builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1468909962.47 results: success (0) buildid: 20160718203032 builduid: 9cafc9a0e8fa4f7e92cb6858dbe95347 revision: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.466136) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.466617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.466892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.482058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.482456) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 23:32:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-18 23:32:42 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.585183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.585538) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:42.634964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 23:32:42.635333) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 23:32:42,740 truncating revision to first 12 chars 2016-07-18 23:32:42,740 Setting DEBUG logging. 2016-07-18 23:32:42,740 attempt 1/10 2016-07-18 23:32:42,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77a5e8e87f91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 23:32:44,063 unpacking tar archive at: fx-team-77a5e8e87f91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.666969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 23:32:44.316145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:44.316526) ========= script_repo_revision: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:44.316937) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:44.317213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:32:44.326786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-18 23:32:44.327137) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:32:44 INFO - MultiFileLogger online at 20160718 23:32:44 in /builds/slave/test 23:32:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:32:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:32:44 INFO - {'append_to_log': False, 23:32:44 INFO - 'base_work_dir': '/builds/slave/test', 23:32:44 INFO - 'blob_upload_branch': 'Fx-Team', 23:32:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:32:44 INFO - 'branch': 'Fx-Team', 23:32:44 INFO - 'buildbot_json_path': 'buildprops.json', 23:32:44 INFO - 'config_files': ('talos/linux_config.py',), 23:32:44 INFO - 'default_actions': ('clobber', 23:32:44 INFO - 'read-buildbot-config', 23:32:44 INFO - 'download-and-extract', 23:32:44 INFO - 'populate-webroot', 23:32:44 INFO - 'create-virtualenv', 23:32:44 INFO - 'install', 23:32:44 INFO - 'run-tests'), 23:32:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:32:44 INFO - 'download_minidump_stackwalk': True, 23:32:44 INFO - 'download_symbols': 'ondemand', 23:32:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:32:44 INFO - 'tooltool.py': '/tools/tooltool.py', 23:32:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:32:44 INFO - '/tools/misc-python/virtualenv.py')}, 23:32:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:32:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:32:44 INFO - 'installer_path': 'installer.exe', 23:32:44 INFO - 'log_level': 'info', 23:32:44 INFO - 'log_name': 'talos', 23:32:44 INFO - 'log_to_console': True, 23:32:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:32:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:32:44 INFO - 'opt_config_files': (), 23:32:44 INFO - 'pip_index': False, 23:32:44 INFO - 'sps_profile': False, 23:32:44 INFO - 'sps_profile_interval': 0, 23:32:44 INFO - 'suite': 'dromaeojs', 23:32:44 INFO - 'system_bits': '32', 23:32:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:32:44 INFO - 'title': 'talos-linux64-ix-021', 23:32:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:32:44 INFO - 'use_talos_json': True, 23:32:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:32:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:32:44 INFO - 'work_dir': 'build'} 23:32:44 INFO - ##### 23:32:44 INFO - ##### Running clobber step. 23:32:44 INFO - ##### 23:32:44 INFO - Running pre-action listener: _resource_record_pre_action 23:32:44 INFO - Running main action method: clobber 23:32:44 INFO - rmtree: /builds/slave/test/build 23:32:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:32:44 INFO - Running post-action listener: _resource_record_post_action 23:32:44 INFO - ##### 23:32:44 INFO - ##### Finished clobber step (success) 23:32:44 INFO - ##### 23:32:44 INFO - ##### 23:32:44 INFO - ##### Running read-buildbot-config step. 23:32:44 INFO - ##### 23:32:44 INFO - Running pre-action listener: _resource_record_pre_action 23:32:44 INFO - Running main action method: read_buildbot_config 23:32:44 INFO - Using buildbot properties: 23:32:44 INFO - { 23:32:44 INFO - "project": "", 23:32:44 INFO - "product": "firefox", 23:32:44 INFO - "script_repo_revision": "production", 23:32:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:32:44 INFO - "repository": "", 23:32:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:32:44 INFO - "buildid": "20160718203032", 23:32:44 INFO - "pgo_build": "True", 23:32:44 INFO - "basedir": "/builds/slave/test", 23:32:44 INFO - "buildnumber": 298, 23:32:44 INFO - "slavename": "talos-linux64-ix-021", 23:32:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:32:44 INFO - "platform": "ubuntu64_hw", 23:32:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:32:44 INFO - "branch": "fx-team", 23:32:44 INFO - "repo_path": "integration/fx-team", 23:32:44 INFO - "revision": "77a5e8e87f91113dcf6cb15fdc83a184cc237e48", 23:32:44 INFO - "stage_platform": "linux64-pgo", 23:32:44 INFO - "builduid": "9cafc9a0e8fa4f7e92cb6858dbe95347", 23:32:44 INFO - "slavebuilddir": "test" 23:32:44 INFO - } 23:32:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:32:44 INFO - Running post-action listener: _resource_record_post_action 23:32:44 INFO - ##### 23:32:45 INFO - ##### Finished read-buildbot-config step (success) 23:32:45 INFO - ##### 23:32:45 INFO - ##### 23:32:45 INFO - ##### Running download-and-extract step. 23:32:45 INFO - ##### 23:32:45 INFO - Running pre-action listener: _resource_record_pre_action 23:32:45 INFO - Running main action method: download_and_extract 23:32:45 INFO - mkdir: /builds/slave/test/build/tests 23:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:45 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:32:45 INFO - Downloaded 1361 bytes. 23:32:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:32:45 INFO - Using the following test package requirements: 23:32:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:32:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:32:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:32:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'jsshell-linux-x86_64.zip'], 23:32:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:32:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:32:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:32:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:32:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:32:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:32:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:32:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:45 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:32:46 INFO - Downloaded 24333765 bytes. 23:32:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:32:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:32:47 INFO - Return code: 0 23:32:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:47 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:32:48 INFO - Downloaded 24333765 bytes. 23:32:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:32:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:32:51 INFO - Return code: 0 23:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:51 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:32:52 INFO - Downloaded 14403317 bytes. 23:32:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:32:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:32:52 INFO - Return code: 0 23:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:52 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:32:53 INFO - Downloaded 60845064 bytes. 23:32:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:32:53 INFO - mkdir: /builds/slave/test/properties 23:32:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:32:53 INFO - Writing to file /builds/slave/test/properties/build_url 23:32:53 INFO - Contents: 23:32:53 INFO - build_url:https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:32:54 INFO - Running post-action listener: _resource_record_post_action 23:32:54 INFO - Running post-action listener: set_extra_try_arguments 23:32:54 INFO - ##### 23:32:54 INFO - ##### Finished download-and-extract step (success) 23:32:54 INFO - ##### 23:32:54 INFO - ##### 23:32:54 INFO - ##### Running populate-webroot step. 23:32:54 INFO - ##### 23:32:54 INFO - Running pre-action listener: _resource_record_pre_action 23:32:54 INFO - Running main action method: populate_webroot 23:32:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:32:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:32:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:32:54 INFO - '--tppagecycles', 23:32:54 INFO - '7'], 23:32:54 INFO - 'tests': ['tsvgm']}}, 23:32:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:32:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:32:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:32:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:32:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['damp', 'tps']}, 23:32:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'tests': ['damp', 'tps']}, 23:32:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['dromaeo_dom']}, 23:32:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:32:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['basic_compositor_video']}, 23:32:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:32:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['a11yr', 23:32:54 INFO - 'ts_paint', 23:32:54 INFO - 'tpaint', 23:32:54 INFO - 'sessionrestore', 23:32:54 INFO - 'sessionrestore_no_auto_restore', 23:32:54 INFO - 'tabpaint']}, 23:32:54 INFO - 'other-e10s': {'tests': ['a11yr', 23:32:54 INFO - 'ts_paint', 23:32:54 INFO - 'tpaint', 23:32:54 INFO - 'sessionrestore', 23:32:54 INFO - 'sessionrestore_no_auto_restore', 23:32:54 INFO - 'tabpaint']}, 23:32:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:32:54 INFO - 'ts_paint', 23:32:54 INFO - 'tpaint', 23:32:54 INFO - 'sessionrestore', 23:32:54 INFO - 'sessionrestore_no_auto_restore', 23:32:54 INFO - 'tabpaint']}, 23:32:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:32:54 INFO - 'ts_paint', 23:32:54 INFO - 'tpaint', 23:32:54 INFO - 'sessionrestore', 23:32:54 INFO - 'sessionrestore_no_auto_restore', 23:32:54 INFO - 'tabpaint']}, 23:32:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['a11yr', 23:32:54 INFO - 'ts_paint', 23:32:54 INFO - 'tpaint', 23:32:54 INFO - 'sessionrestore', 23:32:54 INFO - 'sessionrestore_no_auto_restore', 23:32:54 INFO - 'tabpaint']}, 23:32:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['a11yr', 23:32:54 INFO - 'ts_paint', 23:32:54 INFO - 'tpaint', 23:32:54 INFO - 'sessionrestore', 23:32:54 INFO - 'sessionrestore_no_auto_restore', 23:32:54 INFO - 'tabpaint']}, 23:32:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['tsvgx', 23:32:54 INFO - 'tsvgr_opacity', 23:32:54 INFO - 'tart', 23:32:54 INFO - 'tscrollx', 23:32:54 INFO - 'cart']}, 23:32:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:32:54 INFO - 'tsvgr_opacity', 23:32:54 INFO - 'tart', 23:32:54 INFO - 'tscrollx', 23:32:54 INFO - 'cart']}, 23:32:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'talos_options': ['--disable-e10s'], 23:32:54 INFO - 'tests': ['tp5o']}, 23:32:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'tests': ['tp5o']}, 23:32:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'talos_options': ['--disable-e10s', 23:32:54 INFO - '--xperf_path', 23:32:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:54 INFO - 'tests': ['tp5n']}, 23:32:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:54 INFO - 'talos_options': ['--xperf_path', 23:32:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:54 INFO - 'tests': ['tp5n']}}, 23:32:54 INFO - 'talos.zip': {'path': '', 23:32:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:32:54 INFO - Running post-action listener: _resource_record_post_action 23:32:54 INFO - ##### 23:32:54 INFO - ##### Finished populate-webroot step (success) 23:32:54 INFO - ##### 23:32:54 INFO - ##### 23:32:54 INFO - ##### Running create-virtualenv step. 23:32:54 INFO - ##### 23:32:54 INFO - Running pre-action listener: _resource_record_pre_action 23:32:54 INFO - Running main action method: create_virtualenv 23:32:54 INFO - Creating virtualenv /builds/slave/test/build/venv 23:32:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:32:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:32:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:32:54 INFO - Using real prefix '/usr' 23:32:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:32:55 INFO - Installing distribute.............................................................................................................................................................................................done. 23:32:57 INFO - Installing pip.................done. 23:32:57 INFO - Return code: 0 23:32:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:32:57 INFO - Using env: {'DISPLAY': ':0', 23:32:57 INFO - 'HOME': '/home/cltbld', 23:32:57 INFO - 'LANG': 'en_US.UTF-8', 23:32:57 INFO - 'LANGUAGE': 'en_US:en', 23:32:57 INFO - 'LOGNAME': 'cltbld', 23:32:57 INFO - 'MAIL': '/var/mail/cltbld', 23:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:57 INFO - 'MOZ_NO_REMOTE': '1', 23:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:57 INFO - 'NO_EM_RESTART': '1', 23:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:57 INFO - 'PWD': '/builds/slave/test', 23:32:57 INFO - 'SHELL': '/bin/bash', 23:32:57 INFO - 'SHLVL': '1', 23:32:57 INFO - 'TERM': 'linux', 23:32:57 INFO - 'TMOUT': '86400', 23:32:57 INFO - 'USER': 'cltbld', 23:32:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:57 INFO - '_': '/tools/buildbot/bin/python'} 23:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:32:57 INFO - Cleaning up... 23:32:57 INFO - Return code: 0 23:32:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:32:57 INFO - Using env: {'DISPLAY': ':0', 23:32:57 INFO - 'HOME': '/home/cltbld', 23:32:57 INFO - 'LANG': 'en_US.UTF-8', 23:32:57 INFO - 'LANGUAGE': 'en_US:en', 23:32:57 INFO - 'LOGNAME': 'cltbld', 23:32:57 INFO - 'MAIL': '/var/mail/cltbld', 23:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:57 INFO - 'MOZ_NO_REMOTE': '1', 23:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:57 INFO - 'NO_EM_RESTART': '1', 23:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:57 INFO - 'PWD': '/builds/slave/test', 23:32:57 INFO - 'SHELL': '/bin/bash', 23:32:57 INFO - 'SHLVL': '1', 23:32:57 INFO - 'TERM': 'linux', 23:32:57 INFO - 'TMOUT': '86400', 23:32:57 INFO - 'USER': 'cltbld', 23:32:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:57 INFO - '_': '/tools/buildbot/bin/python'} 23:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:57 INFO - Downloading/unpacking psutil>=3.1.1 23:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:32:59 INFO - Installing collected packages: psutil 23:32:59 INFO - Running setup.py install for psutil 23:32:59 INFO - building 'psutil._psutil_linux' extension 23:32:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:32:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:32:59 INFO - building 'psutil._psutil_posix' extension 23:32:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:32:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:33:00 INFO - Successfully installed psutil 23:33:00 INFO - Cleaning up... 23:33:00 INFO - Return code: 0 23:33:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:33:00 INFO - Using env: {'DISPLAY': ':0', 23:33:00 INFO - 'HOME': '/home/cltbld', 23:33:00 INFO - 'LANG': 'en_US.UTF-8', 23:33:00 INFO - 'LANGUAGE': 'en_US:en', 23:33:00 INFO - 'LOGNAME': 'cltbld', 23:33:00 INFO - 'MAIL': '/var/mail/cltbld', 23:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:00 INFO - 'MOZ_NO_REMOTE': '1', 23:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:00 INFO - 'NO_EM_RESTART': '1', 23:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:00 INFO - 'PWD': '/builds/slave/test', 23:33:00 INFO - 'SHELL': '/bin/bash', 23:33:00 INFO - 'SHLVL': '1', 23:33:00 INFO - 'TERM': 'linux', 23:33:00 INFO - 'TMOUT': '86400', 23:33:00 INFO - 'USER': 'cltbld', 23:33:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:00 INFO - '_': '/tools/buildbot/bin/python'} 23:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:33:02 INFO - Installing collected packages: mozsystemmonitor 23:33:02 INFO - Running setup.py install for mozsystemmonitor 23:33:02 INFO - Successfully installed mozsystemmonitor 23:33:02 INFO - Cleaning up... 23:33:02 INFO - Return code: 0 23:33:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:33:02 INFO - Using env: {'DISPLAY': ':0', 23:33:02 INFO - 'HOME': '/home/cltbld', 23:33:02 INFO - 'LANG': 'en_US.UTF-8', 23:33:02 INFO - 'LANGUAGE': 'en_US:en', 23:33:02 INFO - 'LOGNAME': 'cltbld', 23:33:02 INFO - 'MAIL': '/var/mail/cltbld', 23:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:02 INFO - 'MOZ_NO_REMOTE': '1', 23:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:02 INFO - 'NO_EM_RESTART': '1', 23:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:02 INFO - 'PWD': '/builds/slave/test', 23:33:02 INFO - 'SHELL': '/bin/bash', 23:33:02 INFO - 'SHLVL': '1', 23:33:02 INFO - 'TERM': 'linux', 23:33:02 INFO - 'TMOUT': '86400', 23:33:02 INFO - 'USER': 'cltbld', 23:33:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:02 INFO - '_': '/tools/buildbot/bin/python'} 23:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:02 INFO - Downloading/unpacking jsonschema==2.5.1 23:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:33:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 23:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:33:04 INFO - warning: no files found matching '*.txt' 23:33:04 INFO - no previously-included directories found matching 'build' 23:33:04 INFO - no previously-included directories found matching 'dist' 23:33:04 INFO - no previously-included directories found matching '.git*' 23:33:04 INFO - Installing collected packages: jsonschema, functools32 23:33:04 INFO - Running setup.py install for functools32 23:33:04 INFO - warning: no files found matching '*.txt' 23:33:04 INFO - no previously-included directories found matching 'build' 23:33:04 INFO - no previously-included directories found matching 'dist' 23:33:04 INFO - no previously-included directories found matching '.git*' 23:33:04 INFO - Successfully installed jsonschema functools32 23:33:04 INFO - Cleaning up... 23:33:04 INFO - Return code: 0 23:33:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:33:04 INFO - Using env: {'DISPLAY': ':0', 23:33:04 INFO - 'HOME': '/home/cltbld', 23:33:04 INFO - 'LANG': 'en_US.UTF-8', 23:33:04 INFO - 'LANGUAGE': 'en_US:en', 23:33:04 INFO - 'LOGNAME': 'cltbld', 23:33:04 INFO - 'MAIL': '/var/mail/cltbld', 23:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:04 INFO - 'MOZ_NO_REMOTE': '1', 23:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:04 INFO - 'NO_EM_RESTART': '1', 23:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:04 INFO - 'PWD': '/builds/slave/test', 23:33:04 INFO - 'SHELL': '/bin/bash', 23:33:04 INFO - 'SHLVL': '1', 23:33:04 INFO - 'TERM': 'linux', 23:33:04 INFO - 'TMOUT': '86400', 23:33:04 INFO - 'USER': 'cltbld', 23:33:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:04 INFO - '_': '/tools/buildbot/bin/python'} 23:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 23:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:07 INFO - Downloading blobuploader-1.2.4.tar.gz 23:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:33:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:07 INFO - Downloading docopt-0.6.1.tar.gz 23:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:33:07 INFO - Installing collected packages: blobuploader, requests, docopt 23:33:07 INFO - Running setup.py install for blobuploader 23:33:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:33:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:33:08 INFO - Running setup.py install for requests 23:33:08 INFO - Running setup.py install for docopt 23:33:08 INFO - Successfully installed blobuploader requests docopt 23:33:08 INFO - Cleaning up... 23:33:08 INFO - Return code: 0 23:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:33:08 INFO - Using env: {'DISPLAY': ':0', 23:33:08 INFO - 'HOME': '/home/cltbld', 23:33:08 INFO - 'LANG': 'en_US.UTF-8', 23:33:08 INFO - 'LANGUAGE': 'en_US:en', 23:33:08 INFO - 'LOGNAME': 'cltbld', 23:33:08 INFO - 'MAIL': '/var/mail/cltbld', 23:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:08 INFO - 'MOZ_NO_REMOTE': '1', 23:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:08 INFO - 'NO_EM_RESTART': '1', 23:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:08 INFO - 'PWD': '/builds/slave/test', 23:33:08 INFO - 'SHELL': '/bin/bash', 23:33:08 INFO - 'SHLVL': '1', 23:33:08 INFO - 'TERM': 'linux', 23:33:08 INFO - 'TMOUT': '86400', 23:33:08 INFO - 'USER': 'cltbld', 23:33:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:08 INFO - '_': '/tools/buildbot/bin/python'} 23:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:33:08 INFO - Running setup.py (path:/tmp/pip-v0EvMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:33:08 INFO - Running setup.py (path:/tmp/pip-3V8zB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:33:08 INFO - Running setup.py (path:/tmp/pip-xITCrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:33:08 INFO - Running setup.py (path:/tmp/pip-T55aAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:33:09 INFO - Running setup.py (path:/tmp/pip-kKEYek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:33:09 INFO - Running setup.py (path:/tmp/pip-x1mGdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:33:09 INFO - Running setup.py (path:/tmp/pip-owQOd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:33:09 INFO - Running setup.py (path:/tmp/pip-Xac08w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:33:09 INFO - Running setup.py (path:/tmp/pip-nCkapi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:33:09 INFO - Running setup.py (path:/tmp/pip-3YMkPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:33:09 INFO - Running setup.py (path:/tmp/pip-b0lLLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:33:09 INFO - Running setup.py (path:/tmp/pip-Gqhwy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:33:09 INFO - Running setup.py (path:/tmp/pip-WYdH6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:33:09 INFO - Running setup.py (path:/tmp/pip-l7woZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:09 INFO - Running setup.py (path:/tmp/pip-IAJWTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:33:09 INFO - Running setup.py (path:/tmp/pip-42csDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:33:09 INFO - Running setup.py (path:/tmp/pip-AMXjX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:33:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:33:09 INFO - Running setup.py install for manifestparser 23:33:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozcrash 23:33:10 INFO - Running setup.py install for mozdebug 23:33:10 INFO - Running setup.py install for mozdevice 23:33:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozfile 23:33:10 INFO - Running setup.py install for mozhttpd 23:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozinfo 23:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozInstall 23:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozleak 23:33:10 INFO - Running setup.py install for mozlog 23:33:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for moznetwork 23:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Running setup.py install for mozprocess 23:33:11 INFO - Running setup.py install for mozprofile 23:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Running setup.py install for mozrunner 23:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Running setup.py install for mozscreenshot 23:33:11 INFO - Running setup.py install for moztest 23:33:11 INFO - Running setup.py install for mozversion 23:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:33:11 INFO - Cleaning up... 23:33:11 INFO - Return code: 0 23:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:33:11 INFO - Using env: {'DISPLAY': ':0', 23:33:11 INFO - 'HOME': '/home/cltbld', 23:33:11 INFO - 'LANG': 'en_US.UTF-8', 23:33:11 INFO - 'LANGUAGE': 'en_US:en', 23:33:11 INFO - 'LOGNAME': 'cltbld', 23:33:11 INFO - 'MAIL': '/var/mail/cltbld', 23:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:11 INFO - 'MOZ_NO_REMOTE': '1', 23:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:11 INFO - 'NO_EM_RESTART': '1', 23:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:11 INFO - 'PWD': '/builds/slave/test', 23:33:11 INFO - 'SHELL': '/bin/bash', 23:33:11 INFO - 'SHLVL': '1', 23:33:11 INFO - 'TERM': 'linux', 23:33:11 INFO - 'TMOUT': '86400', 23:33:11 INFO - 'USER': 'cltbld', 23:33:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:11 INFO - '_': '/tools/buildbot/bin/python'} 23:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:33:11 INFO - Running setup.py (path:/tmp/pip-17Uboy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:33:12 INFO - Running setup.py (path:/tmp/pip-W_xV3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:33:12 INFO - Running setup.py (path:/tmp/pip-yqRaro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:33:12 INFO - Running setup.py (path:/tmp/pip-PNknz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:33:12 INFO - Running setup.py (path:/tmp/pip-2AL405-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:33:12 INFO - Running setup.py (path:/tmp/pip-0xx1QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:33:12 INFO - Running setup.py (path:/tmp/pip-qyDP7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:33:12 INFO - Running setup.py (path:/tmp/pip-xlsIPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:33:12 INFO - Running setup.py (path:/tmp/pip-ElVeuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:33:12 INFO - Running setup.py (path:/tmp/pip-XrhwuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:33:12 INFO - Running setup.py (path:/tmp/pip-btaVgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:33:12 INFO - Running setup.py (path:/tmp/pip-GR8flo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:33:12 INFO - Running setup.py (path:/tmp/pip-4UHuTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:33:12 INFO - Running setup.py (path:/tmp/pip-FdbjH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:12 INFO - Running setup.py (path:/tmp/pip-qnStRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:33:13 INFO - Running setup.py (path:/tmp/pip-aKYaSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:33:13 INFO - Running setup.py (path:/tmp/pip-F7aUzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:33:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:15 INFO - Downloading blessings-1.6.tar.gz 23:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:33:15 INFO - Installing collected packages: blessings 23:33:15 INFO - Running setup.py install for blessings 23:33:15 INFO - Successfully installed blessings 23:33:15 INFO - Cleaning up... 23:33:15 INFO - Return code: 0 23:33:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:33:15 INFO - Reading from file tmpfile_stdout 23:33:15 INFO - Current package versions: 23:33:15 INFO - argparse == 1.2.1 23:33:15 INFO - blessings == 1.6 23:33:15 INFO - blobuploader == 1.2.4 23:33:15 INFO - docopt == 0.6.1 23:33:15 INFO - functools32 == 3.2.3-2 23:33:15 INFO - jsonschema == 2.5.1 23:33:15 INFO - manifestparser == 1.1 23:33:15 INFO - mozInstall == 1.12 23:33:15 INFO - mozcrash == 0.17 23:33:15 INFO - mozdebug == 0.1 23:33:15 INFO - mozdevice == 0.48 23:33:15 INFO - mozfile == 1.2 23:33:15 INFO - mozhttpd == 0.7 23:33:15 INFO - mozinfo == 0.9 23:33:15 INFO - mozleak == 0.1 23:33:15 INFO - mozlog == 3.2 23:33:15 INFO - moznetwork == 0.27 23:33:15 INFO - mozprocess == 0.23 23:33:15 INFO - mozprofile == 0.28 23:33:15 INFO - mozrunner == 6.12 23:33:15 INFO - mozscreenshot == 0.1 23:33:15 INFO - mozsystemmonitor == 0.3 23:33:15 INFO - moztest == 0.7 23:33:15 INFO - mozversion == 1.4 23:33:15 INFO - psutil == 3.1.1 23:33:15 INFO - requests == 1.2.3 23:33:15 INFO - wsgiref == 0.1.2 23:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:33:15 INFO - Using env: {'DISPLAY': ':0', 23:33:15 INFO - 'HOME': '/home/cltbld', 23:33:15 INFO - 'LANG': 'en_US.UTF-8', 23:33:15 INFO - 'LANGUAGE': 'en_US:en', 23:33:15 INFO - 'LOGNAME': 'cltbld', 23:33:15 INFO - 'MAIL': '/var/mail/cltbld', 23:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:15 INFO - 'MOZ_NO_REMOTE': '1', 23:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:15 INFO - 'NO_EM_RESTART': '1', 23:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:15 INFO - 'PWD': '/builds/slave/test', 23:33:15 INFO - 'SHELL': '/bin/bash', 23:33:15 INFO - 'SHLVL': '1', 23:33:15 INFO - 'TERM': 'linux', 23:33:15 INFO - 'TMOUT': '86400', 23:33:15 INFO - 'USER': 'cltbld', 23:33:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:15 INFO - '_': '/tools/buildbot/bin/python'} 23:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:33:15 INFO - Cleaning up... 23:33:15 INFO - Return code: 0 23:33:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:33:15 INFO - Using env: {'DISPLAY': ':0', 23:33:15 INFO - 'HOME': '/home/cltbld', 23:33:15 INFO - 'LANG': 'en_US.UTF-8', 23:33:15 INFO - 'LANGUAGE': 'en_US:en', 23:33:15 INFO - 'LOGNAME': 'cltbld', 23:33:15 INFO - 'MAIL': '/var/mail/cltbld', 23:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:15 INFO - 'MOZ_NO_REMOTE': '1', 23:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:15 INFO - 'NO_EM_RESTART': '1', 23:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:15 INFO - 'PWD': '/builds/slave/test', 23:33:15 INFO - 'SHELL': '/bin/bash', 23:33:15 INFO - 'SHLVL': '1', 23:33:15 INFO - 'TERM': 'linux', 23:33:15 INFO - 'TMOUT': '86400', 23:33:15 INFO - 'USER': 'cltbld', 23:33:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:15 INFO - '_': '/tools/buildbot/bin/python'} 23:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:33:15 INFO - Cleaning up... 23:33:16 INFO - Return code: 0 23:33:16 INFO - Running post-action listener: _resource_record_post_action 23:33:16 INFO - Running post-action listener: _start_resource_monitoring 23:33:16 INFO - Starting resource monitoring. 23:33:16 INFO - ##### 23:33:16 INFO - ##### Finished create-virtualenv step (success) 23:33:16 INFO - ##### 23:33:16 INFO - ##### 23:33:16 INFO - ##### Running install step. 23:33:16 INFO - ##### 23:33:16 INFO - Running pre-action listener: _resource_record_pre_action 23:33:16 INFO - Running main action method: install 23:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:33:16 INFO - Reading from file tmpfile_stdout 23:33:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:33:16 INFO - Reading from file tmpfile_stdout 23:33:16 INFO - Output received: 23:33:16 INFO - Usage: mozinstall [options] installer 23:33:16 INFO - Options: 23:33:16 INFO - -h, --help show this help message and exit 23:33:16 INFO - -d DEST, --destination=DEST 23:33:16 INFO - Directory to install application into. [default: 23:33:16 INFO - "/builds/slave/test"] 23:33:16 INFO - --app=APP Application being installed. [default: firefox] 23:33:16 INFO - mkdir: /builds/slave/test/build/application 23:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:33:33 INFO - Reading from file tmpfile_stdout 23:33:33 INFO - Output received: 23:33:33 INFO - /builds/slave/test/build/application/firefox/firefox 23:33:33 INFO - Running post-action listener: _resource_record_post_action 23:33:33 INFO - ##### 23:33:33 INFO - ##### Finished install step (success) 23:33:33 INFO - ##### 23:33:33 INFO - ##### 23:33:33 INFO - ##### Running run-tests step. 23:33:33 INFO - ##### 23:33:33 INFO - Running pre-action listener: _resource_record_pre_action 23:33:33 INFO - Running main action method: run_tests 23:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:33:33 INFO - Python 2.7.3 23:33:33 INFO - Return code: 0 23:33:33 INFO - grabbing minidump binary from tooltool 23:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:33:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d123b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:33:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:33:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:33:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:33:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:33:33 INFO - Return code: 0 23:33:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:33:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:33:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:33:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:33:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:33:33 INFO - Using env: {'DISPLAY': ':0', 23:33:33 INFO - 'HOME': '/home/cltbld', 23:33:33 INFO - 'LANG': 'en_US.UTF-8', 23:33:33 INFO - 'LANGUAGE': 'en_US:en', 23:33:33 INFO - 'LOGNAME': 'cltbld', 23:33:33 INFO - 'MAIL': '/var/mail/cltbld', 23:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:33 INFO - 'MOZ_NO_REMOTE': '1', 23:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:33 INFO - 'NO_EM_RESTART': '1', 23:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:33 INFO - 'PWD': '/builds/slave/test', 23:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:33:33 INFO - 'SHELL': '/bin/bash', 23:33:33 INFO - 'SHLVL': '1', 23:33:33 INFO - 'TERM': 'linux', 23:33:33 INFO - 'TMOUT': '86400', 23:33:33 INFO - 'USER': 'cltbld', 23:33:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111', 23:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:33 INFO - '_': '/tools/buildbot/bin/python'} 23:33:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:33:33 INFO - mozversion application_buildid: 20160718203032 23:33:33 INFO - mozversion application_changeset: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 23:33:33 INFO - mozversion application_display_name: Nightly 23:33:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:33:33 INFO - mozversion application_name: Firefox 23:33:33 INFO - mozversion application_remotingname: firefox 23:33:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:33:33 INFO - mozversion application_vendor: Mozilla 23:33:33 INFO - mozversion application_version: 50.0a1 23:33:33 INFO - mozversion platform_buildid: 20160718203032 23:33:33 INFO - mozversion platform_changeset: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 23:33:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:33:33 INFO - mozversion platform_version: 50.0a1 23:33:33 INFO - using testdate: 1468910013 23:33:33 INFO - actual date: 1468910013 23:33:33 INFO - starting webserver on 'localhost:49889' 23:33:33 INFO - SUITE-START | Running 2 tests 23:33:33 INFO - TEST-START | dromaeo_css 23:33:33 INFO - operating with platform_type : linux_ 23:33:33 INFO - Initialising browser for dromaeo_css test... 23:33:33 INFO - TEST-INFO | started process 993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODIBXi/profile http://localhost:49889/getInfo.html) 23:33:38 INFO - PROCESS | 993 | __metrics Screen width/height:1600/1200 23:33:38 INFO - PROCESS | 993 | colorDepth:24 23:33:38 INFO - PROCESS | 993 | Browser inner width/height: 1024/697 23:33:38 INFO - PROCESS | 993 | __metrics 23:33:39 INFO - PROCESS | 993 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:33:39 INFO - PROCESS | 993 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:33:39 INFO - PROCESS | 993 | console.error: PushService: 23:33:39 INFO - PROCESS | 993 | stateChangeProcessEnqueue: Error transitioning state 23:33:39 INFO - PROCESS | 993 | UnknownError 23:33:40 INFO - TEST-INFO | 993: exit 0 23:33:40 INFO - Browser initialized. 23:33:40 INFO - Running cycle 1/1 for dromaeo_css test... 23:33:40 INFO - TEST-INFO | started process 1083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODIBXi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:33:52 INFO - PROCESS | 1083 | RSS: Main: 158105600 23:33:52 INFO - PROCESS | 1083 | 23:34:43 INFO - PROCESS | 1083 | 1468910083836 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:36:51 INFO - PROCESS | 1083 | Cycle 1(1): loaded http://localhost:49889/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49889/tests/dromaeo/cssquery-ext.html) 23:36:52 INFO - PROCESS | 1083 | RSS: Main: 254656512 23:36:52 INFO - PROCESS | 1083 | 23:39:55 INFO - PROCESS | 1083 | Cycle 1(1): loaded http://localhost:49889/tests/dromaeo/cssquery-ext.html (next: http://localhost:49889/tests/dromaeo/cssquery-jquery.html) 23:39:55 INFO - PROCESS | 1083 | RSS: Main: 241709056 23:39:55 INFO - PROCESS | 1083 | 23:42:57 INFO - PROCESS | 1083 | Cycle 1(1): loaded http://localhost:49889/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49889/tests/dromaeo/cssquery-mootools.html) 23:42:58 INFO - PROCESS | 1083 | RSS: Main: 252178432 23:42:58 INFO - PROCESS | 1083 | 23:46:00 INFO - PROCESS | 1083 | Cycle 1(1): loaded http://localhost:49889/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49889/tests/dromaeo/cssquery-prototype.html) 23:46:00 INFO - PROCESS | 1083 | RSS: Main: 238989312 23:46:00 INFO - PROCESS | 1083 | 23:49:03 INFO - PROCESS | 1083 | Cycle 1(1): loaded http://localhost:49889/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49889/tests/dromaeo/cssquery-yui.html) 23:49:04 INFO - PROCESS | 1083 | RSS: Main: 224874496 23:49:04 INFO - PROCESS | 1083 | 23:52:06 INFO - PROCESS | 1083 | Cycle 1(1): loaded http://localhost:49889/tests/dromaeo/cssquery-yui.html (next: http://localhost:49889/tests/dromaeo/cssquery-dojo.html) 23:52:07 INFO - PROCESS | 1083 | RSS: Main: 291708928 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | __start_tp_report 23:52:07 INFO - PROCESS | 1083 | _x_x_mozilla_page_load 23:52:07 INFO - PROCESS | 1083 | _x_x_mozilla_page_load_details 23:52:07 INFO - PROCESS | 1083 | |i|pagename|runs| 23:52:07 INFO - PROCESS | 1083 | |0;dojo.html;3028;3042.1329920972526;3052.175912503624;3082.4759790835556;3098.2409309719123;5175.896482070356;5240.475952404767;5255.159174532076;5306.389765177006;5355.758990845412;5254.789808407669;5270.5520030797425;5293.6294459387855;5295;5362.490563396481;4736.313234580975;4788.353572267734;4838.080764654722;4844.32179494871;4929;4875.609951203895;4878.146324393235;4902.436219834711;4928.679635823678;4950.900981980359;4730.550597693214;4744;4757.881052973668;4762.1428142934255;4768.403949506329;4717.740524271164;4732.02993386355;4802.639802014863;4811.08589368019;4851.708897466164;4763.54746299101;4773.0965501135415;4779.569838714532;4783.162946484351;4835.443923948756;5170.612204084671;5178.275041494194;5259.631825772198;5328.547073498718;5333.493318134771;5649.576281778842;5676.347220069703;5685.744141513642;5694.743736531866;5705.857353566153;5510.834674959758;5683.829485115411;5720;5729.427057294279;5734.885302293973;5149.588032957355;5217.34783152106;5224.085784987612;5251.711155886463;5299.072662284085;5803.5357171426185;5812.505936995402;5849.707514624251;5858.8242352729485;5865.501432378211;5377.300950876361;5403.7838486460105;5609.354924183689;5612.466815652507;5620.775168993195;5462.562994960394;5548.55611551075;5553.944460555343;5606.6916319602815;5615.101583746581;5529.170624406372;5529.281193444907;5537.473939975695;5544.77820887168;5569.443055694479;5436.565074794007;5553;5556.166575013699;5560.555155587544;5621.943780562224;4200.915981680349;4220.40914271996;4225.535191128974;4252.723572967747;4264.594863487963;3789.7157713171623;3801.6388443097862;3808.0670235791854;3810.447485114643;3838.539375274929;5203.2195170723935;5246.160614301693;5285.894282114413;5327.360716714019;5377.489138531833;5670.291213598301;5689.743961521742;5690.345610254791;5695.772169113189;5732.713364331767;5340.145576707708;5358.089124848785;5368.194770784414;5373.919391209135;5375.7849686012905;4776.140294746979;4777;4810.158222311082;4869.050535145612;4899.657024008286;5801.8549536261935;5803.5357171426185;5806.274215723035;5813.447722466359;5822.970885145547;5648.322201335866;5658.603897727285;5661.094224923992;5663.062748133503;5707.1724599933605;5677.432256774289;5747.453991870766;5776.393478684678;5781.710914454176;5812.9827280224945;5487.259220005249;5487.588430867621;5489.890202196014;5497.175423686479;5500.724963751716;5440.211169380497;5540.864122854725;5600.551955843604;5601.103823388238;5606.439356064361;5483.232347471437;5533.446655334435;5544.584156188383;5562.193481945176;5563.360213575491;5526.944730552643;5531.806386776443;5533.474319939599;5535.7785688572;5542.63972841764;5420.349558053059;5442.210879422382;5524.8342549723575;5533.833984980457;5542.584306176972;5521.061419558604;5580.441955804387;5592.496675299242;5630.4369563043365;5636.661800291996;5424.267723857387;5425.267588875609;5426.267453893832;5428.647137936022;5431.34823821144 23:52:07 INFO - PROCESS | 1083 | |1;ext.html;580.8809194115207;606.4360145065087;619.2630769384431;626.5144513002424;628.0767272109999;33784.83107584462;36889.44665830011;37044.44433333502;43915;45414;46165.30752038722;46659.766701166445;46760.53239467604;46763;46817.29774053392;9085.682001129962;9234.769130771718;9240.768980775501;9243.07569243077;9249.815003699921;9072.410293330913;9145.634174633007;9154.176124148826;9159.771005724877;9161.496117713523;9221.031791661879;9230;9265.583048762823;9266.44401335922;9279.768005799842;9207.723768286929;9234;9254.167124958785;9259.166674999215;9260.120288572574;9046.185843274072;9115.179633832988;9117.772055698595;9121.087891210893;9121.635134594608;43892.78053609744;44208.3368749469;44355;44400.555994440285;44421.33367999482;3533;3583.4803953426867;3688.907777305562;3725.9441108383394;4180.937285940713;31535.211619709462;33895.6610433895;34233.4864977023;34705.65294347049;34866;4486.461624605068;4586.862394128181;4591.471980722193;4600.378948841897;4663.953360466419;372374;374700;377629.45408548356;377705;379631;35928.281434371165;36963.63036369602;64289;65369;65394.67302663456;38905.6109438902;38921.80539097286;39040.414393784115;39059;39141.41287880684;16028.358865645243;16173.4339298124;16173.514794555947;16186.352545898268;16187.352505899868;13306.334683265797;13378.598642040753;13378.866211337761;13382;13390.397432115578;8584.699535516227;8672.436291641023;8706.869396959051;8714.869276960851;8779.385443018928;3311.850966706504;3352.832358382071;3373.3421982713626;3399.4390925497014;3411.522386865841;1031.5197592460565;1036.7770929250248;1041.6927006533092;1061.2783307350921;1100.5212732461405;32546.674533254838;32564.185895352806;32773.50839737406;32962.20699567328;33358;1124.9325040497597;1139.4530625299737;1174.6006357838376;1186.827909953052;1190.190670344157;17173.828261717223;17214.483565493054;17400.39098631542;17577.384791532237;17746.29014839392;596952;597312;602470;604346;605906;61135.388646112966;61824.38175618276;61878;61893.69053154706;61908.38091619116;1225.9019278457881;1307.3332600373878;1329.8936085113362;1353.5668586052566;1361.9727605447836;30494;34279.657203428644;34474;34550.48174277337;34566.65433345635;51243.74378128086;51496;51855;52007.73996129995;52056.21915671192;406700;407328;408734;409706;410633;26056.73943260543;28934.42131157323;29348.11955641334;29658.703412965595;29921.850390747906;49907.500924991735;50287.49712502828;50529.49470505248;50971;51017.74491127521;41676;43204.35193472038;43550.34674479822;44074.559254407046;44756.76216189112;42589.787051064544;42831.571684284005;42976;43064.13871722485;43595.78202109096;41049.79475102606;41894.1621167581;42084.36873446962;42087.158256835304;42362;37237.81381093077;38280.42579361256;38402.61597384102;39041.609583903795;39163.608363916;28256.434871302048;28290.292742680773;28486.57270140991;28526.144215673565;28631.284217894718 23:52:07 INFO - PROCESS | 1083 | |2;jquery.html;394.80457173699017;398.18571022259476;400.9759414435134;402.5833262573237;417.7911044477761;19570.902145489254;19846.60306793863;20368.592628147428;20548.178072877086;20601.99999999998;19254.43828328151;19534.51163720904;20102.195912163497;20166.39500814978;20187.39437816868;5296.496832800878;5731.598788084815;6011.098335249704;6021;6110.358412366704;6071.514278857703;6077.665728384937;6081.118237855509;6087.330393656716;6089.482393996494;6472.223333200022;6506.186726659168;6514.7719829805965;6516.4786817054755;6518.902216466757;6328.873422531569;6494.220693516784;6499;6603.306652801435;6623.569467984566;5864.354920958691;5864.677442740647;5866.20806191163;5870.501007414375;5883.411658834125;18074.90962545192;23510.529789404118;23669;23672.64491032636;24301.27096187117;2317.2237300504353;2391.4619210677633;2478.1450399612286;2962.844490648649;2993.5659329397117;10193.949030254875;10319.58721651133;12979.610611681665;14606;14779.704405911929;1983.4942089767162;1995.3814317561603;2007.2272175212502;2077.3352527191305;2153.676948457728;81852.59073704593;85188.99999999937;85360;87019;88029.11970880273;10609.939006099328;10788;10854.891451085388;10883.619073332395;10997;14875.628109297355;14939.25303734809;14982.925085374503;14992.100473971597;14992.550223493312;7862.567558784322;8154.184581541917;8226.712065077694;8266.941231744293;8326.583670816435;7883.448158628956;7898.210178982055;7911.960440197762;8018.759437216893;8036.4374493786045;4595.080983803253;4765;4821.734804585712;4864.805407783649;4917.508249175054;1992.7907569705262;2013.5570174561574;2017.3544465770813;2029.9797002030086;2062.1442101527996;879.3404946290283;954.575214029764;994.1847684898314;1023.1712313026472;1023.2223510132204;19623.50941226452;19968.400947971582;20359.455068116484;20455.85746989157;20525.076371563315;988.1600639456548;1016.202281209262;1035.782485678016;1099.6536091131268;1100.49927283086;10730.141588672888;11348.205625606293;11412.258203216765;11446.542138314375;11479.827802582968;497121;503290;505724;516973;518148;81870.31583578754;94492;96431;97765;98790;1003.7390278527636;1006.2201793609864;1025.610268098118;1055.7782865598156;1060.734816295926;17402.564935876704;17668.64662706713;18071.819281807013;18120.546986325448;18408.81591184071;45290.773546132055;45947.540524595664;46161.307580386994;46396.07207855756;46440.53559464497;61565;61708.69145654243;61778.073328901;64134.35865641284;64154;8414.915850841413;8565.48607083577;8613.353998450266;8691.826163476822;8846;12318.568850090203;12764.489420423079;13209.471621135048;13967.511137110152;14039.157650541;11746.236494627821;11843.23019003762;11921.523139074687;12048.036157107235;12220.388980550759;11415.143864210384;11729.706757331134;12043.638690839289;12085.894150140515;12162.087843411957;11833.644990650295;11888.643340699793;11985.700357491132;12107.697307567381;12274;8670.869936951078;8790.077041910507;8795.516246606498;8812.51531165792;9045.909540904508;9176.082391761038;11684.532618695157;12064.939675301568;12112.333821639542;12158.696032599255 23:52:07 INFO - PROCESS | 1083 | |3;mootools.html;1316.6642506160927;1464.9560513184601;1500.2348802110923;1609.139110575842;1778.066515079583;8610.870836937444;8755.824883502333;8767.736967890965;8979.640814367434;8991.820163596723;8763.123687631234;8943.284537237021;8950.865737013934;8968.237699795525;8971.237444817181;2316.339843144708;2338.1232037985756;2340.754220806816;2342.2621874109686;2342.367560758603;2342.648602709599;2369.490559529701;2371.6442533619925;2379.1910750344878;2386.1409892438796;2255.4812393149587;2271.136967952176;2291.0263138166297;2311.0871205873755;2312.919047833326;2185.825133989277;2216.7339919209635;2217.7227846519186;2218.245796429214;2225.5660146271484;2265.920692775745;2288.530851175505;2288.8168946484243;2290.3472510334473;2291.576058429196;8909.020007799138;8953.865692014626;8960.1935825776;8976.281897448189;9279.39683920543;5254.08053590624;5348.438413966516;5352.4915133062295;5355.758990845421;5361.678299302054;3447.724182065454;3485.442329227337;3504.8598056077726;3510.947335789965;3530.1704099536587;1145.450183911727;1158.7740390623833;1171.806651902435;1175.5180376045867;1177.034831438221;12458.377081145996;12470.688232794253;12487.31319777421;12521.74956500874;12562.874371256263;4303.859477238534;4314.158739045856;4426.712263702913;4499.347594598765;4535.274356103074;9891.752706182258;9899.1585715215;9901.257405694601;9904.801903961881;9933.106020458194;5272.420033796279;5280.155175171954;5286.995470860525;5289.920651190235;5291.444398338196;4413.646908247332;4747;4835.105505481497;4846.903061938812;4951.5048495150195;3508.614052454228;3601.369760291991;3613.6567026132475;3647.544056992876;3657.6708096271464;1058.4707646176912;1061.920355973305;1065.1372388365448;1065.5205157679075;1091.9781604367868;809.5952023988006;998.3760149906309;1024.687470321559;1029.629333439961;1055.9472026398648;6171;6318.178636777189;6493.870122597522;6509.381608747161;6593.570597072795;512.9487051294915;516.6590050566608;519.4390058736556;521.7938914128898;676.2696288008939;4323.329883868006;4335.2196604610845;4344.56554344563;4348.7390756554705;4365.148795984753;10941.83587246192;11194.552217911192;11195.552177912956;11255.774884502263;11259.549618015188;11127.888721112686;11165.609203677832;11172.273802202832;11181.049610783175;11200.327980321206;7952.801179970547;8267.338612910953;8276.048254450694;8395.160483951557;8478.406511544255;6313.90529142054;6384.170057892445;6460.870782584416;6468.838279042873;6477.611343319416;10161.187105031728;10299.794004119725;10496.895031049897;10512.684619461428;10608;10560.524776385235;10657.094146997591;10716.19628527848;10785.083267922315;10824.837627435752;7772.883406749016;7845.176256492986;7906.090799557895;7946.562939038408;8112.83774324522;8856;8896.243819275434;8901.154390332907;8914.687985920462;8935.597898094471;7674.117476490052;8077.798055048435;8118.9188108120525;8217.260446559838;8282.254597086292;7851.56816375082;7931.762047138595;8034.598270086589;8043.3967452442475;8140.226678465537;7368.410527157707;7393.630318484162;7437.107547094383;7449.962750186214;7451.627418629156;5483.396826349019;5534.501894829485;5538.806141785019;5556.555475561864;5755.65466072037;5599.748011339418;5619.409961953936;5625.521830644441;5749.310082790092;5791.333996590446 23:52:07 INFO - PROCESS | 1083 | |4;prototype.html;327.7345350266283;329.4366633057472;335.31595545088015;337.3657523855152;340.5147664577976;5393.865153371167;5408.486193811592;5413.810516631918;5423.484768946949;5430.70131142787;5284.762185701643;5321.308229930104;5368.32895888014;5369.221462887879;5388.757505912234;3911.647951684348;4159.2721273777115;4238.961454443658;4261.424707664457;4266.57334266574;4107.466029416187;4118.546959834416;4127.979360103211;4137.689673274502;4159.9376009359885;4090.365993271048;4124.711270211086;4132.710710250284;4135.710500264982;4138.213739389522;3888.747231429962;3993.900152496182;4095.303798354257;4121.299379105544;4139.296319625671;3580.534530511043;3589;3603.9099022524383;3607.404778211618;3615.258871931274;5139.537441630271;5141.794328226866;5156;5195.402528709171;5241.9213711794355;4554.407926969506;4585.266357382836;4733.9763301183275;4741.952580474185;4748.477667456577;5492.96760198725;5517.724113794335;5522.337319521643;5539.642787517084;5611.494965453129;4042.2521833460905;4042.2925987952285;4049.2711311963835;4055.4930633670792;4063.97968010161;5526;5766.654000759968;5769.653820770767;5770.740316685759;5791.681457519835;3858.9807050964564;3892.8832135035996;3903.394973779069;3903.785291808921;3910.687145028391;3936.3111455495746;3940.7635541867007;3951.9012024699614;3952.110775075585;3963.147923196469;4492.618127459137;4618.976905115453;4714.787834547454;4732.148213321566;4735.976320118446;5540.9168862467095;5555.138953462219;5568.025595520849;5568.638038527482;5639.351474580394;1393.1641015390685;1398.6293632187478;1401.341369556307;1403.5508637235987;1408.1058527834693;890.6214858685033;899.4917871402637;904.2810965282616;911.521451238092;912.2792993535165;4704.764761761967;4768.403949506312;4778.211595086841;4815.566599006106;4849.393825771778;5063.215201643751;5067.5185857343495;5071.565648488746;5089.923651145235;5163.225516172604;4767.2361226346475;4815.927761083586;4822.469528351879;5102.759747560326;5322.787088516493;3007.428588568209;3016.6425108701173;3037.7417919477093;3040.60472138625;3046.8019578727312;5866.765329386777;5904.940950590439;5918.431615621864;5938.317093534212;5959.4934430573885;5705.372409035002;5768.682722450306;5799.797007104731;5808.273965754281;5890.3815099414805;5816.302043754777;5822.3304320003745;5835.854103647443;5861;5899.882002359843;5500.202470641814;5675.8864822704145;5710;5737.627054241461;5753.015209752629;5638.323401191883;5648.322201335866;5655.275141082009;5657.15142728594;5686.459786320293;5867.911981320369;5874.177615133799;5885.55858310637;5897.734601942837;5922.703864806656;3862.729608927348;4114.362273847559;4133.152703695795;4135.110951145518;4139.627433530876;5782.335031471434;5783.7397317119985;5798.6810725410505;5799.9130013049;5805.996931058778;5518.227448157181;5605.719714014364;5662.603617746719;5664.546836253172;5669.829905102853;5525.585581081355;5586.692731899784;5593.300837395325;5599.160125980972;5607.158926161109;5366.2023222221;5449.863753406196;5550.195221692751;5557.861053473695;5561.360443548881;5689;5697.772089116389;5702.857428564153;5723.914141287801;5726.5418766499415;5555.416681248411;5572.972135139298;5573.693446860461;5573.832785016456;5600.215969764317 23:52:07 INFO - PROCESS | 1083 | |5;yui.html;752.06743637889;774.3495463810401;839.2488722593279;843.2368706320774;879.8680197970306;13641.386137623806;14122.858771412282;14353.35409906554;14409.20749358786;14428.20644864532;14936.178510181935;15339.463118790845;15359.616009599738;15384;15395.76906346403;684.5037347922741;810.9270165685087;818.5661599352323;827.5034979012604;830.779843341515;831.9792005199888;832.7626626411474;833.212614079695;833.4624167412015;833.5790425834945;866.0430224601819;866.445474896067;866.6490071521013;867.7310033889482;868.097178933908;706.1702499562992;842.616609442702;861.5519929636586;862.9482231066094;865.7835541114721;634.0141080619635;634.1629049654458;634.5304474688697;634.685830513894;635.5360586771636;15269.160196189205;15283;15299.15854627995;15304.617384565363;15320;14523.491677791333;14885.851141488554;14922.477713280092;14930.178840163786;15031.398744050224;13622.727545449035;13785.448582056706;13786.93106534471;13949.721005579933;13992.930035349758;4551.817927282905;4646.930296045562;4725.66920315578;4738.952610473885;4750.809967601292;77321;77701.22298777052;78178.21821781823;78352.60823695901;79422.8086578696;11663;11669.941650291694;11684.118500268383;11969.281843089442;12047.27716337005;22132.446688832584;22169;22190;22209.1116355344;22215.77784222137;8335.083140854622;8756.124387561193;8814.691485797966;8845.557722113868;8866.512341821133;4935.012997400462;4949.529794669501;4993.101241776515;5021.6735912165595;5037.748112594429;3187.2350635847693;3304.074859039473;3314.171457135716;3315.336932613487;3317.7179939705397;609.8048624440137;621.7544070092288;627.9937200628027;637.4263163153199;637.7895294552786;641.1312671330373;660.2572106380322;660.2769966886252;683.8119517132728;690.7133539581118;9201;9236.07639236071;9238.168564829197;9467.52662366879;9498;658.8978708300222;669.3201845581127;685.873113474009;703.9260877607879;725.4740313272835;4218.2196293685765;4428.756418397019;4489.461264648197;4491.910161796745;4532.32015197723;71487.48968930416;72658.2734172662;100808.49595752121;104335;104974.4751276254;88786.55606721925;88893.55553222322;91788;101638;103477.48261258796;80322.59838700769;87269;88662;91236;92498.53750731204;9955.20358371343;10083.848742269018;10682.198835087554;10749.946250268698;10764.946175269073;44782.3282650754;52457.7377113112;52930.735346323025;53801.46198538121;54001;72864;81205.18794811977;81253;82470;85343;13656;13823.79264311016;13995.440182392591;14067.226302553458;14208.78686819678;15702;15910.204489775697;16050.438234661731;16057.437989670305;16175;12537.623871283877;13009.089363744448;13748.65628359299;14141.929290353894;14998.400063997318;13945.511907083204;14834.184119873511;15302.387904483696;15394.538163855103;15420;14418.423263069779;15044.247787610795;15525.534233973;15604.921975390505;15661;11812;12412.62762117138;12452.501899924264;12784.360781960679;12814.743705126031;11306.434678266218;11659.708507287385;11762.411879405825;11930.463129159036;11973.461194246105 23:52:07 INFO - PROCESS | 1083 | __end_tp_report 23:52:07 INFO - PROCESS | 1083 | __start_cc_report 23:52:07 INFO - PROCESS | 1083 | _x_x_mozilla_cycle_collect,865 23:52:07 INFO - PROCESS | 1083 | __end_cc_report 23:52:07 INFO - PROCESS | 1083 | __startTimestamp1468911127201__endTimestamp 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | ------- Summary: start ------- 23:52:07 INFO - PROCESS | 1083 | Number of tests: 6 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | [#0] dojo.html Cycles:165 Average:5230.74 Median:5431.35 stddev:596.16 (11.0%) stddev-sans-first:572.40 23:52:07 INFO - PROCESS | 1083 | Values: 3028.0 3042.1 3052.2 3082.5 3098.2 5175.9 5240.5 5255.2 5306.4 5355.8 5254.8 5270.6 5293.6 5295.0 5362.5 4736.3 4788.4 4838.1 4844.3 4929.0 4875.6 4878.1 4902.4 4928.7 4950.9 4730.6 4744.0 4757.9 4762.1 4768.4 4717.7 4732.0 4802.6 4811.1 4851.7 4763.5 4773.1 4779.6 4783.2 4835.4 5170.6 5178.3 5259.6 5328.5 5333.5 5649.6 5676.3 5685.7 5694.7 5705.9 5510.8 5683.8 5720.0 5729.4 5734.9 5149.6 5217.3 5224.1 5251.7 5299.1 5803.5 5812.5 5849.7 5858.8 5865.5 5377.3 5403.8 5609.4 5612.5 5620.8 5462.6 5548.6 5553.9 5606.7 5615.1 5529.2 5529.3 5537.5 5544.8 5569.4 5436.6 5553.0 5556.2 5560.6 5621.9 4200.9 4220.4 4225.5 4252.7 4264.6 3789.7 3801.6 3808.1 3810.4 3838.5 5203.2 5246.2 5285.9 5327.4 5377.5 5670.3 5689.7 5690.3 5695.8 5732.7 5340.1 5358.1 5368.2 5373.9 5375.8 4776.1 4777.0 4810.2 4869.1 4899.7 5801.9 5803.5 5806.3 5813.4 5823.0 5648.3 5658.6 5661.1 5663.1 5707.2 5677.4 5747.5 5776.4 5781.7 5813.0 5487.3 5487.6 5489.9 5497.2 5500.7 5440.2 5540.9 5600.6 5601.1 5606.4 5483.2 5533.4 5544.6 5562.2 5563.4 5526.9 5531.8 5533.5 5535.8 5542.6 5420.3 5442.2 5524.8 5533.8 5542.6 5521.1 5580.4 5592.5 5630.4 5636.7 5424.3 5425.3 5426.3 5428.6 5431.3 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | [#1] ext.html Cycles:180 Average:61531.13 Median:22928.47 stddev:125811.10 (548.7%) stddev-sans-first:126080.81 23:52:07 INFO - PROCESS | 1083 | Values: 580.9 606.4 619.3 626.5 628.1 33784.8 36889.4 37044.4 43915.0 45414.0 46165.3 46659.8 46760.5 46763.0 46817.3 9085.7 9234.8 9240.8 9243.1 9249.8 9072.4 9145.6 9154.2 9159.8 9161.5 9221.0 9230.0 9265.6 9266.4 9279.8 9207.7 9234.0 9254.2 9259.2 9260.1 9046.2 9115.2 9117.8 9121.1 9121.6 43892.8 44208.3 44355.0 44400.6 44421.3 3533.0 3583.5 3688.9 3725.9 4180.9 31535.2 33895.7 34233.5 34705.7 34866.0 4486.5 4586.9 4591.5 4600.4 4664.0 372374.0 374700.0 377629.5 377705.0 379631.0 35928.3 36963.6 64289.0 65369.0 65394.7 38905.6 38921.8 39040.4 39059.0 39141.4 16028.4 16173.4 16173.5 16186.4 16187.4 13306.3 13378.6 13378.9 13382.0 13390.4 8584.7 8672.4 8706.9 8714.9 8779.4 3311.9 3352.8 3373.3 3399.4 3411.5 1031.5 1036.8 1041.7 1061.3 1100.5 32546.7 32564.2 32773.5 32962.2 33358.0 1124.9 1139.5 1174.6 1186.8 1190.2 17173.8 17214.5 17400.4 17577.4 17746.3 596952.0 597312.0 602470.0 604346.0 605906.0 61135.4 61824.4 61878.0 61893.7 61908.4 1225.9 1307.3 1329.9 1353.6 1362.0 30494.0 34279.7 34474.0 34550.5 34566.7 51243.7 51496.0 51855.0 52007.7 52056.2 406700.0 407328.0 408734.0 409706.0 410633.0 26056.7 28934.4 29348.1 29658.7 29921.9 49907.5 50287.5 50529.5 50971.0 51017.7 41676.0 43204.4 43550.3 44074.6 44756.8 42589.8 42831.6 42976.0 43064.1 43595.8 41049.8 41894.2 42084.4 42087.2 42362.0 37237.8 38280.4 38402.6 39041.6 39163.6 28256.4 28290.3 28486.6 28526.1 28631.3 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | [#2] jquery.html Cycles:180 Average:30184.53 Median:13346.37 stddev:83854.11 (628.3%) stddev-sans-first:84059.51 23:52:07 INFO - PROCESS | 1083 | Values: 394.8 398.2 401.0 402.6 417.8 19570.9 19846.6 20368.6 20548.2 20602.0 19254.4 19534.5 20102.2 20166.4 20187.4 5296.5 5731.6 6011.1 6021.0 6110.4 6071.5 6077.7 6081.1 6087.3 6089.5 6472.2 6506.2 6514.8 6516.5 6518.9 6328.9 6494.2 6499.0 6603.3 6623.6 5864.4 5864.7 5866.2 5870.5 5883.4 18074.9 23510.5 23669.0 23672.6 24301.3 2317.2 2391.5 2478.1 2962.8 2993.6 10193.9 10319.6 12979.6 14606.0 14779.7 1983.5 1995.4 2007.2 2077.3 2153.7 81852.6 85189.0 85360.0 87019.0 88029.1 10609.9 10788.0 10854.9 10883.6 10997.0 14875.6 14939.3 14982.9 14992.1 14992.6 7862.6 8154.2 8226.7 8266.9 8326.6 7883.4 7898.2 7912.0 8018.8 8036.4 4595.1 4765.0 4821.7 4864.8 4917.5 1992.8 2013.6 2017.4 2030.0 2062.1 879.3 954.6 994.2 1023.2 1023.2 19623.5 19968.4 20359.5 20455.9 20525.1 988.2 1016.2 1035.8 1099.7 1100.5 10730.1 11348.2 11412.3 11446.5 11479.8 497121.0 503290.0 505724.0 516973.0 518148.0 81870.3 94492.0 96431.0 97765.0 98790.0 1003.7 1006.2 1025.6 1055.8 1060.7 17402.6 17668.6 18071.8 18120.5 18408.8 45290.8 45947.5 46161.3 46396.1 46440.5 61565.0 61708.7 61778.1 64134.4 64154.0 8414.9 8565.5 8613.4 8691.8 8846.0 12318.6 12764.5 13209.5 13967.5 14039.2 11746.2 11843.2 11921.5 12048.0 12220.4 11415.1 11729.7 12043.6 12085.9 12162.1 11833.6 11888.6 11985.7 12107.7 12274.0 8670.9 8790.1 8795.5 8812.5 9045.9 9176.1 11684.5 12064.9 12112.3 12158.7 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | [#3] mootools.html Cycles:180 Average:5925.90 Median:4841.00 stddev:3414.28 (70.5%) stddev-sans-first:3406.28 23:52:07 INFO - PROCESS | 1083 | Values: 1316.7 1465.0 1500.2 1609.1 1778.1 8610.9 8755.8 8767.7 8979.6 8991.8 8763.1 8943.3 8950.9 8968.2 8971.2 2316.3 2338.1 2340.8 2342.3 2342.4 2342.6 2369.5 2371.6 2379.2 2386.1 2255.5 2271.1 2291.0 2311.1 2312.9 2185.8 2216.7 2217.7 2218.2 2225.6 2265.9 2288.5 2288.8 2290.3 2291.6 8909.0 8953.9 8960.2 8976.3 9279.4 5254.1 5348.4 5352.5 5355.8 5361.7 3447.7 3485.4 3504.9 3510.9 3530.2 1145.5 1158.8 1171.8 1175.5 1177.0 12458.4 12470.7 12487.3 12521.7 12562.9 4303.9 4314.2 4426.7 4499.3 4535.3 9891.8 9899.2 9901.3 9904.8 9933.1 5272.4 5280.2 5287.0 5289.9 5291.4 4413.6 4747.0 4835.1 4846.9 4951.5 3508.6 3601.4 3613.7 3647.5 3657.7 1058.5 1061.9 1065.1 1065.5 1092.0 809.6 998.4 1024.7 1029.6 1055.9 6171.0 6318.2 6493.9 6509.4 6593.6 512.9 516.7 519.4 521.8 676.3 4323.3 4335.2 4344.6 4348.7 4365.1 10941.8 11194.6 11195.6 11255.8 11259.5 11127.9 11165.6 11172.3 11181.0 11200.3 7952.8 8267.3 8276.0 8395.2 8478.4 6313.9 6384.2 6460.9 6468.8 6477.6 10161.2 10299.8 10496.9 10512.7 10608.0 10560.5 10657.1 10716.2 10785.1 10824.8 7772.9 7845.2 7906.1 7946.6 8112.8 8856.0 8896.2 8901.2 8914.7 8935.6 7674.1 8077.8 8118.9 8217.3 8282.3 7851.6 7931.8 8034.6 8043.4 8140.2 7368.4 7393.6 7437.1 7450.0 7451.6 5483.4 5534.5 5538.8 5556.6 5755.7 5599.7 5619.4 5625.5 5749.3 5791.3 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | [#4] prototype.html Cycles:180 Average:4644.84 Median:5322.05 stddev:1380.35 (25.9%) stddev-sans-first:1345.65 23:52:07 INFO - PROCESS | 1083 | Values: 327.7 329.4 335.3 337.4 340.5 5393.9 5408.5 5413.8 5423.5 5430.7 5284.8 5321.3 5368.3 5369.2 5388.8 3911.6 4159.3 4239.0 4261.4 4266.6 4107.5 4118.5 4128.0 4137.7 4159.9 4090.4 4124.7 4132.7 4135.7 4138.2 3888.7 3993.9 4095.3 4121.3 4139.3 3580.5 3589.0 3603.9 3607.4 3615.3 5139.5 5141.8 5156.0 5195.4 5241.9 4554.4 4585.3 4734.0 4742.0 4748.5 5493.0 5517.7 5522.3 5539.6 5611.5 4042.3 4042.3 4049.3 4055.5 4064.0 5526.0 5766.7 5769.7 5770.7 5791.7 3859.0 3892.9 3903.4 3903.8 3910.7 3936.3 3940.8 3951.9 3952.1 3963.1 4492.6 4619.0 4714.8 4732.1 4736.0 5540.9 5555.1 5568.0 5568.6 5639.4 1393.2 1398.6 1401.3 1403.6 1408.1 890.6 899.5 904.3 911.5 912.3 4704.8 4768.4 4778.2 4815.6 4849.4 5063.2 5067.5 5071.6 5089.9 5163.2 4767.2 4815.9 4822.5 5102.8 5322.8 3007.4 3016.6 3037.7 3040.6 3046.8 5866.8 5904.9 5918.4 5938.3 5959.5 5705.4 5768.7 5799.8 5808.3 5890.4 5816.3 5822.3 5835.9 5861.0 5899.9 5500.2 5675.9 5710.0 5737.6 5753.0 5638.3 5648.3 5655.3 5657.2 5686.5 5867.9 5874.2 5885.6 5897.7 5922.7 3862.7 4114.4 4133.2 4135.1 4139.6 5782.3 5783.7 5798.7 5799.9 5806.0 5518.2 5605.7 5662.6 5664.5 5669.8 5525.6 5586.7 5593.3 5599.2 5607.2 5366.2 5449.9 5550.2 5557.9 5561.4 5689.0 5697.8 5702.9 5723.9 5726.5 5555.4 5573.0 5573.7 5573.8 5600.2 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - PROCESS | 1083 | [#5] yui.html Cycles:180 Average:20619.56 Median:4599.37 stddev:28343.29 (616.2%) stddev-sans-first:28383.54 23:52:07 INFO - PROCESS | 1083 | Values: 752.1 774.3 839.2 843.2 879.9 13641.4 14122.9 14353.4 14409.2 14428.2 14936.2 15339.5 15359.6 15384.0 15395.8 684.5 810.9 818.6 827.5 830.8 832.0 832.8 833.2 833.5 833.6 866.0 866.4 866.6 867.7 868.1 706.2 842.6 861.6 862.9 865.8 634.0 634.2 634.5 634.7 635.5 15269.2 15283.0 15299.2 15304.6 15320.0 14523.5 14885.9 14922.5 14930.2 15031.4 13622.7 13785.4 13786.9 13949.7 13992.9 4551.8 4646.9 4725.7 4739.0 4750.8 77321.0 77701.2 78178.2 78352.6 79422.8 11663.0 11669.9 11684.1 11969.3 12047.3 22132.4 22169.0 22190.0 22209.1 22215.8 8335.1 8756.1 8814.7 8845.6 8866.5 4935.0 4949.5 4993.1 5021.7 5037.7 3187.2 3304.1 3314.2 3315.3 3317.7 609.8 621.8 628.0 637.4 637.8 641.1 660.3 660.3 683.8 690.7 9201.0 9236.1 9238.2 9467.5 9498.0 658.9 669.3 685.9 703.9 725.5 4218.2 4428.8 4489.5 4491.9 4532.3 71487.5 72658.3 100808.5 104335.0 104974.5 88786.6 88893.6 91788.0 101638.0 103477.5 80322.6 87269.0 88662.0 91236.0 92498.5 9955.2 10083.8 10682.2 10749.9 10764.9 44782.3 52457.7 52930.7 53801.5 54001.0 72864.0 81205.2 81253.0 82470.0 85343.0 13656.0 13823.8 13995.4 14067.2 14208.8 15702.0 15910.2 16050.4 16057.4 16175.0 12537.6 13009.1 13748.7 14141.9 14998.4 13945.5 14834.2 15302.4 15394.5 15420.0 14418.4 15044.2 15525.5 15604.9 15661.0 11812.0 12412.6 12452.5 12784.4 12814.7 11306.4 11659.7 11762.4 11930.5 11973.5 23:52:07 INFO - PROCESS | 1083 | -------- Summary: end -------- 23:52:07 INFO - PROCESS | 1083 | 23:52:07 INFO - TEST-INFO | 1083: exit 0 23:52:07 INFO - TEST-OK | dromaeo_css | took 1113949ms 23:52:07 INFO - TEST-START | kraken 23:52:07 INFO - operating with platform_type : linux_ 23:52:07 INFO - Initialising browser for kraken test... 23:52:07 INFO - TEST-INFO | started process 1343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdu5C_O/profile http://localhost:49889/getInfo.html) 23:52:12 INFO - PROCESS | 1343 | __metrics Screen width/height:1600/1200 23:52:12 INFO - PROCESS | 1343 | colorDepth:24 23:52:12 INFO - PROCESS | 1343 | Browser inner width/height: 1024/697 23:52:12 INFO - PROCESS | 1343 | __metrics 23:52:13 INFO - PROCESS | 1343 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:52:13 INFO - PROCESS | 1343 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:52:13 INFO - PROCESS | 1343 | console.error: PushService: 23:52:13 INFO - PROCESS | 1343 | stateChangeProcessEnqueue: Error transitioning state 23:52:13 INFO - PROCESS | 1343 | UnknownError 23:52:14 INFO - TEST-INFO | 1343: exit 0 23:52:14 INFO - Browser initialized. 23:52:14 INFO - Running cycle 1/1 for kraken test... 23:52:14 INFO - TEST-INFO | started process 1429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdu5C_O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:52:25 INFO - PROCESS | 1429 | RSS: Main: 158273536 23:52:25 INFO - PROCESS | 1429 | 23:52:28 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49889/tests/kraken/driver.html?testName=audio-beat-detection) 23:52:29 INFO - PROCESS | 1429 | RSS: Main: 216891392 23:52:29 INFO - PROCESS | 1429 | 23:52:31 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49889/tests/kraken/driver.html?testName=audio-dft) 23:52:32 INFO - PROCESS | 1429 | RSS: Main: 205590528 23:52:32 INFO - PROCESS | 1429 | 23:52:35 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49889/tests/kraken/driver.html?testName=audio-fft) 23:52:36 INFO - PROCESS | 1429 | RSS: Main: 269668352 23:52:36 INFO - PROCESS | 1429 | 23:52:38 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49889/tests/kraken/driver.html?testName=audio-oscillator) 23:52:38 INFO - PROCESS | 1429 | RSS: Main: 181317632 23:52:38 INFO - PROCESS | 1429 | 23:52:40 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49889/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:52:41 INFO - PROCESS | 1429 | RSS: Main: 185700352 23:52:41 INFO - PROCESS | 1429 | 23:52:44 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49889/tests/kraken/driver.html?testName=imaging-darkroom) 23:52:45 INFO - PROCESS | 1429 | RSS: Main: 221638656 23:52:45 INFO - PROCESS | 1429 | 23:52:48 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49889/tests/kraken/driver.html?testName=imaging-desaturate) 23:52:49 INFO - PROCESS | 1429 | RSS: Main: 220999680 23:52:49 INFO - PROCESS | 1429 | 23:52:51 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49889/tests/kraken/driver.html?testName=json-parse-financial) 23:52:52 INFO - PROCESS | 1429 | RSS: Main: 221519872 23:52:52 INFO - PROCESS | 1429 | 23:52:53 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49889/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:52:54 INFO - PROCESS | 1429 | RSS: Main: 209993728 23:52:54 INFO - PROCESS | 1429 | 23:52:56 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:52:56 INFO - PROCESS | 1429 | RSS: Main: 214634496 23:52:56 INFO - PROCESS | 1429 | 23:52:58 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:52:59 INFO - PROCESS | 1429 | RSS: Main: 214831104 23:52:59 INFO - PROCESS | 1429 | 23:53:02 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:53:02 INFO - PROCESS | 1429 | RSS: Main: 225361920 23:53:02 INFO - PROCESS | 1429 | 23:53:05 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:53:05 INFO - PROCESS | 1429 | RSS: Main: 225644544 23:53:05 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | Cycle 1(1): loaded http://localhost:49889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49889/tests/kraken/driver.html?testName=ai-astar) 23:53:07 INFO - PROCESS | 1429 | RSS: Main: 268226560 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | __start_tp_report 23:53:07 INFO - PROCESS | 1429 | _x_x_mozilla_page_load 23:53:07 INFO - PROCESS | 1429 | _x_x_mozilla_page_load_details 23:53:07 INFO - PROCESS | 1429 | |i|pagename|runs| 23:53:07 INFO - PROCESS | 1429 | |0;ai-astar;102;113;113;113;114;113;113;111;110;111 23:53:07 INFO - PROCESS | 1429 | |1;audio-beat-detection;144;118;118;169;122;125;137;119;145;119 23:53:07 INFO - PROCESS | 1429 | |2;audio-dft;162;161;160;160;159;159;160;160;160;161 23:53:07 INFO - PROCESS | 1429 | |3;audio-fft;76;74;76;123;76;76;74;74;101;74 23:53:07 INFO - PROCESS | 1429 | |4;audio-oscillator;83;84;127;84;83;89;113;85;84;122 23:53:07 INFO - PROCESS | 1429 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;116;117;117 23:53:07 INFO - PROCESS | 1429 | |6;imaging-darkroom;146;146;146;145;145;145;146;146;147;145 23:53:07 INFO - PROCESS | 1429 | |7;imaging-desaturate;96;95;95;95;95;94;95;95;95;95 23:53:07 INFO - PROCESS | 1429 | |8;json-parse-financial;52;50;50;50;50;51;51;50;49;50 23:53:07 INFO - PROCESS | 1429 | |9;json-stringify-tinderbox;60;62;61;61;61;60;60;60;61;61 23:53:07 INFO - PROCESS | 1429 | |10;stanford-crypto-aes;75;75;83;74;82;74;83;74;74;74 23:53:07 INFO - PROCESS | 1429 | |11;stanford-crypto-ccm;135;123;118;118;116;117;128;120;170;134 23:53:07 INFO - PROCESS | 1429 | |12;stanford-crypto-pbkdf2;167;164;164;160;156;159;153;155;153;160 23:53:07 INFO - PROCESS | 1429 | |13;stanford-crypto-sha256-iterative;66;62;63;63;62;62;63;63;61;60 23:53:07 INFO - PROCESS | 1429 | __end_tp_report 23:53:07 INFO - PROCESS | 1429 | __start_cc_report 23:53:07 INFO - PROCESS | 1429 | _x_x_mozilla_cycle_collect,1627 23:53:07 INFO - PROCESS | 1429 | __end_cc_report 23:53:07 INFO - PROCESS | 1429 | __startTimestamp1468911187797__endTimestamp 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | ------- Summary: start ------- 23:53:07 INFO - PROCESS | 1429 | Number of tests: 14 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:1.32 23:53:07 INFO - PROCESS | 1429 | Values: 102.0 113.0 113.0 113.0 114.0 113.0 113.0 111.0 110.0 111.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:131.00 stddev:16.95 (12.9%) stddev-sans-first:17.37 23:53:07 INFO - PROCESS | 1429 | Values: 144.0 118.0 118.0 169.0 122.0 125.0 137.0 119.0 145.0 119.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 23:53:07 INFO - PROCESS | 1429 | Values: 162.0 161.0 160.0 160.0 159.0 159.0 160.0 160.0 160.0 161.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.47 (22.0%) stddev-sans-first:17.30 23:53:07 INFO - PROCESS | 1429 | Values: 76.0 74.0 76.0 123.0 76.0 76.0 74.0 74.0 101.0 74.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:17.83 (21.2%) stddev-sans-first:18.34 23:53:07 INFO - PROCESS | 1429 | Values: 83.0 84.0 127.0 84.0 83.0 89.0 113.0 85.0 84.0 122.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:53:07 INFO - PROCESS | 1429 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:53:07 INFO - PROCESS | 1429 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 147.0 145.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 23:53:07 INFO - PROCESS | 1429 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.60 23:53:07 INFO - PROCESS | 1429 | Values: 52.0 50.0 50.0 50.0 50.0 51.0 51.0 50.0 49.0 50.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 23:53:07 INFO - PROCESS | 1429 | Values: 60.0 62.0 61.0 61.0 61.0 60.0 60.0 60.0 61.0 61.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:75.00 stddev:4.08 (5.4%) stddev-sans-first:4.27 23:53:07 INFO - PROCESS | 1429 | Values: 75.0 75.0 83.0 74.0 82.0 74.0 83.0 74.0 74.0 74.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.50 stddev:16.34 (13.0%) stddev-sans-first:17.13 23:53:07 INFO - PROCESS | 1429 | Values: 135.0 123.0 118.0 118.0 116.0 117.0 128.0 120.0 170.0 134.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.00 stddev:4.86 (3.0%) stddev-sans-first:4.24 23:53:07 INFO - PROCESS | 1429 | Values: 167.0 164.0 164.0 160.0 156.0 159.0 153.0 155.0 153.0 160.0 23:53:07 INFO - PROCESS | 1429 | 23:53:07 INFO - PROCESS | 1429 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.05 23:53:07 INFO - PROCESS | 1429 | Values: 66.0 62.0 63.0 63.0 62.0 62.0 63.0 63.0 61.0 60.0 23:53:07 INFO - PROCESS | 1429 | -------- Summary: end -------- 23:53:07 INFO - PROCESS | 1429 | 23:53:08 INFO - TEST-INFO | 1429: exit 0 23:53:08 INFO - TEST-OK | kraken | took 60869ms 23:53:08 INFO - SUITE-END | took 1174s 23:53:08 INFO - Completed test suite (00:19:34) 23:53:08 INFO - javascript benchmark 23:53:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.0, 3042.1329920972526, 3052.175912503624, 3082.4759790835556, 3098.2409309719123, 5175.896482070356, 5240.475952404767, 5255.159174532076, 5306.389765177006, 5355.758990845412, 5254.789808407669, 5270.5520030797425, 5293.6294459387855, 5295.0, 5362.490563396481, 4736.313234580975, 4788.353572267734, 4838.080764654722, 4844.32179494871, 4929.0, 4875.609951203895, 4878.146324393235, 4902.436219834711, 4928.679635823678, 4950.900981980359, 4730.550597693214, 4744.0, 4757.881052973668, 4762.1428142934255, 4768.403949506329, 4717.740524271164, 4732.02993386355, 4802.639802014863, 4811.08589368019, 4851.708897466164, 4763.54746299101, 4773.0965501135415, 4779.569838714532, 4783.162946484351, 4835.443923948756, 5170.612204084671, 5178.275041494194, 5259.631825772198, 5328.547073498718, 5333.493318134771, 5649.576281778842, 5676.347220069703, 5685.744141513642, 5694.743736531866, 5705.857353566153, 5510.834674959758, 5683.829485115411, 5720.0, 5729.427057294279, 5734.885302293973, 5149.588032957355, 5217.34783152106, 5224.085784987612, 5251.711155886463, 5299.072662284085, 5803.5357171426185, 5812.505936995402, 5849.707514624251, 5858.8242352729485, 5865.501432378211, 5377.300950876361, 5403.7838486460105, 5609.354924183689, 5612.466815652507, 5620.775168993195, 5462.562994960394, 5548.55611551075, 5553.944460555343, 5606.6916319602815, 5615.101583746581, 5529.170624406372, 5529.281193444907, 5537.473939975695, 5544.77820887168, 5569.443055694479, 5436.565074794007, 5553.0, 5556.166575013699, 5560.555155587544, 5621.943780562224, 4200.915981680349, 4220.40914271996, 4225.535191128974, 4252.723572967747, 4264.594863487963, 3789.7157713171623, 3801.6388443097862, 3808.0670235791854, 3810.447485114643, 3838.539375274929, 5203.2195170723935, 5246.160614301693, 5285.894282114413, 5327.360716714019, 5377.489138531833, 5670.291213598301, 5689.743961521742, 5690.345610254791, 5695.772169113189, 5732.713364331767, 5340.145576707708, 5358.089124848785, 5368.194770784414, 5373.919391209135, 5375.7849686012905, 4776.140294746979, 4777.0, 4810.158222311082, 4869.050535145612, 4899.657024008286, 5801.8549536261935, 5803.5357171426185, 5806.274215723035, 5813.447722466359, 5822.970885145547, 5648.322201335866, 5658.603897727285, 5661.094224923992, 5663.062748133503, 5707.1724599933605, 5677.432256774289, 5747.453991870766, 5776.393478684678, 5781.710914454176, 5812.9827280224945, 5487.259220005249, 5487.588430867621, 5489.890202196014, 5497.175423686479, 5500.724963751716, 5440.211169380497, 5540.864122854725, 5600.551955843604, 5601.103823388238, 5606.439356064361, 5483.232347471437, 5533.446655334435, 5544.584156188383, 5562.193481945176, 5563.360213575491, 5526.944730552643, 5531.806386776443, 5533.474319939599, 5535.7785688572, 5542.63972841764, 5420.349558053059, 5442.210879422382, 5524.8342549723575, 5533.833984980457, 5542.584306176972, 5521.061419558604, 5580.441955804387, 5592.496675299242, 5630.4369563043365, 5636.661800291996, 5424.267723857387, 5425.267588875609, 5426.267453893832, 5428.647137936022, 5431.34823821144], "value": 5190.276912828718, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8809194115207, 606.4360145065087, 619.2630769384431, 626.5144513002424, 628.0767272109999, 33784.83107584462, 36889.44665830011, 37044.44433333502, 43915.0, 45414.0, 46165.30752038722, 46659.766701166445, 46760.53239467604, 46763.0, 46817.29774053392, 9085.682001129962, 9234.769130771718, 9240.768980775501, 9243.07569243077, 9249.815003699921, 9072.410293330913, 9145.634174633007, 9154.176124148826, 9159.771005724877, 9161.496117713523, 9221.031791661879, 9230.0, 9265.583048762823, 9266.44401335922, 9279.768005799842, 9207.723768286929, 9234.0, 9254.167124958785, 9259.166674999215, 9260.120288572574, 9046.185843274072, 9115.179633832988, 9117.772055698595, 9121.087891210893, 9121.635134594608, 43892.78053609744, 44208.3368749469, 44355.0, 44400.555994440285, 44421.33367999482, 3533.0, 3583.4803953426867, 3688.907777305562, 3725.9441108383394, 4180.937285940713, 31535.211619709462, 33895.6610433895, 34233.4864977023, 34705.65294347049, 34866.0, 4486.461624605068, 4586.862394128181, 4591.471980722193, 4600.378948841897, 4663.953360466419, 372374.0, 374700.0, 377629.45408548356, 377705.0, 379631.0, 35928.281434371165, 36963.63036369602, 64289.0, 65369.0, 65394.67302663456, 38905.6109438902, 38921.80539097286, 39040.414393784115, 39059.0, 39141.41287880684, 16028.358865645243, 16173.4339298124, 16173.514794555947, 16186.352545898268, 16187.352505899868, 13306.334683265797, 13378.598642040753, 13378.866211337761, 13382.0, 13390.397432115578, 8584.699535516227, 8672.436291641023, 8706.869396959051, 8714.869276960851, 8779.385443018928, 3311.850966706504, 3352.832358382071, 3373.3421982713626, 3399.4390925497014, 3411.522386865841, 1031.5197592460565, 1036.7770929250248, 1041.6927006533092, 1061.2783307350921, 1100.5212732461405, 32546.674533254838, 32564.185895352806, 32773.50839737406, 32962.20699567328, 33358.0, 1124.9325040497597, 1139.4530625299737, 1174.6006357838376, 1186.827909953052, 1190.190670344157, 17173.828261717223, 17214.483565493054, 17400.39098631542, 17577.384791532237, 17746.29014839392, 596952.0, 597312.0, 602470.0, 604346.0, 605906.0, 61135.388646112966, 61824.38175618276, 61878.0, 61893.69053154706, 61908.38091619116, 1225.9019278457881, 1307.3332600373878, 1329.8936085113362, 1353.5668586052566, 1361.9727605447836, 30494.0, 34279.657203428644, 34474.0, 34550.48174277337, 34566.65433345635, 51243.74378128086, 51496.0, 51855.0, 52007.73996129995, 52056.21915671192, 406700.0, 407328.0, 408734.0, 409706.0, 410633.0, 26056.73943260543, 28934.42131157323, 29348.11955641334, 29658.703412965595, 29921.850390747906, 49907.500924991735, 50287.49712502828, 50529.49470505248, 50971.0, 51017.74491127521, 41676.0, 43204.35193472038, 43550.34674479822, 44074.559254407046, 44756.76216189112, 42589.787051064544, 42831.571684284005, 42976.0, 43064.13871722485, 43595.78202109096, 41049.79475102606, 41894.1621167581, 42084.36873446962, 42087.158256835304, 42362.0, 37237.81381093077, 38280.42579361256, 38402.61597384102, 39041.609583903795, 39163.608363916, 28256.434871302048, 28290.292742680773, 28486.57270140991, 28526.144215673565, 28631.284217894718], "value": 19522.1600029063, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.80457173699017, 398.18571022259476, 400.9759414435134, 402.5833262573237, 417.7911044477761, 19570.902145489254, 19846.60306793863, 20368.592628147428, 20548.178072877086, 20601.99999999998, 19254.43828328151, 19534.51163720904, 20102.195912163497, 20166.39500814978, 20187.39437816868, 5296.496832800878, 5731.598788084815, 6011.098335249704, 6021.0, 6110.358412366704, 6071.514278857703, 6077.665728384937, 6081.118237855509, 6087.330393656716, 6089.482393996494, 6472.223333200022, 6506.186726659168, 6514.7719829805965, 6516.4786817054755, 6518.902216466757, 6328.873422531569, 6494.220693516784, 6499.0, 6603.306652801435, 6623.569467984566, 5864.354920958691, 5864.677442740647, 5866.20806191163, 5870.501007414375, 5883.411658834125, 18074.90962545192, 23510.529789404118, 23669.0, 23672.64491032636, 24301.27096187117, 2317.2237300504353, 2391.4619210677633, 2478.1450399612286, 2962.844490648649, 2993.5659329397117, 10193.949030254875, 10319.58721651133, 12979.610611681665, 14606.0, 14779.704405911929, 1983.4942089767162, 1995.3814317561603, 2007.2272175212502, 2077.3352527191305, 2153.676948457728, 81852.59073704593, 85188.99999999937, 85360.0, 87019.0, 88029.11970880273, 10609.939006099328, 10788.0, 10854.891451085388, 10883.619073332395, 10997.0, 14875.628109297355, 14939.25303734809, 14982.925085374503, 14992.100473971597, 14992.550223493312, 7862.567558784322, 8154.184581541917, 8226.712065077694, 8266.941231744293, 8326.583670816435, 7883.448158628956, 7898.210178982055, 7911.960440197762, 8018.759437216893, 8036.4374493786045, 4595.080983803253, 4765.0, 4821.734804585712, 4864.805407783649, 4917.508249175054, 1992.7907569705262, 2013.5570174561574, 2017.3544465770813, 2029.9797002030086, 2062.1442101527996, 879.3404946290283, 954.575214029764, 994.1847684898314, 1023.1712313026472, 1023.2223510132204, 19623.50941226452, 19968.400947971582, 20359.455068116484, 20455.85746989157, 20525.076371563315, 988.1600639456548, 1016.202281209262, 1035.782485678016, 1099.6536091131268, 1100.49927283086, 10730.141588672888, 11348.205625606293, 11412.258203216765, 11446.542138314375, 11479.827802582968, 497121.0, 503290.0, 505724.0, 516973.0, 518148.0, 81870.31583578754, 94492.0, 96431.0, 97765.0, 98790.0, 1003.7390278527636, 1006.2201793609864, 1025.610268098118, 1055.7782865598156, 1060.734816295926, 17402.564935876704, 17668.64662706713, 18071.819281807013, 18120.546986325448, 18408.81591184071, 45290.773546132055, 45947.540524595664, 46161.307580386994, 46396.07207855756, 46440.53559464497, 61565.0, 61708.69145654243, 61778.073328901, 64134.35865641284, 64154.0, 8414.915850841413, 8565.48607083577, 8613.353998450266, 8691.826163476822, 8846.0, 12318.568850090203, 12764.489420423079, 13209.471621135048, 13967.511137110152, 14039.157650541, 11746.236494627821, 11843.23019003762, 11921.523139074687, 12048.036157107235, 12220.388980550759, 11415.143864210384, 11729.706757331134, 12043.638690839289, 12085.894150140515, 12162.087843411957, 11833.644990650295, 11888.643340699793, 11985.700357491132, 12107.697307567381, 12274.0, 8670.869936951078, 8790.077041910507, 8795.516246606498, 8812.51531165792, 9045.909540904508, 9176.082391761038, 11684.532618695157, 12064.939675301568, 12112.333821639542, 12158.696032599255], "value": 9591.588787918887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.6642506160927, 1464.9560513184601, 1500.2348802110923, 1609.139110575842, 1778.066515079583, 8610.870836937444, 8755.824883502333, 8767.736967890965, 8979.640814367434, 8991.820163596723, 8763.123687631234, 8943.284537237021, 8950.865737013934, 8968.237699795525, 8971.237444817181, 2316.339843144708, 2338.1232037985756, 2340.754220806816, 2342.2621874109686, 2342.367560758603, 2342.648602709599, 2369.490559529701, 2371.6442533619925, 2379.1910750344878, 2386.1409892438796, 2255.4812393149587, 2271.136967952176, 2291.0263138166297, 2311.0871205873755, 2312.919047833326, 2185.825133989277, 2216.7339919209635, 2217.7227846519186, 2218.245796429214, 2225.5660146271484, 2265.920692775745, 2288.530851175505, 2288.8168946484243, 2290.3472510334473, 2291.576058429196, 8909.020007799138, 8953.865692014626, 8960.1935825776, 8976.281897448189, 9279.39683920543, 5254.08053590624, 5348.438413966516, 5352.4915133062295, 5355.758990845421, 5361.678299302054, 3447.724182065454, 3485.442329227337, 3504.8598056077726, 3510.947335789965, 3530.1704099536587, 1145.450183911727, 1158.7740390623833, 1171.806651902435, 1175.5180376045867, 1177.034831438221, 12458.377081145996, 12470.688232794253, 12487.31319777421, 12521.74956500874, 12562.874371256263, 4303.859477238534, 4314.158739045856, 4426.712263702913, 4499.347594598765, 4535.274356103074, 9891.752706182258, 9899.1585715215, 9901.257405694601, 9904.801903961881, 9933.106020458194, 5272.420033796279, 5280.155175171954, 5286.995470860525, 5289.920651190235, 5291.444398338196, 4413.646908247332, 4747.0, 4835.105505481497, 4846.903061938812, 4951.5048495150195, 3508.614052454228, 3601.369760291991, 3613.6567026132475, 3647.544056992876, 3657.6708096271464, 1058.4707646176912, 1061.920355973305, 1065.1372388365448, 1065.5205157679075, 1091.9781604367868, 809.5952023988006, 998.3760149906309, 1024.687470321559, 1029.629333439961, 1055.9472026398648, 6171.0, 6318.178636777189, 6493.870122597522, 6509.381608747161, 6593.570597072795, 512.9487051294915, 516.6590050566608, 519.4390058736556, 521.7938914128898, 676.2696288008939, 4323.329883868006, 4335.2196604610845, 4344.56554344563, 4348.7390756554705, 4365.148795984753, 10941.83587246192, 11194.552217911192, 11195.552177912956, 11255.774884502263, 11259.549618015188, 11127.888721112686, 11165.609203677832, 11172.273802202832, 11181.049610783175, 11200.327980321206, 7952.801179970547, 8267.338612910953, 8276.048254450694, 8395.160483951557, 8478.406511544255, 6313.90529142054, 6384.170057892445, 6460.870782584416, 6468.838279042873, 6477.611343319416, 10161.187105031728, 10299.794004119725, 10496.895031049897, 10512.684619461428, 10608.0, 10560.524776385235, 10657.094146997591, 10716.19628527848, 10785.083267922315, 10824.837627435752, 7772.883406749016, 7845.176256492986, 7906.090799557895, 7946.562939038408, 8112.83774324522, 8856.0, 8896.243819275434, 8901.154390332907, 8914.687985920462, 8935.597898094471, 7674.117476490052, 8077.798055048435, 8118.9188108120525, 8217.260446559838, 8282.254597086292, 7851.56816375082, 7931.762047138595, 8034.598270086589, 8043.3967452442475, 8140.226678465537, 7368.410527157707, 7393.630318484162, 7437.107547094383, 7449.962750186214, 7451.627418629156, 5483.396826349019, 5534.501894829485, 5538.806141785019, 5556.555475561864, 5755.65466072037, 5599.748011339418, 5619.409961953936, 5625.521830644441, 5749.310082790092, 5791.333996590446], "value": 4636.155287317917, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.7345350266283, 329.4366633057472, 335.31595545088015, 337.3657523855152, 340.5147664577976, 5393.865153371167, 5408.486193811592, 5413.810516631918, 5423.484768946949, 5430.70131142787, 5284.762185701643, 5321.308229930104, 5368.32895888014, 5369.221462887879, 5388.757505912234, 3911.647951684348, 4159.2721273777115, 4238.961454443658, 4261.424707664457, 4266.57334266574, 4107.466029416187, 4118.546959834416, 4127.979360103211, 4137.689673274502, 4159.9376009359885, 4090.365993271048, 4124.711270211086, 4132.710710250284, 4135.710500264982, 4138.213739389522, 3888.747231429962, 3993.900152496182, 4095.303798354257, 4121.299379105544, 4139.296319625671, 3580.534530511043, 3589.0, 3603.9099022524383, 3607.404778211618, 3615.258871931274, 5139.537441630271, 5141.794328226866, 5156.0, 5195.402528709171, 5241.9213711794355, 4554.407926969506, 4585.266357382836, 4733.9763301183275, 4741.952580474185, 4748.477667456577, 5492.96760198725, 5517.724113794335, 5522.337319521643, 5539.642787517084, 5611.494965453129, 4042.2521833460905, 4042.2925987952285, 4049.2711311963835, 4055.4930633670792, 4063.97968010161, 5526.0, 5766.654000759968, 5769.653820770767, 5770.740316685759, 5791.681457519835, 3858.9807050964564, 3892.8832135035996, 3903.394973779069, 3903.785291808921, 3910.687145028391, 3936.3111455495746, 3940.7635541867007, 3951.9012024699614, 3952.110775075585, 3963.147923196469, 4492.618127459137, 4618.976905115453, 4714.787834547454, 4732.148213321566, 4735.976320118446, 5540.9168862467095, 5555.138953462219, 5568.025595520849, 5568.638038527482, 5639.351474580394, 1393.1641015390685, 1398.6293632187478, 1401.341369556307, 1403.5508637235987, 1408.1058527834693, 890.6214858685033, 899.4917871402637, 904.2810965282616, 911.521451238092, 912.2792993535165, 4704.764761761967, 4768.403949506312, 4778.211595086841, 4815.566599006106, 4849.393825771778, 5063.215201643751, 5067.5185857343495, 5071.565648488746, 5089.923651145235, 5163.225516172604, 4767.2361226346475, 4815.927761083586, 4822.469528351879, 5102.759747560326, 5322.787088516493, 3007.428588568209, 3016.6425108701173, 3037.7417919477093, 3040.60472138625, 3046.8019578727312, 5866.765329386777, 5904.940950590439, 5918.431615621864, 5938.317093534212, 5959.4934430573885, 5705.372409035002, 5768.682722450306, 5799.797007104731, 5808.273965754281, 5890.3815099414805, 5816.302043754777, 5822.3304320003745, 5835.854103647443, 5861.0, 5899.882002359843, 5500.202470641814, 5675.8864822704145, 5710.0, 5737.627054241461, 5753.015209752629, 5638.323401191883, 5648.322201335866, 5655.275141082009, 5657.15142728594, 5686.459786320293, 5867.911981320369, 5874.177615133799, 5885.55858310637, 5897.734601942837, 5922.703864806656, 3862.729608927348, 4114.362273847559, 4133.152703695795, 4135.110951145518, 4139.627433530876, 5782.335031471434, 5783.7397317119985, 5798.6810725410505, 5799.9130013049, 5805.996931058778, 5518.227448157181, 5605.719714014364, 5662.603617746719, 5664.546836253172, 5669.829905102853, 5525.585581081355, 5586.692731899784, 5593.300837395325, 5599.160125980972, 5607.158926161109, 5366.2023222221, 5449.863753406196, 5550.195221692751, 5557.861053473695, 5561.360443548881, 5689.0, 5697.772089116389, 5702.857428564153, 5723.914141287801, 5726.5418766499415, 5555.416681248411, 5572.972135139298, 5573.693446860461, 5573.832785016456, 5600.215969764317], "value": 4204.3219519456425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.06743637889, 774.3495463810401, 839.2488722593279, 843.2368706320774, 879.8680197970306, 13641.386137623806, 14122.858771412282, 14353.35409906554, 14409.20749358786, 14428.20644864532, 14936.178510181935, 15339.463118790845, 15359.616009599738, 15384.0, 15395.76906346403, 684.5037347922741, 810.9270165685087, 818.5661599352323, 827.5034979012604, 830.779843341515, 831.9792005199888, 832.7626626411474, 833.212614079695, 833.4624167412015, 833.5790425834945, 866.0430224601819, 866.445474896067, 866.6490071521013, 867.7310033889482, 868.097178933908, 706.1702499562992, 842.616609442702, 861.5519929636586, 862.9482231066094, 865.7835541114721, 634.0141080619635, 634.1629049654458, 634.5304474688697, 634.685830513894, 635.5360586771636, 15269.160196189205, 15283.0, 15299.15854627995, 15304.617384565363, 15320.0, 14523.491677791333, 14885.851141488554, 14922.477713280092, 14930.178840163786, 15031.398744050224, 13622.727545449035, 13785.448582056706, 13786.93106534471, 13949.721005579933, 13992.930035349758, 4551.817927282905, 4646.930296045562, 4725.66920315578, 4738.952610473885, 4750.809967601292, 77321.0, 77701.22298777052, 78178.21821781823, 78352.60823695901, 79422.8086578696, 11663.0, 11669.941650291694, 11684.118500268383, 11969.281843089442, 12047.27716337005, 22132.446688832584, 22169.0, 22190.0, 22209.1116355344, 22215.77784222137, 8335.083140854622, 8756.124387561193, 8814.691485797966, 8845.557722113868, 8866.512341821133, 4935.012997400462, 4949.529794669501, 4993.101241776515, 5021.6735912165595, 5037.748112594429, 3187.2350635847693, 3304.074859039473, 3314.171457135716, 3315.336932613487, 3317.7179939705397, 609.8048624440137, 621.7544070092288, 627.9937200628027, 637.4263163153199, 637.7895294552786, 641.1312671330373, 660.2572106380322, 660.2769966886252, 683.8119517132728, 690.7133539581118, 9201.0, 9236.07639236071, 9238.168564829197, 9467.52662366879, 9498.0, 658.8978708300222, 669.3201845581127, 685.873113474009, 703.9260877607879, 725.4740313272835, 4218.2196293685765, 4428.756418397019, 4489.461264648197, 4491.910161796745, 4532.32015197723, 71487.48968930416, 72658.2734172662, 100808.49595752121, 104335.0, 104974.4751276254, 88786.55606721925, 88893.55553222322, 91788.0, 101638.0, 103477.48261258796, 80322.59838700769, 87269.0, 88662.0, 91236.0, 92498.53750731204, 9955.20358371343, 10083.848742269018, 10682.198835087554, 10749.946250268698, 10764.946175269073, 44782.3282650754, 52457.7377113112, 52930.735346323025, 53801.46198538121, 54001.0, 72864.0, 81205.18794811977, 81253.0, 82470.0, 85343.0, 13656.0, 13823.79264311016, 13995.440182392591, 14067.226302553458, 14208.78686819678, 15702.0, 15910.204489775697, 16050.438234661731, 16057.437989670305, 16175.0, 12537.623871283877, 13009.089363744448, 13748.65628359299, 14141.929290353894, 14998.400063997318, 13945.511907083204, 14834.184119873511, 15302.387904483696, 15394.538163855103, 15420.0, 14418.423263069779, 15044.247787610795, 15525.534233973, 15604.921975390505, 15661.0, 11812.0, 12412.62762117138, 12452.501899924264, 12784.360781960679, 12814.743705126031, 11306.434678266218, 11659.708507287385, 11762.411879405825, 11930.463129159036, 11973.461194246105], "value": 7727.196605511635, "unit": "score"}], "name": "dromaeo_css", "value": 7259.750801431531, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 111.0, 110.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 118.0, 169.0, 122.0, 125.0, 137.0, 119.0, 145.0, 119.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 159.0, 159.0, 160.0, 160.0, 160.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 123.0, 76.0, 76.0, 74.0, 74.0, 101.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 127.0, 84.0, 83.0, 89.0, 113.0, 85.0, 84.0, 122.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 50.0, 50.0, 51.0, 51.0, 50.0, 49.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 83.0, 74.0, 82.0, 74.0, 83.0, 74.0, 74.0, 74.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 118.0, 118.0, 116.0, 117.0, 128.0, 120.0, 170.0, 134.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 164.0, 160.0, 156.0, 159.0, 153.0, 155.0, 153.0, 160.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 61.0, 60.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1475.5, "alertThreshold": 2.0}]} 23:53:09 INFO - Return code: 0 23:53:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:53:09 INFO - # TBPL SUCCESS # 23:53:09 INFO - Running post-action listener: _resource_record_post_action 23:53:09 INFO - ##### 23:53:09 INFO - ##### Finished run-tests step (success) 23:53:09 INFO - ##### 23:53:09 INFO - Running post-run listener: _resource_record_post_run 23:53:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557199360; Read time: 4; Write time: 1185752 23:53:09 INFO - TinderboxPrint: CPU usage
13.0% 23:53:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 23:53:09 INFO - TinderboxPrint: I/O write bytes / time
557,199,360 / 1,185,752 23:53:09 INFO - TinderboxPrint: CPU idle
8,281.2 (87.0%) 23:53:09 INFO - TinderboxPrint: CPU user
1,190.1 (12.5%) 23:53:09 INFO - TinderboxPrint: Swap in / out
0 / 0 23:53:09 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 258134016; Read time: 0; Write time: 827564 23:53:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 299065344; Read time: 0; Write time: 358188 23:53:09 INFO - Running post-run listener: _upload_blobber_files 23:53:09 INFO - Blob upload gear active. 23:53:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:53:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:53:10 INFO - (blobuploader) - INFO - Open directory for files ... 23:53:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:53:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:17 INFO - (blobuploader) - INFO - Done attempting. 23:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:18 INFO - (blobuploader) - INFO - Done attempting. 23:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:18 INFO - (blobuploader) - INFO - Done attempting. 23:53:18 INFO - (blobuploader) - INFO - Iteration through files over. 23:53:18 INFO - Return code: 0 23:53:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:53:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:53:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cee735ec8cbc2e3be0644e8535651ba1dcc4f25c21149055ada73e886479ec23c8eee699130825414a9cc44971a5562973380f361676d65e1ac1ff59f2dac6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1e951a9b6968314b4a7b722cec2f4c4f8264aa4336e0196838b55ae9b947072eb7ecd17dab9ec7c69da0b424ce2c037bc8eec8e250a0bc28ab1dd9904d87a28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a1168abd1f7e8bb3c580cd2129abf3f08672a28a0342b2cafc39ba24428be2b102f301f4d11c841315778b24043beb32a348cdc62c384c91b68b8f4c5ed350"} 23:53:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:53:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:53:18 INFO - Contents: 23:53:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cee735ec8cbc2e3be0644e8535651ba1dcc4f25c21149055ada73e886479ec23c8eee699130825414a9cc44971a5562973380f361676d65e1ac1ff59f2dac6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1e951a9b6968314b4a7b722cec2f4c4f8264aa4336e0196838b55ae9b947072eb7ecd17dab9ec7c69da0b424ce2c037bc8eec8e250a0bc28ab1dd9904d87a28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a1168abd1f7e8bb3c580cd2129abf3f08672a28a0342b2cafc39ba24428be2b102f301f4d11c841315778b24043beb32a348cdc62c384c91b68b8f4c5ed350"} 23:53:18 INFO - Running post-run listener: copy_logs_to_upload_dir 23:53:18 INFO - Copying logs to upload dir... 23:53:18 INFO - mkdir: /builds/slave/test/build/upload/logs 23:53:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.458654 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-18 23:53:18.809639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:53:18.813890) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cee735ec8cbc2e3be0644e8535651ba1dcc4f25c21149055ada73e886479ec23c8eee699130825414a9cc44971a5562973380f361676d65e1ac1ff59f2dac6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1e951a9b6968314b4a7b722cec2f4c4f8264aa4336e0196838b55ae9b947072eb7ecd17dab9ec7c69da0b424ce2c037bc8eec8e250a0bc28ab1dd9904d87a28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a1168abd1f7e8bb3c580cd2129abf3f08672a28a0342b2cafc39ba24428be2b102f301f4d11c841315778b24043beb32a348cdc62c384c91b68b8f4c5ed350"} build_url:https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cee735ec8cbc2e3be0644e8535651ba1dcc4f25c21149055ada73e886479ec23c8eee699130825414a9cc44971a5562973380f361676d65e1ac1ff59f2dac6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1e951a9b6968314b4a7b722cec2f4c4f8264aa4336e0196838b55ae9b947072eb7ecd17dab9ec7c69da0b424ce2c037bc8eec8e250a0bc28ab1dd9904d87a28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a1168abd1f7e8bb3c580cd2129abf3f08672a28a0342b2cafc39ba24428be2b102f301f4d11c841315778b24043beb32a348cdc62c384c91b68b8f4c5ed350"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:53:18.845530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:53:18.846039) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468909961.803407-1601899111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:53:18.931798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:53:18.932351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:53:18.932855) ========= ========= Total master_lag: 0.18 =========