builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1468930623.62 results: success (0) buildid: 20160719023024 builduid: dda9f9c189dc45ec83bb6b67c0e400d8 revision: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.617689) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.618159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.618447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.634019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.634409) ========= 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=923d835db2ba3686ebe126b700000192-1468927050.351699-162231268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 05:17:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.1M=0s 2016-07-19 05:17:04 (34.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.729104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.729430) ========= 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=923d835db2ba3686ebe126b700000192-1468927050.351699-162231268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018552 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:03.780783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 05:17:03.781118) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5a2837e3fed3cfdf6be39fa756e3be7e1257190 --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 a5a2837e3fed3cfdf6be39fa756e3be7e1257190 --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=923d835db2ba3686ebe126b700000192-1468927050.351699-162231268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 05:17:04,242 truncating revision to first 12 chars 2016-07-19 05:17:04,242 Setting DEBUG logging. 2016-07-19 05:17:04,242 attempt 1/10 2016-07-19 05:17:04,242 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5a2837e3fed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 05:17:05,514 unpacking tar archive at: fx-team-a5a2837e3fed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.597752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 05:17:05.392548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:05.392900) ========= script_repo_revision: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:05.393363) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:05.393650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 05:17:05.404769) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-19 05:17:05.405366) ========= /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=923d835db2ba3686ebe126b700000192-1468927050.351699-162231268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:05 INFO - MultiFileLogger online at 20160719 05:17:05 in /builds/slave/test 05:17:05 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 05:17:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:05 INFO - {'append_to_log': False, 05:17:05 INFO - 'base_work_dir': '/builds/slave/test', 05:17:05 INFO - 'blob_upload_branch': 'Fx-Team', 05:17:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:05 INFO - 'branch': 'Fx-Team', 05:17:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:05 INFO - 'config_files': ('talos/linux_config.py',), 05:17:05 INFO - 'default_actions': ('clobber', 05:17:05 INFO - 'read-buildbot-config', 05:17:05 INFO - 'download-and-extract', 05:17:05 INFO - 'populate-webroot', 05:17:05 INFO - 'create-virtualenv', 05:17:05 INFO - 'install', 05:17:05 INFO - 'run-tests'), 05:17:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:05 INFO - 'download_minidump_stackwalk': True, 05:17:05 INFO - 'download_symbols': 'ondemand', 05:17:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:05 INFO - 'installer_path': 'installer.exe', 05:17:05 INFO - 'log_level': 'info', 05:17:05 INFO - 'log_name': 'talos', 05:17:05 INFO - 'log_to_console': True, 05:17:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:05 INFO - 'opt_config_files': (), 05:17:05 INFO - 'pip_index': False, 05:17:05 INFO - 'sps_profile': False, 05:17:05 INFO - 'sps_profile_interval': 0, 05:17:05 INFO - 'suite': 'dromaeojs', 05:17:05 INFO - 'system_bits': '32', 05:17:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:05 INFO - 'title': 'talos-linux64-ix-007', 05:17:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:05 INFO - 'use_talos_json': True, 05:17:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:05 INFO - 'work_dir': 'build'} 05:17:05 INFO - ##### 05:17:05 INFO - ##### Running clobber step. 05:17:05 INFO - ##### 05:17:05 INFO - Running pre-action listener: _resource_record_pre_action 05:17:05 INFO - Running main action method: clobber 05:17:05 INFO - rmtree: /builds/slave/test/build 05:17:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:07 INFO - Running post-action listener: _resource_record_post_action 05:17:07 INFO - ##### 05:17:07 INFO - ##### Finished clobber step (success) 05:17:07 INFO - ##### 05:17:07 INFO - ##### 05:17:07 INFO - ##### Running read-buildbot-config step. 05:17:07 INFO - ##### 05:17:07 INFO - Running pre-action listener: _resource_record_pre_action 05:17:07 INFO - Running main action method: read_buildbot_config 05:17:07 INFO - Using buildbot properties: 05:17:07 INFO - { 05:17:07 INFO - "project": "", 05:17:07 INFO - "product": "firefox", 05:17:07 INFO - "script_repo_revision": "production", 05:17:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:17:07 INFO - "repository": "", 05:17:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:17:07 INFO - "buildid": "20160719023024", 05:17:07 INFO - "pgo_build": "True", 05:17:07 INFO - "basedir": "/builds/slave/test", 05:17:07 INFO - "buildnumber": 300, 05:17:07 INFO - "slavename": "talos-linux64-ix-007", 05:17:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:17:07 INFO - "platform": "ubuntu64_hw", 05:17:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:17:07 INFO - "branch": "fx-team", 05:17:07 INFO - "repo_path": "integration/fx-team", 05:17:07 INFO - "revision": "a5a2837e3fed3cfdf6be39fa756e3be7e1257190", 05:17:07 INFO - "stage_platform": "linux64-pgo", 05:17:07 INFO - "builduid": "dda9f9c189dc45ec83bb6b67c0e400d8", 05:17:07 INFO - "slavebuilddir": "test" 05:17:07 INFO - } 05:17:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:17:07 INFO - Running post-action listener: _resource_record_post_action 05:17:07 INFO - ##### 05:17:07 INFO - ##### Finished read-buildbot-config step (success) 05:17:07 INFO - ##### 05:17:07 INFO - ##### 05:17:07 INFO - ##### Running download-and-extract step. 05:17:07 INFO - ##### 05:17:07 INFO - Running pre-action listener: _resource_record_pre_action 05:17:07 INFO - Running main action method: download_and_extract 05:17:07 INFO - mkdir: /builds/slave/test/build/tests 05:17:07 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')]} 05:17:07 INFO - https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:08 INFO - Downloaded 1361 bytes. 05:17:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:08 INFO - Using the following test package requirements: 05:17:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:17:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:17:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:17:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'jsshell-linux-x86_64.zip'], 05:17:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:17:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:17:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:17:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:17:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:17:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:17:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:17: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')]} 05:17:08 INFO - https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:10 INFO - Downloaded 24333743 bytes. 05:17:10 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'] 05:17:10 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 05:17:11 INFO - Return code: 0 05:17:11 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 05:17: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')]} 05:17:11 INFO - https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:23 INFO - Downloaded 24333743 bytes. 05:17:23 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'] 05:17:23 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 05:17:24 INFO - Return code: 0 05:17:24 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')]} 05:17:24 INFO - https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:17:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:26 INFO - Downloaded 14403317 bytes. 05:17:26 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'] 05:17:26 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 05:17:26 INFO - Return code: 0 05:17:26 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')]} 05:17:26 INFO - https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSDEuFMTQdeskTAOq7psgg/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 05:17:27 INFO - Downloaded 60837054 bytes. 05:17:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:27 INFO - mkdir: /builds/slave/test/properties 05:17:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:27 INFO - Contents: 05:17:27 INFO - build_url:https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:28 INFO - Running post-action listener: _resource_record_post_action 05:17:28 INFO - Running post-action listener: set_extra_try_arguments 05:17:28 INFO - ##### 05:17:28 INFO - ##### Finished download-and-extract step (success) 05:17:28 INFO - ##### 05:17:28 INFO - ##### 05:17:28 INFO - ##### Running populate-webroot step. 05:17:28 INFO - ##### 05:17:28 INFO - Running pre-action listener: _resource_record_pre_action 05:17:28 INFO - Running main action method: populate_webroot 05:17:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:28 INFO - '--tppagecycles', 05:17:28 INFO - '7'], 05:17:28 INFO - 'tests': ['tsvgm']}}, 05:17:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['damp', 'tps']}, 05:17:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'tests': ['damp', 'tps']}, 05:17:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['dromaeo_dom']}, 05:17:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['basic_compositor_video']}, 05:17:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:17:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['a11yr', 05:17:28 INFO - 'ts_paint', 05:17:28 INFO - 'tpaint', 05:17:28 INFO - 'sessionrestore', 05:17:28 INFO - 'sessionrestore_no_auto_restore', 05:17:28 INFO - 'tabpaint']}, 05:17:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:28 INFO - 'ts_paint', 05:17:28 INFO - 'tpaint', 05:17:28 INFO - 'sessionrestore', 05:17:28 INFO - 'sessionrestore_no_auto_restore', 05:17:28 INFO - 'tabpaint']}, 05:17:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:28 INFO - 'ts_paint', 05:17:28 INFO - 'tpaint', 05:17:28 INFO - 'sessionrestore', 05:17:28 INFO - 'sessionrestore_no_auto_restore', 05:17:28 INFO - 'tabpaint']}, 05:17:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:28 INFO - 'ts_paint', 05:17:28 INFO - 'tpaint', 05:17:28 INFO - 'sessionrestore', 05:17:28 INFO - 'sessionrestore_no_auto_restore', 05:17:28 INFO - 'tabpaint']}, 05:17:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['a11yr', 05:17:28 INFO - 'ts_paint', 05:17:28 INFO - 'tpaint', 05:17:28 INFO - 'sessionrestore', 05:17:28 INFO - 'sessionrestore_no_auto_restore', 05:17:28 INFO - 'tabpaint']}, 05:17:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['a11yr', 05:17:28 INFO - 'ts_paint', 05:17:28 INFO - 'tpaint', 05:17:28 INFO - 'sessionrestore', 05:17:28 INFO - 'sessionrestore_no_auto_restore', 05:17:28 INFO - 'tabpaint']}, 05:17:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['tsvgx', 05:17:28 INFO - 'tsvgr_opacity', 05:17:28 INFO - 'tart', 05:17:28 INFO - 'tscrollx', 05:17:28 INFO - 'cart']}, 05:17:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:28 INFO - 'tsvgr_opacity', 05:17:28 INFO - 'tart', 05:17:28 INFO - 'tscrollx', 05:17:28 INFO - 'cart']}, 05:17:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'talos_options': ['--disable-e10s'], 05:17:28 INFO - 'tests': ['tp5o']}, 05:17:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'tests': ['tp5o']}, 05:17:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'talos_options': ['--disable-e10s', 05:17:28 INFO - '--xperf_path', 05:17:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:28 INFO - 'tests': ['tp5n']}, 05:17:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:28 INFO - 'talos_options': ['--xperf_path', 05:17:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:28 INFO - 'tests': ['tp5n']}}, 05:17:28 INFO - 'talos.zip': {'path': '', 05:17:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:28 INFO - Running post-action listener: _resource_record_post_action 05:17:28 INFO - ##### 05:17:28 INFO - ##### Finished populate-webroot step (success) 05:17:28 INFO - ##### 05:17:28 INFO - ##### 05:17:28 INFO - ##### Running create-virtualenv step. 05:17:28 INFO - ##### 05:17:28 INFO - Running pre-action listener: _resource_record_pre_action 05:17:28 INFO - Running main action method: create_virtualenv 05:17:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:28 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 05:17:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:28 INFO - Using real prefix '/usr' 05:17:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:31 INFO - Installing pip.................done. 05:17:31 INFO - Return code: 0 05:17:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:31 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')]} 05:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:31 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')]} 05:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:31 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:31 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 05:17:31 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 05:17:31 INFO - Using env: {'DISPLAY': ':0', 05:17:31 INFO - 'HOME': '/home/cltbld', 05:17:31 INFO - 'LANG': 'en_US.UTF-8', 05:17:31 INFO - 'LANGUAGE': 'en_US:en', 05:17:31 INFO - 'LOGNAME': 'cltbld', 05:17:31 INFO - 'MAIL': '/var/mail/cltbld', 05:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:31 INFO - 'MOZ_NO_REMOTE': '1', 05:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:31 INFO - 'NO_EM_RESTART': '1', 05:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:31 INFO - 'PWD': '/builds/slave/test', 05:17:31 INFO - 'SHELL': '/bin/bash', 05:17:31 INFO - 'SHLVL': '1', 05:17:31 INFO - 'TERM': 'linux', 05:17:31 INFO - 'TMOUT': '86400', 05:17:31 INFO - 'USER': 'cltbld', 05:17:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:31 INFO - '_': '/tools/buildbot/bin/python'} 05:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:31 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 05:17:31 INFO - Cleaning up... 05:17:31 INFO - Return code: 0 05:17:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17:31 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')]} 05:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:31 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')]} 05:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:31 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:31 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 05:17:31 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 05:17:31 INFO - Using env: {'DISPLAY': ':0', 05:17:31 INFO - 'HOME': '/home/cltbld', 05:17:31 INFO - 'LANG': 'en_US.UTF-8', 05:17:31 INFO - 'LANGUAGE': 'en_US:en', 05:17:31 INFO - 'LOGNAME': 'cltbld', 05:17:31 INFO - 'MAIL': '/var/mail/cltbld', 05:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:31 INFO - 'MOZ_NO_REMOTE': '1', 05:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:31 INFO - 'NO_EM_RESTART': '1', 05:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:31 INFO - 'PWD': '/builds/slave/test', 05:17:31 INFO - 'SHELL': '/bin/bash', 05:17:31 INFO - 'SHLVL': '1', 05:17:31 INFO - 'TERM': 'linux', 05:17:31 INFO - 'TMOUT': '86400', 05:17:31 INFO - 'USER': 'cltbld', 05:17:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:31 INFO - '_': '/tools/buildbot/bin/python'} 05:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:31 INFO - Downloading/unpacking psutil>=3.1.1 05:17:31 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 05:17:31 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 05:17:31 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 05:17:31 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 05:17:31 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 05:17:31 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 05:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:33 INFO - Installing collected packages: psutil 05:17:33 INFO - Running setup.py install for psutil 05:17:33 INFO - building 'psutil._psutil_linux' extension 05:17:33 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 05:17:33 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 05:17:33 INFO - building 'psutil._psutil_posix' extension 05:17:33 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 05:17:33 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 05:17:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:33 INFO - Successfully installed psutil 05:17:33 INFO - Cleaning up... 05:17:34 INFO - Return code: 0 05:17:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17:34 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')]} 05:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:34 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')]} 05:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:34 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:34 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 05:17:34 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 05:17:34 INFO - Using env: {'DISPLAY': ':0', 05:17:34 INFO - 'HOME': '/home/cltbld', 05:17:34 INFO - 'LANG': 'en_US.UTF-8', 05:17:34 INFO - 'LANGUAGE': 'en_US:en', 05:17:34 INFO - 'LOGNAME': 'cltbld', 05:17:34 INFO - 'MAIL': '/var/mail/cltbld', 05:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:34 INFO - 'MOZ_NO_REMOTE': '1', 05:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:34 INFO - 'NO_EM_RESTART': '1', 05:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:34 INFO - 'PWD': '/builds/slave/test', 05:17:34 INFO - 'SHELL': '/bin/bash', 05:17:34 INFO - 'SHLVL': '1', 05:17:34 INFO - 'TERM': 'linux', 05:17:34 INFO - 'TMOUT': '86400', 05:17:34 INFO - 'USER': 'cltbld', 05:17:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:34 INFO - '_': '/tools/buildbot/bin/python'} 05:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:34 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 05:17:34 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 05:17:34 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 05:17:34 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 05:17:34 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 05:17:34 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 05:17:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:36 INFO - Installing collected packages: mozsystemmonitor 05:17:36 INFO - Running setup.py install for mozsystemmonitor 05:17:36 INFO - Successfully installed mozsystemmonitor 05:17:36 INFO - Cleaning up... 05:17:36 INFO - Return code: 0 05:17:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17:36 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')]} 05:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:36 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')]} 05:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:36 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:36 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 05:17:36 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 05:17:36 INFO - Using env: {'DISPLAY': ':0', 05:17:36 INFO - 'HOME': '/home/cltbld', 05:17:36 INFO - 'LANG': 'en_US.UTF-8', 05:17:36 INFO - 'LANGUAGE': 'en_US:en', 05:17:36 INFO - 'LOGNAME': 'cltbld', 05:17:36 INFO - 'MAIL': '/var/mail/cltbld', 05:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:36 INFO - 'MOZ_NO_REMOTE': '1', 05:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:36 INFO - 'NO_EM_RESTART': '1', 05:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:36 INFO - 'PWD': '/builds/slave/test', 05:17:36 INFO - 'SHELL': '/bin/bash', 05:17:36 INFO - 'SHLVL': '1', 05:17:36 INFO - 'TERM': 'linux', 05:17:36 INFO - 'TMOUT': '86400', 05:17:36 INFO - 'USER': 'cltbld', 05:17:36 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:36 INFO - '_': '/tools/buildbot/bin/python'} 05:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:36 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 05:17:36 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 05:17:36 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 05:17:36 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 05:17:36 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 05:17:36 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 05:17:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:38 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 05:17:38 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 05:17:38 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 05:17:38 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 05:17:38 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 05:17:38 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 05:17:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:38 INFO - warning: no files found matching '*.txt' 05:17:38 INFO - no previously-included directories found matching 'build' 05:17:38 INFO - no previously-included directories found matching 'dist' 05:17:38 INFO - no previously-included directories found matching '.git*' 05:17:38 INFO - Installing collected packages: jsonschema, functools32 05:17:38 INFO - Running setup.py install for functools32 05:17:38 INFO - warning: no files found matching '*.txt' 05:17:38 INFO - no previously-included directories found matching 'build' 05:17:38 INFO - no previously-included directories found matching 'dist' 05:17:38 INFO - no previously-included directories found matching '.git*' 05:17:38 INFO - Successfully installed jsonschema functools32 05:17:38 INFO - Cleaning up... 05:17:38 INFO - Return code: 0 05:17:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:38 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')]} 05:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 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')]} 05:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:38 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 05:17:38 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 05:17:38 INFO - Using env: {'DISPLAY': ':0', 05:17:38 INFO - 'HOME': '/home/cltbld', 05:17:38 INFO - 'LANG': 'en_US.UTF-8', 05:17:38 INFO - 'LANGUAGE': 'en_US:en', 05:17:38 INFO - 'LOGNAME': 'cltbld', 05:17:38 INFO - 'MAIL': '/var/mail/cltbld', 05:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:38 INFO - 'MOZ_NO_REMOTE': '1', 05:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:38 INFO - 'NO_EM_RESTART': '1', 05:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:38 INFO - 'PWD': '/builds/slave/test', 05:17:38 INFO - 'SHELL': '/bin/bash', 05:17:38 INFO - 'SHLVL': '1', 05:17:38 INFO - 'TERM': 'linux', 05:17:38 INFO - 'TMOUT': '86400', 05:17:38 INFO - 'USER': 'cltbld', 05:17:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:38 INFO - '_': '/tools/buildbot/bin/python'} 05:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:39 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 05:17:39 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 05:17:39 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 05:17:39 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 05:17:39 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 05:17:39 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 05:17:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 INFO - Downloading docopt-0.6.1.tar.gz 05:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:41 INFO - Running setup.py install for blobuploader 05:17:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:41 INFO - Running setup.py install for requests 05:17:42 INFO - Running setup.py install for docopt 05:17:42 INFO - Successfully installed blobuploader requests docopt 05:17:42 INFO - Cleaning up... 05:17:42 INFO - Return code: 0 05:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:42 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')]} 05:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:42 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')]} 05:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:42 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:42 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 05:17:42 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 05:17:42 INFO - Using env: {'DISPLAY': ':0', 05:17:42 INFO - 'HOME': '/home/cltbld', 05:17:42 INFO - 'LANG': 'en_US.UTF-8', 05:17:42 INFO - 'LANGUAGE': 'en_US:en', 05:17:42 INFO - 'LOGNAME': 'cltbld', 05:17:42 INFO - 'MAIL': '/var/mail/cltbld', 05:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:42 INFO - 'MOZ_NO_REMOTE': '1', 05:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:42 INFO - 'NO_EM_RESTART': '1', 05:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:42 INFO - 'PWD': '/builds/slave/test', 05:17:42 INFO - 'SHELL': '/bin/bash', 05:17:42 INFO - 'SHLVL': '1', 05:17:42 INFO - 'TERM': 'linux', 05:17:42 INFO - 'TMOUT': '86400', 05:17:42 INFO - 'USER': 'cltbld', 05:17:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:42 INFO - '_': '/tools/buildbot/bin/python'} 05:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:42 INFO - Running setup.py (path:/tmp/pip-kNFXm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:42 INFO - Running setup.py (path:/tmp/pip-wxhzjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:42 INFO - Running setup.py (path:/tmp/pip-be2cLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:42 INFO - Running setup.py (path:/tmp/pip-ubyVF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:42 INFO - Running setup.py (path:/tmp/pip-2u9qE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:43 INFO - Running setup.py (path:/tmp/pip-o97Bfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:43 INFO - Running setup.py (path:/tmp/pip-uMOr4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:43 INFO - Running setup.py (path:/tmp/pip-29R9uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:43 INFO - Running setup.py (path:/tmp/pip-10Z6jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:43 INFO - Running setup.py (path:/tmp/pip-IU87cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:43 INFO - Running setup.py (path:/tmp/pip-7HoSIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:43 INFO - Running setup.py (path:/tmp/pip-1yeQTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:43 INFO - Running setup.py (path:/tmp/pip-B8cXCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:43 INFO - Running setup.py (path:/tmp/pip-2F75wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:43 INFO - Running setup.py (path:/tmp/pip-tarj_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:43 INFO - Running setup.py (path:/tmp/pip-FxAVn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:43 INFO - Running setup.py (path:/tmp/pip-j1F09Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:43 INFO - Running setup.py install for manifestparser 05:17:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:43 INFO - Running setup.py install for mozcrash 05:17:44 INFO - Running setup.py install for mozdebug 05:17:44 INFO - Running setup.py install for mozdevice 05:17:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Running setup.py install for mozfile 05:17:44 INFO - Running setup.py install for mozhttpd 05:17:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Running setup.py install for mozinfo 05:17:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Running setup.py install for mozInstall 05:17:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Running setup.py install for mozleak 05:17:44 INFO - Running setup.py install for mozlog 05:17:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:44 INFO - Running setup.py install for moznetwork 05:17:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:45 INFO - Running setup.py install for mozprocess 05:17:45 INFO - Running setup.py install for mozprofile 05:17:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:45 INFO - Running setup.py install for mozrunner 05:17:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:45 INFO - Running setup.py install for mozscreenshot 05:17:45 INFO - Running setup.py install for moztest 05:17:45 INFO - Running setup.py install for mozversion 05:17:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:45 INFO - Cleaning up... 05:17:45 INFO - Return code: 0 05:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:45 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 05:17:45 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 05:17:45 INFO - Using env: {'DISPLAY': ':0', 05:17:45 INFO - 'HOME': '/home/cltbld', 05:17:45 INFO - 'LANG': 'en_US.UTF-8', 05:17:45 INFO - 'LANGUAGE': 'en_US:en', 05:17:45 INFO - 'LOGNAME': 'cltbld', 05:17:45 INFO - 'MAIL': '/var/mail/cltbld', 05:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:45 INFO - 'MOZ_NO_REMOTE': '1', 05:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:45 INFO - 'NO_EM_RESTART': '1', 05:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:45 INFO - 'PWD': '/builds/slave/test', 05:17:45 INFO - 'SHELL': '/bin/bash', 05:17:45 INFO - 'SHLVL': '1', 05:17:45 INFO - 'TERM': 'linux', 05:17:45 INFO - 'TMOUT': '86400', 05:17:45 INFO - 'USER': 'cltbld', 05:17:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:45 INFO - '_': '/tools/buildbot/bin/python'} 05:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:45 INFO - Running setup.py (path:/tmp/pip-FfTYhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:45 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)) 05:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:45 INFO - Running setup.py (path:/tmp/pip-7NAHpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:46 INFO - Running setup.py (path:/tmp/pip-cnSY2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:46 INFO - Running setup.py (path:/tmp/pip-nJ3WUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:46 INFO - Running setup.py (path:/tmp/pip-tUgFhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:46 INFO - Running setup.py (path:/tmp/pip-4TKnDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:46 INFO - Running setup.py (path:/tmp/pip-JaloW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:46 INFO - Running setup.py (path:/tmp/pip-OUBmFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:46 INFO - Running setup.py (path:/tmp/pip-Zir1H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:46 INFO - Running setup.py (path:/tmp/pip-uGb2YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:46 INFO - Running setup.py (path:/tmp/pip-m31zdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:46 INFO - Running setup.py (path:/tmp/pip-WOA7av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:46 INFO - Running setup.py (path:/tmp/pip-R8FP0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:46 INFO - Running setup.py (path:/tmp/pip-qwzJ8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:46 INFO - Running setup.py (path:/tmp/pip-84QUZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:46 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)) 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:46 INFO - Running setup.py (path:/tmp/pip-4pbwqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:47 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)) 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:47 INFO - Running setup.py (path:/tmp/pip-6s8eKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:47 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)) 05:17:47 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)) 05:17:47 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)) 05:17:47 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)) 05:17:47 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)) 05:17:47 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)) 05:17:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:47 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 05:17:47 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 05:17:47 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 05:17:47 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 05:17:47 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 05:17:47 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 05:17:49 INFO - Downloading blessings-1.6.tar.gz 05:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:49 INFO - Installing collected packages: blessings 05:17:49 INFO - Running setup.py install for blessings 05:17:49 INFO - Successfully installed blessings 05:17:49 INFO - Cleaning up... 05:17:49 INFO - Return code: 0 05:17:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:49 INFO - Reading from file tmpfile_stdout 05:17:49 INFO - Current package versions: 05:17:49 INFO - argparse == 1.2.1 05:17:49 INFO - blessings == 1.6 05:17:49 INFO - blobuploader == 1.2.4 05:17:49 INFO - docopt == 0.6.1 05:17:49 INFO - functools32 == 3.2.3-2 05:17:49 INFO - jsonschema == 2.5.1 05:17:49 INFO - manifestparser == 1.1 05:17:49 INFO - mozInstall == 1.12 05:17:49 INFO - mozcrash == 0.17 05:17:49 INFO - mozdebug == 0.1 05:17:49 INFO - mozdevice == 0.48 05:17:49 INFO - mozfile == 1.2 05:17:49 INFO - mozhttpd == 0.7 05:17:49 INFO - mozinfo == 0.9 05:17:49 INFO - mozleak == 0.1 05:17:49 INFO - mozlog == 3.2 05:17:49 INFO - moznetwork == 0.27 05:17:49 INFO - mozprocess == 0.23 05:17:49 INFO - mozprofile == 0.28 05:17:49 INFO - mozrunner == 6.12 05:17:49 INFO - mozscreenshot == 0.1 05:17:49 INFO - mozsystemmonitor == 0.3 05:17:49 INFO - moztest == 0.7 05:17:49 INFO - mozversion == 1.4 05:17:49 INFO - psutil == 3.1.1 05:17:49 INFO - requests == 1.2.3 05:17:49 INFO - wsgiref == 0.1.2 05:17:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:49 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')]} 05:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:49 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')]} 05:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:49 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:49 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 05:17:49 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 05:17:49 INFO - Using env: {'DISPLAY': ':0', 05:17:49 INFO - 'HOME': '/home/cltbld', 05:17:49 INFO - 'LANG': 'en_US.UTF-8', 05:17:49 INFO - 'LANGUAGE': 'en_US:en', 05:17:49 INFO - 'LOGNAME': 'cltbld', 05:17:49 INFO - 'MAIL': '/var/mail/cltbld', 05:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:49 INFO - 'MOZ_NO_REMOTE': '1', 05:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:49 INFO - 'NO_EM_RESTART': '1', 05:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:49 INFO - 'PWD': '/builds/slave/test', 05:17:49 INFO - 'SHELL': '/bin/bash', 05:17:49 INFO - 'SHLVL': '1', 05:17:49 INFO - 'TERM': 'linux', 05:17:49 INFO - 'TMOUT': '86400', 05:17:49 INFO - 'USER': 'cltbld', 05:17:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:49 INFO - '_': '/tools/buildbot/bin/python'} 05:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 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)) 05:17:49 INFO - Cleaning up... 05:17:49 INFO - Return code: 0 05:17:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:49 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')]} 05:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:49 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')]} 05:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:49 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 0x1885030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b46180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, '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': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', '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 05:17:49 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 05:17:49 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 05:17:49 INFO - Using env: {'DISPLAY': ':0', 05:17:49 INFO - 'HOME': '/home/cltbld', 05:17:49 INFO - 'LANG': 'en_US.UTF-8', 05:17:49 INFO - 'LANGUAGE': 'en_US:en', 05:17:49 INFO - 'LOGNAME': 'cltbld', 05:17:49 INFO - 'MAIL': '/var/mail/cltbld', 05:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:49 INFO - 'MOZ_NO_REMOTE': '1', 05:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:49 INFO - 'NO_EM_RESTART': '1', 05:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:49 INFO - 'PWD': '/builds/slave/test', 05:17:49 INFO - 'SHELL': '/bin/bash', 05:17:49 INFO - 'SHLVL': '1', 05:17:49 INFO - 'TERM': 'linux', 05:17:49 INFO - 'TMOUT': '86400', 05:17:49 INFO - 'USER': 'cltbld', 05:17:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:49 INFO - '_': '/tools/buildbot/bin/python'} 05:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:49 INFO - Cleaning up... 05:17:49 INFO - Return code: 0 05:17:49 INFO - Running post-action listener: _resource_record_post_action 05:17:49 INFO - Running post-action listener: _start_resource_monitoring 05:17:49 INFO - Starting resource monitoring. 05:17:49 INFO - ##### 05:17:49 INFO - ##### Finished create-virtualenv step (success) 05:17:49 INFO - ##### 05:17:49 INFO - ##### 05:17:49 INFO - ##### Running install step. 05:17:49 INFO - ##### 05:17:49 INFO - Running pre-action listener: _resource_record_pre_action 05:17:49 INFO - Running main action method: install 05:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:50 INFO - Reading from file tmpfile_stdout 05:17:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:50 INFO - Reading from file tmpfile_stdout 05:17:50 INFO - Output received: 05:17:50 INFO - Usage: mozinstall [options] installer 05:17:50 INFO - Options: 05:17:50 INFO - -h, --help show this help message and exit 05:17:50 INFO - -d DEST, --destination=DEST 05:17:50 INFO - Directory to install application into. [default: 05:17:50 INFO - "/builds/slave/test"] 05:17:50 INFO - --app=APP Application being installed. [default: firefox] 05:17:50 INFO - mkdir: /builds/slave/test/build/application 05:17:50 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'] 05:17:50 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 05:18:07 INFO - Reading from file tmpfile_stdout 05:18:07 INFO - Output received: 05:18:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:18:07 INFO - Running post-action listener: _resource_record_post_action 05:18:07 INFO - ##### 05:18:07 INFO - ##### Finished install step (success) 05:18:07 INFO - ##### 05:18:07 INFO - ##### 05:18:07 INFO - ##### Running run-tests step. 05:18:07 INFO - ##### 05:18:07 INFO - Running pre-action listener: _resource_record_pre_action 05:18:07 INFO - Running main action method: run_tests 05:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:07 INFO - Python 2.7.3 05:18:07 INFO - Return code: 0 05:18:07 INFO - grabbing minidump binary from tooltool 05:18:07 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')]} 05:18:07 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 0x1b443b0>, '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 0x1b452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b45740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:07 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 05:18:07 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 05:18:07 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 05:18:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:07 INFO - Return code: 0 05:18:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:18:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:18:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:07 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/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:18:07 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/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 05:18:07 INFO - Using env: {'DISPLAY': ':0', 05:18:07 INFO - 'HOME': '/home/cltbld', 05:18:07 INFO - 'LANG': 'en_US.UTF-8', 05:18:07 INFO - 'LANGUAGE': 'en_US:en', 05:18:07 INFO - 'LOGNAME': 'cltbld', 05:18:07 INFO - 'MAIL': '/var/mail/cltbld', 05:18:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:07 INFO - 'MOZ_NO_REMOTE': '1', 05:18:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:07 INFO - 'NO_EM_RESTART': '1', 05:18:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:07 INFO - 'PWD': '/builds/slave/test', 05:18:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:07 INFO - 'SHELL': '/bin/bash', 05:18:07 INFO - 'SHLVL': '1', 05:18:07 INFO - 'TERM': 'linux', 05:18:07 INFO - 'TMOUT': '86400', 05:18:07 INFO - 'USER': 'cltbld', 05:18:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468927050.351699-162231268', 05:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:07 INFO - '_': '/tools/buildbot/bin/python'} 05:18:07 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/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:18:07 INFO - mozversion application_buildid: 20160719023024 05:18:07 INFO - mozversion application_changeset: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 05:18:07 INFO - mozversion application_display_name: Nightly 05:18:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:07 INFO - mozversion application_name: Firefox 05:18:07 INFO - mozversion application_remotingname: firefox 05:18:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:18:07 INFO - mozversion application_vendor: Mozilla 05:18:07 INFO - mozversion application_version: 50.0a1 05:18:07 INFO - mozversion platform_buildid: 20160719023024 05:18:07 INFO - mozversion platform_changeset: a5a2837e3fed3cfdf6be39fa756e3be7e1257190 05:18:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:18:07 INFO - mozversion platform_version: 50.0a1 05:18:07 INFO - using testdate: 1468930687 05:18:07 INFO - actual date: 1468930687 05:18:07 INFO - starting webserver on 'localhost:43375' 05:18:07 INFO - SUITE-START | Running 2 tests 05:18:07 INFO - TEST-START | dromaeo_css 05:18:07 INFO - operating with platform_type : linux_ 05:18:07 INFO - Initialising browser for dromaeo_css test... 05:18:07 INFO - TEST-INFO | started process 17666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppZAAQU/profile http://localhost:43375/getInfo.html) 05:18:11 INFO - PROCESS | 17666 | __metrics Screen width/height:1600/1200 05:18:11 INFO - PROCESS | 17666 | colorDepth:24 05:18:11 INFO - PROCESS | 17666 | Browser inner width/height: 1024/697 05:18:11 INFO - PROCESS | 17666 | __metrics 05:18:12 INFO - PROCESS | 17666 | 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" 05:18:12 INFO - PROCESS | 17666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:13 INFO - TEST-INFO | 17666: exit 0 05:18:13 INFO - Browser initialized. 05:18:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:13 INFO - TEST-INFO | started process 17748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppZAAQU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:24 INFO - PROCESS | 17748 | RSS: Main: 157982720 05:18:24 INFO - PROCESS | 17748 | 05:19:16 INFO - PROCESS | 17748 | 1468930756417 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] 05:21:24 INFO - PROCESS | 17748 | Cycle 1(1): loaded http://localhost:43375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43375/tests/dromaeo/cssquery-ext.html) 05:21:25 INFO - PROCESS | 17748 | RSS: Main: 253648896 05:21:25 INFO - PROCESS | 17748 | 05:24:27 INFO - PROCESS | 17748 | Cycle 1(1): loaded http://localhost:43375/tests/dromaeo/cssquery-ext.html (next: http://localhost:43375/tests/dromaeo/cssquery-jquery.html) 05:24:28 INFO - PROCESS | 17748 | RSS: Main: 244056064 05:24:28 INFO - PROCESS | 17748 | 05:27:30 INFO - PROCESS | 17748 | Cycle 1(1): loaded http://localhost:43375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43375/tests/dromaeo/cssquery-mootools.html) 05:27:31 INFO - PROCESS | 17748 | RSS: Main: 239124480 05:27:31 INFO - PROCESS | 17748 | 05:30:33 INFO - PROCESS | 17748 | Cycle 1(1): loaded http://localhost:43375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43375/tests/dromaeo/cssquery-prototype.html) 05:30:33 INFO - PROCESS | 17748 | RSS: Main: 235737088 05:30:33 INFO - PROCESS | 17748 | 05:33:36 INFO - PROCESS | 17748 | Cycle 1(1): loaded http://localhost:43375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43375/tests/dromaeo/cssquery-yui.html) 05:33:37 INFO - PROCESS | 17748 | RSS: Main: 228491264 05:33:37 INFO - PROCESS | 17748 | 05:36:39 INFO - PROCESS | 17748 | Cycle 1(1): loaded http://localhost:43375/tests/dromaeo/cssquery-yui.html (next: http://localhost:43375/tests/dromaeo/cssquery-dojo.html) 05:36:40 INFO - PROCESS | 17748 | RSS: Main: 291405824 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | __start_tp_report 05:36:40 INFO - PROCESS | 17748 | _x_x_mozilla_page_load 05:36:40 INFO - PROCESS | 17748 | _x_x_mozilla_page_load_details 05:36:40 INFO - PROCESS | 17748 | |i|pagename|runs| 05:36:40 INFO - PROCESS | 17748 | |0;dojo.html;3039.696030396959;3043.5130379139337;3050.786444948854;3087.984560077202;3097.0399176255364;5217.243499692542;5271.841844744659;5295.020421222067;5383.865403364913;5402.216678581603;5253.6322457428;5268.762905669245;5303.124984377583;5315.601329900253;5329.786808527664;4761.190597598408;4791.760411979404;4870.391201099845;4881.8535443936735;5004.974975125119;4917.50824917509;4929.753512324387;4930.704157750546;4981.427135879366;4999.525045120726;4681.74250416227;4714.033623107255;4714.6464015199;4775.14047471455;4823.324734537167;4813.614910807162;4820.831270905536;4828.5412885775795;4892.412910450733;4939.58013568847;4851.660383773137;4873.366462359906;4874.1713908635265;4874.634402419832;4875.8781030474165;5122.206058061007;5219.634625576211;5229.294045303874;5302.390225124122;5331.573474122061;5650.745716442729;5665.036943719578;5671.914921276143;5699.800506982236;5706.172604972297;5473.151661492475;5700.173474846166;5734.369219385864;5745.683987380692;5752.395998420147;5254.868628284324;5316.574674026068;5323.254744335796;5390.838274851682;5391.326084239509;5880.470757631833;5881.05903055509;5896.262967129109;5903.911441328383;5906;5368.489993450616;5537.529310008614;5542.778288868481;5556.444355564411;5568.969740598002;5672.7730890763905;5715.942840571624;5758.078707406795;5773.191753154561;5776;5686.402927692533;5706.914396284059;5709.914351284651;5711.086226203871;5715.857103572361;5471.23402723619;5560.388357280696;5620.297462817148;5720.599558030898;5729.684867332254;4330.17726631939;4331.220380331571;4352.651787856964;4386.627136693417;4388.539203383662;3877.0888841122314;3890.9416358754643;3891.2606604745006;3927.1752931884052;3931.76409415436;5192.3769147702515;5285.762140703678;5313.628046036741;5349.251104845324;5398.757055932492;5655.802046928337;5665.915011274834;5674.517665998436;5677.886442271131;5725.828225153252;5378.865528361744;5381.031414345455;5382.703951282639;5387.81142660005;5398.217258497496;4848.3454733610515;4867.9269810952865;4873.512648735098;4905.533974272438;4918.680285781413;5841.2990441146485;5844.357120716718;5844.795432159939;5858.50202732764;5864.589478736533;5459.945400545944;5644.915326270027;5663.235463212413;5675.631083979528;5676.489115979582;5747.885042299047;5752.798652047159;5756.798512052058;5804.100364443518;5810.5351571875;5512.972435137959;5557.527610153183;5566.220729097849;5568.916466252928;5569.498745112959;5559.054960656617;5564.749586268708;5663.065594177079;5673.8297851064535;5682.77268909239;5467.6719396836315;5497.39528651856;5510.724463776715;5511.944880551304;5576.0799468088935;5505.862353441196;5508.20131080999;5511.4213007633625;5513.3108361454815;5514.228008078952;5264.10510213257;5351.571874249973;5385.649932754515;5448.809291674773;5482.095454250004;5510.063289240758;5588.273524441796;5592.245046918777;5637.52081073097;5657.066584013592;5407.270018547603;5453.345598528202;5454.727263636723;5458.181272809111;5479.6164268500825 05:36:40 INFO - PROCESS | 17748 | |1;ext.html;597.6533610505907;615.6090882289747;632.433971595422;635.4884318123911;648.9415952564268;32884.67115328846;41906.79046604766;42872.571274287286;42937;43275.78362108185;44792.552074479245;45161.0967780645;45181;45290;45443.77278113613;8119;8244.38167137464;8929.866052009225;9102.59038343273;9133;10497.895021049806;10808.891911080867;10812.189085818594;11120.833187502154;11147.386893720843;10995.175361847894;11097.056750176245;11101.666949991473;11102.222844400896;11103.888961110366;8170.632321545515;10525;10761.354318740901;10766.354018758899;10795.08241799448;10712.73218169552;10766.730831729192;10780.946095269474;10800.135989120852;10809.78380432387;33076.1730956728;42232.366514502304;42536.14927701459;42547.787261063495;42581.36127958083;3537.5931767846514;3830.9808450957844;3940.5862384449506;4084.4485994390675;4233.894152646209;33756.324873502395;34158.82920585381;34295.4855677165;34543.30913381718;34679.13302167441;4294.269974104379;4345.782710864444;4376.5623437656295;4433.756143412111;4484.641228701696;383867;387526;391856;392691;393166;66009.6699516509;66480;66964;66968;67026.66486667634;34009.14977125542;34523.30953380918;69878.65060674664;70281;70294.64852675806;18049.819501805076;18144.909275453538;18159.182836772376;18196.63606727858;18207.08964551767;13783.862161378258;13849.930750346184;13872.791908121386;13876.861231387556;13886.166829990232;21122.788772112388;21246.681299780517;21421.78578214198;21569.460763480725;21726;6425.646589437626;7500.737474188377;7610.9238907611325;7771.72798952034;7936.484128531627;938.1369140390857;960.6973803252093;993.8012397520525;1028.5165971993301;1051.1328154272755;32852.507212391836;33008.504872426936;33175.33649327048;33195.834020830225;33521;1066.3921564708041;1141.4463984967285;1163.87197408285;1238.2756087688622;1259.7606454773563;17125.657486850443;17132.486025419257;17224.397146100076;17296.654066918592;17393;663273;663414;668160;670437;672111;59848;60339.698301508215;60372;60390.39609603935;60409.69795150996;1233.1183204009176;1343.5767733164023;1361.3465536542317;1366.5558693424678;1405.0445696925983;32819.34361312712;34107.65892341045;34278;34342.82828585941;34412.65587344095;49511.752441237564;50317;50375;50460;50467.747661262925;404331;412273;413442;413812;414186;25598.616020760077;28215.71784282131;28533.714662853105;28851.278718032216;30912;48716.75641621769;48734.26898596595;49171.75414122907;49200.75399622979;50454.49545504498;41135;41256;42019.57980420157;42422;43080.784596078076;41219.1756164869;41714.16571668489;42461.36307955445;42478.78760606177;42987.57012429961;40894.591054089076;41768.373474397304;41964.3705344414;42159.578404215565;42357.57642423536;36324;37108.814455927546;37110.25779484341;37867.431988519646;38562.2287554253;25506.23481295564;25972.610410843474;26112.86943565346;26323;26607 05:36:40 INFO - PROCESS | 17748 | |2;jquery.html;385.3487605945949;390.496259824826;395.94060890866376;396.5756640394778;414.8133339997002;13210.097648339108;19021.144048517814;20366.59266814663;20391.388258352254;20854.687179692315;15398.30707618157;18286.17712202951;18926.148323325448;18975.62048759024;19112.61774764504;5627.212190293352;5801.883962320751;5803.796867109652;5803.854903627401;5806.419358064202;5580.91628625571;5626.381098079208;5652.463016013472;5654.604177707542;5668.093105103184;5532.3914369419535;5621;5650.0959846424585;5676.517496012823;5677.744501497422;5360.437154098802;5631.493165615094;5641.605087643867;5648.887022259552;5673.602847800615;5367.919481207785;5538.280023596906;5569.359523654791;5576.581756368289;5581.609287349887;14345.856541434556;14557.199354035523;14588.635284117876;14613.926930365387;15475.535733928;2303.8156947444163;2456.7788898998997;2477.814163937712;2624.973750262492;2760.2823265950997;10123.392596444237;10300.742481438025;10484.161267098614;10629.20280978922;10687.465626718711;1875.606122714218;1879.793222745497;1911.923523059076;1956.5988972260652;1979.990100049505;86683.77558906868;88257.55871220666;89373.99999999935;90463.54768226182;90914.5454272731;10687.198460115522;10943.398113103696;10953.014228719294;11019;11088.65174439924;15237.847621523864;15455;15493.225338733018;15546;15566.299516521784;8310;8325.125861784547;8417.70538031166;8480.448770829877;8482.533460659599;6561.770338038145;8121.959390203011;8130.552819594861;8172.795680107926;8329.08380078191;4416.205083085076;4594.65540084495;4696.178168820443;4750.762461876892;4805.951940480621;1988.6619274723332;2020.40398082566;2043.2439997201132;2055.7122002919605;2065.5455799724036;912.3112050401904;942.769021589715;991.1921783746224;1109.2678831970861;1120.3669926491507;19401;19484.70772938407;19998.300059497848;20010.89994550018;20436.897815510827;943.5706753427174;960.2126256469628;1040.6825918094903;1044.5456226541328;1059.7085801404676;9522.571484283224;10962.890371096188;11078.778424431466;11102.555897764;11120.110391168688;504164;506288;510710;520166;520599;97158.51420742851;99854;100716.49641751891;101068.49465752624;102893.48553257185;965.5944503308627;969.345691658128;986.0238364019713;986.3342243985425;998.3760149906309;17336.826631733522;17573.472795816146;17831.910840445715;17888.373906913195;18132.637347252716;30742.692573073982;33981.15047123842;42411.575884242;42496.78751606222;43230.56769432266;57525.712371437876;58361.4163858356;61802;62729;62964.68517657566;7323.560586364835;7723.9227607723205;8579.184977427134;8585.742427727178;8706.869396959177;12200.328981906081;12348.753024939271;12473.064520161206;12527.248365098123;12786.977041836817;10667.519961601902;10762.677119686421;10866.293690910066;11110.888891110986;11361.659150225507;10751.462426878468;11021.614243501439;11040.558377664804;11270.154738394489;11284.943575282072;10931.398773067558;11159.49782259784;11307.43462826839;11359.659210223706;11419.287106933694;7546.886796697944;7632.8473430532185;7678;7690.0771907369235;7935.047794264725;9920.603175872884;10820.513076911715;10821.729456763644;10887.18346124028;11014.118870490182 05:36:40 INFO - PROCESS | 17748 | |3;mootools.html;1345.977057436348;1469.4930249064068;1514.1672080355802;1628.8941218820776;1766.1257677449664;8455.661773529058;8873.290136789057;8880.8667869982;9096.499692516909;9099.135582119705;8841.160089791476;9040.321975851804;9048.864267036;9049.638014479413;9050.502222377767;2123;2185.4754858833844;2323.2449453927456;2415.9879200603973;2439.512097580482;2413.8793060347;2428.659987601737;2433.6957880264968;2434.3548959525738;2435.8782060896974;2397.3167647220544;2427.526632306701;2429.9514009719796;2430.8541487510715;2431.7689819467123;2053.127420846142;2289.9084036638515;2346.0967527501866;2371.703537057868;2375.3230329356225;2421.7336093029753;2428.077330614373;2439.5120975804734;2449.4366295752075;2450.4976479821594;9067.68263110788;9096.8635470468;9116.589753461043;9121.863172052424;9133;5271.525562699376;5413;5417.4289456057695;5423.2136340230445;5428.050091234058;3388.932221355584;3438.277961628061;3497.1257185703575;3507.4388097904466;3551.254236610315;1084.7071290751533;1095.3865835132272;1107.6787731557838;1142.2917790969568;1149.367847683779;12882.291473969022;12928.806067908989;12957;12962.80555791664;12989.220646761225;4544.2501987171745;4633.4671512775785;4784.736839473862;4804.135255653946;4809.879753006133;10790.298630588986;10815.35107893529;10836.29564078348;10838;10842.891571084188;5409.29679141709;5412.864678383072;5415.268938693226;5419.539339156137;5423.891522169534;4417.845375411845;4926.359573255454;5032.6980381177245;5044.9243261350375;5068.6451948363265;4070.75575465473;4076.1032572834524;4101.118259574206;4129.97935010323;4153.56701937831;1175.2772045192146;1261.6782720406238;1302.9739405211842;1332.5336132353793;1343.4424713743688;871.8997315308694;1001.7846163074828;1007.2395341517108;1020.7090979071078;1023.65195833417;6196.411340922605;6215.192025036717;6313.210848643919;6323.988161894074;6368.713407896656;974.332582181194;986.7385142937128;999.2355847776457;1007.3502590829021;1017.3438132404558;4223;4304.074623955865;4322.330038843984;4345.804438800262;4401.317795741666;11097.278676886139;11405.486753096131;11538.307701537935;11540.538378464935;11540.653780386601;11385.146114041314;11386.146039047104;11390;11411.60059397917;11414.543418263176;7956;8327.084020757833;8331.66673333072;8487.405881588353;8556.700515481929;6403.3596640337455;6537.5096867736065;6659.766908158192;6685.598864068172;6744.763933262312;10787.406692631981;10839.783204335712;10878.933002729456;10936.726581835517;10947.726306842393;10549.261551691308;11099.833502497308;11100.11199104086;11113.777724445305;11117.332960022424;7084.929150708427;7869.645865935932;8069.636866340911;8118.83762324762;8284;9022.729318120468;9042.593083311398;9067.546622668708;9126.863097053681;9137.908620913706;7851.214878512332;8079.83840323202;8126.349892008507;8141.185881411811;8314.584270786316;7891.171427000312;8035.156308587748;8046.597670116588;8114.715984940499;8138.959305203436;6667.2666006738245;6872.10662613857;6930.757423490154;6949.409300209337;7051.294870512907;5323.4676532348;5337.146056630921;5401.540869026177;5431.701256430934;5468.48049435303;5506.972465137809;5509.256250406143;5565.55475561946;5578.60949733531;5675 05:36:40 INFO - PROCESS | 17748 | |4;prototype.html;327.24896362847267;335.26744064219685;339.984700688469;342.1071004677792;345.9360018396595;5357.142857142858;5371.677699338043;5379.327584051994;5385.542228910537;5413.26920865683;5314.3091398118195;5329.946700532993;5356.785728570862;5364.436734142908;5366.785328586861;3690.225052738928;4009.5789942056103;4119.134981653856;4146.60607242313;4230.492340919094;4152.335626299792;4173.290540608104;4181;4191.245575796355;4227.767472788995;4132.483439570054;4160.167966406716;4166.604172603597;4176.812043458051;4181.310083836163;3977.5823538528616;4069.7354671946227;4133.9173216535655;4157.168566286755;4213.30480470722;3623.3840247158046;3646.5441819772527;3661.7986010769396;3667.1382225177063;3670.1925576373155;5173;5202.97398513005;5213.791448342062;5250.553702935255;5294.338207724035;4522.005158865044;4713.198756211452;4732.7694799352075;4750.45369782476;4775.092732380836;5501.587380946445;5510.512161716314;5522.475364840334;5541.362743284533;5566.526845218162;3841.8271177797064;3984.6812255019527;4001.159756451149;4003.499562554681;4016.5782592827622;5462.890742185174;5625.718714064321;5739.450348405907;5780.855478613026;5780.8843823123725;4088.591140885947;4090.2842002650013;4146.357314616239;4149.190907773016;4171.666266698657;4218.059692541404;4227.196832601796;4227.619514243733;4235.576442355739;4242.00312926462;4649.511801260886;4801.135795556764;4801.95198048015;4810.350602668665;4817.13291607514;5520.91718624221;5569.303837020372;5576.832695019156;5581.4371975846825;5586.329640443173;1442;1462.1154201708025;1465.2380762003697;1466.4940595494538;1469.9191544465157;927.6753136402206;944.6976967370513;947.3889341374775;949.4303417949175;965.4738167698481;4732.858014259577;4744.620430365562;4795.376601041842;4832.565069143794;4880.902381952341;5007.749612519359;5030.245463180479;5054.620903432257;5066.721330326867;5070.923936140961;4657.278121891112;4786.497417771084;4815.759212039454;4849.278506130344;4852;2698.4198397344667;2706.8090040382167;2722.727727227301;2728.0451841855192;2738.1101142128887;5236.9738151309;5251.36983561975;5258.184981327824;5262.684238945675;5267.920981185209;4940.246212594478;5097.61767867404;5150.716710580879;5151.484851514819;5182.714950677749;5173.198154286091;5186.948130518646;5196.922046169235;5210.426853046162;5217.50433708797;5034.263179203169;5036.496350364934;5046.369203849519;5084.720340381315;5103.591712662904;4794.928076078932;5023.246513023076;5027.446980832033;5029.295898574275;5045.697258164522;5632.746526406403;5773.74018169175;5900.583859873514;5907.316414821755;5921.644701317935;4121.381792731115;4146.543880173239;4154.605312495308;4164.708470407042;4177.603127702863;5523.558115350682;5733;5734.111212762028;5785.971070144622;5814.447627475383;5550.139728342114;5564.360098588714;5572.972135139461;5588.217649529151;5595.237500187428;5537.335519737496;5544.279243698294;5557.666160121461;5598.776048958159;5611.859703507445;5305.708186049805;5501.532369748456;5503.614746967673;5503.862403439786;5507.953488837108;5529.391766905556;5543.307086614173;5582.720863956867;5599.440055994368;5603.38362780102;5301.74675762807;5409.188621706776;5442.482964118402;5466.91799622998;5481.342238931354 05:36:40 INFO - PROCESS | 17748 | |5;yui.html;724.6268171891473;777.6150805351352;806.770070529899;836.3518273338162;891.598780548753;16084.597885052879;16537.421190258345;16886.240119194634;16909.49271521855;17520.123993800324;16809.24358403872;16845.494635160965;16890.49328520143;16946.745798813026;16964.15179241039;663.7477758451781;795.1015352651496;804.3565147881686;820.1470470710484;820.2781552234026;822.2229992656942;839.4837175137308;839.7061028639988;840.2521755637488;840.306746933779;865.5153114256005;874.6851133591902;876.8553188723853;877.2280393253927;877.9253763430116;689.3106893106893;824.8597738384489;851.382747508058;869.4913475616772;870.843248215321;626.5207116555838;626.9028300613412;627.8932581461163;628.3622123544606;628.4877824572958;15337.23313834315;15372.154531500762;15391.230438478031;15393.769093463607;15395;14434.927825360912;14435.422583096664;14443.711125777425;14596.927015364961;14727.92636036813;13159.736805263841;13218.933905330508;13322.267275299855;13376.866231337659;13460.461581536727;4515.390422292981;4561.794719237642;4578.679492435531;4741.786619602091;4750.216214324632;79985;80667;81146.59426702888;82107.5894620523;82220.58889705573;11704.70738231534;11710.121740869468;11734.647960561197;11854.762904742029;11972.04223662105;21543;21570;21646.350609481742;21681.891590542262;21726.13095476195;8469.39335438458;8494;8620.870686939701;8793.340499462438;8869.68956086534;4840.854774356775;4842.15262329091;4925.408950925912;4975.353204083446;4989.077020751172;3348.9665103348657;3436.0722604897037;3437.8968630940612;3438.0889064397957;3445.7415693822563;658.3679667519235;692.9376356127973;695.3429009585893;720.5712601002396;723.0636325957792;708;734.500539633044;778.260652380241;780.8047988003;788.9487183333065;9499.192568631745;9963.202943764481;10411.583536658449;10420.426876521864;10728.89271107279;683.7094234950126;700.9158900931819;703.01398549099;706.5230969095943;727.1238158019573;4813;4976.975115124401;4978.452370239271;5022.096022715946;5025.522575355335;101667;127480.36259818642;128963;129994.05008924873;131714.02428963574;58542.41457585455;61136;62136;65304;100845.21685235381;87812;89105;90547.54726226327;92448;92692;9820.361676491006;10031.498425078862;10109.848352274576;10303.690889273334;10337.896621033693;52498;52505.73747131393;52551.47448525466;53827.46172538224;54487.18269225885;75882.62058689892;78898;80765;81081;81378;13466.730665386442;13565.321733913463;13776.242306672828;14317.85682143207;14374.928125359307;14791.630209244855;15676.68646627084;15714.76427853606;15908;16029.919850400673;13048.347582621022;13063.246000693152;13073.346332683517;13320.067595268238;13958.651033724238;13586.45654173822;13740.381682824496;13743.862561374259;13897.861021390061;13957.511487097903;12494.937525312314;12557;12606.621801345975;12955.935220323838;12972.351382430652;10975.39635320033;10993.945030274797;11100.084280449635;11127.332360058423;11405.315681059163;10903.83644245321;11562.248453850472;11790.174687771774;12026;12075.215111017756 05:36:40 INFO - PROCESS | 17748 | __end_tp_report 05:36:40 INFO - PROCESS | 17748 | __start_cc_report 05:36:40 INFO - PROCESS | 17748 | _x_x_mozilla_cycle_collect,795 05:36:40 INFO - PROCESS | 17748 | __end_cc_report 05:36:40 INFO - PROCESS | 17748 | __startTimestamp1468931800122__endTimestamp 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | ------- Summary: start ------- 05:36:40 INFO - PROCESS | 17748 | Number of tests: 6 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | [#0] dojo.html Cycles:165 Average:5265.92 Median:5454.73 stddev:589.06 (10.8%) stddev-sans-first:564.38 05:36:40 INFO - PROCESS | 17748 | Values: 3039.7 3043.5 3050.8 3088.0 3097.0 5217.2 5271.8 5295.0 5383.9 5402.2 5253.6 5268.8 5303.1 5315.6 5329.8 4761.2 4791.8 4870.4 4881.9 5005.0 4917.5 4929.8 4930.7 4981.4 4999.5 4681.7 4714.0 4714.6 4775.1 4823.3 4813.6 4820.8 4828.5 4892.4 4939.6 4851.7 4873.4 4874.2 4874.6 4875.9 5122.2 5219.6 5229.3 5302.4 5331.6 5650.7 5665.0 5671.9 5699.8 5706.2 5473.2 5700.2 5734.4 5745.7 5752.4 5254.9 5316.6 5323.3 5390.8 5391.3 5880.5 5881.1 5896.3 5903.9 5906.0 5368.5 5537.5 5542.8 5556.4 5569.0 5672.8 5715.9 5758.1 5773.2 5776.0 5686.4 5706.9 5709.9 5711.1 5715.9 5471.2 5560.4 5620.3 5720.6 5729.7 4330.2 4331.2 4352.7 4386.6 4388.5 3877.1 3890.9 3891.3 3927.2 3931.8 5192.4 5285.8 5313.6 5349.3 5398.8 5655.8 5665.9 5674.5 5677.9 5725.8 5378.9 5381.0 5382.7 5387.8 5398.2 4848.3 4867.9 4873.5 4905.5 4918.7 5841.3 5844.4 5844.8 5858.5 5864.6 5459.9 5644.9 5663.2 5675.6 5676.5 5747.9 5752.8 5756.8 5804.1 5810.5 5513.0 5557.5 5566.2 5568.9 5569.5 5559.1 5564.7 5663.1 5673.8 5682.8 5467.7 5497.4 5510.7 5511.9 5576.1 5505.9 5508.2 5511.4 5513.3 5514.2 5264.1 5351.6 5385.6 5448.8 5482.1 5510.1 5588.3 5592.2 5637.5 5657.1 5407.3 5453.3 5454.7 5458.2 5479.6 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | [#1] ext.html Cycles:180 Average:64978.45 Median:392928.50 stddev:134777.75 (34.3%) stddev-sans-first:135069.16 05:36:40 INFO - PROCESS | 17748 | Values: 597.7 615.6 632.4 635.5 648.9 32884.7 41906.8 42872.6 42937.0 43275.8 44792.6 45161.1 45181.0 45290.0 45443.8 8119.0 8244.4 8929.9 9102.6 9133.0 10497.9 10808.9 10812.2 11120.8 11147.4 10995.2 11097.1 11101.7 11102.2 11103.9 8170.6 10525.0 10761.4 10766.4 10795.1 10712.7 10766.7 10780.9 10800.1 10809.8 33076.2 42232.4 42536.1 42547.8 42581.4 3537.6 3831.0 3940.6 4084.4 4233.9 33756.3 34158.8 34295.5 34543.3 34679.1 4294.3 4345.8 4376.6 4433.8 4484.6 383867.0 387526.0 391856.0 392691.0 393166.0 66009.7 66480.0 66964.0 66968.0 67026.7 34009.1 34523.3 69878.7 70281.0 70294.6 18049.8 18144.9 18159.2 18196.6 18207.1 13783.9 13849.9 13872.8 13876.9 13886.2 21122.8 21246.7 21421.8 21569.5 21726.0 6425.6 7500.7 7610.9 7771.7 7936.5 938.1 960.7 993.8 1028.5 1051.1 32852.5 33008.5 33175.3 33195.8 33521.0 1066.4 1141.4 1163.9 1238.3 1259.8 17125.7 17132.5 17224.4 17296.7 17393.0 663273.0 663414.0 668160.0 670437.0 672111.0 59848.0 60339.7 60372.0 60390.4 60409.7 1233.1 1343.6 1361.3 1366.6 1405.0 32819.3 34107.7 34278.0 34342.8 34412.7 49511.8 50317.0 50375.0 50460.0 50467.7 404331.0 412273.0 413442.0 413812.0 414186.0 25598.6 28215.7 28533.7 28851.3 30912.0 48716.8 48734.3 49171.8 49200.8 50454.5 41135.0 41256.0 42019.6 42422.0 43080.8 41219.2 41714.2 42461.4 42478.8 42987.6 40894.6 41768.4 41964.4 42159.6 42357.6 36324.0 37108.8 37110.3 37867.4 38562.2 25506.2 25972.6 26112.9 26323.0 26607.0 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | [#2] jquery.html Cycles:180 Average:29700.44 Median:16751.49 stddev:84785.09 (506.1%) stddev-sans-first:84994.36 05:36:40 INFO - PROCESS | 17748 | Values: 385.3 390.5 395.9 396.6 414.8 13210.1 19021.1 20366.6 20391.4 20854.7 15398.3 18286.2 18926.1 18975.6 19112.6 5627.2 5801.9 5803.8 5803.9 5806.4 5580.9 5626.4 5652.5 5654.6 5668.1 5532.4 5621.0 5650.1 5676.5 5677.7 5360.4 5631.5 5641.6 5648.9 5673.6 5367.9 5538.3 5569.4 5576.6 5581.6 14345.9 14557.2 14588.6 14613.9 15475.5 2303.8 2456.8 2477.8 2625.0 2760.3 10123.4 10300.7 10484.2 10629.2 10687.5 1875.6 1879.8 1911.9 1956.6 1980.0 86683.8 88257.6 89374.0 90463.5 90914.5 10687.2 10943.4 10953.0 11019.0 11088.7 15237.8 15455.0 15493.2 15546.0 15566.3 8310.0 8325.1 8417.7 8480.4 8482.5 6561.8 8122.0 8130.6 8172.8 8329.1 4416.2 4594.7 4696.2 4750.8 4806.0 1988.7 2020.4 2043.2 2055.7 2065.5 912.3 942.8 991.2 1109.3 1120.4 19401.0 19484.7 19998.3 20010.9 20436.9 943.6 960.2 1040.7 1044.5 1059.7 9522.6 10962.9 11078.8 11102.6 11120.1 504164.0 506288.0 510710.0 520166.0 520599.0 97158.5 99854.0 100716.5 101068.5 102893.5 965.6 969.3 986.0 986.3 998.4 17336.8 17573.5 17831.9 17888.4 18132.6 30742.7 33981.2 42411.6 42496.8 43230.6 57525.7 58361.4 61802.0 62729.0 62964.7 7323.6 7723.9 8579.2 8585.7 8706.9 12200.3 12348.8 12473.1 12527.2 12787.0 10667.5 10762.7 10866.3 11110.9 11361.7 10751.5 11021.6 11040.6 11270.2 11284.9 10931.4 11159.5 11307.4 11359.7 11419.3 7546.9 7632.8 7678.0 7690.1 7935.0 9920.6 10820.5 10821.7 10887.2 11014.1 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | [#3] mootools.html Cycles:180 Average:6049.19 Median:4409.58 stddev:3479.36 (78.9%) stddev-sans-first:3471.16 05:36:40 INFO - PROCESS | 17748 | Values: 1346.0 1469.5 1514.2 1628.9 1766.1 8455.7 8873.3 8880.9 9096.5 9099.1 8841.2 9040.3 9048.9 9049.6 9050.5 2123.0 2185.5 2323.2 2416.0 2439.5 2413.9 2428.7 2433.7 2434.4 2435.9 2397.3 2427.5 2430.0 2430.9 2431.8 2053.1 2289.9 2346.1 2371.7 2375.3 2421.7 2428.1 2439.5 2449.4 2450.5 9067.7 9096.9 9116.6 9121.9 9133.0 5271.5 5413.0 5417.4 5423.2 5428.1 3388.9 3438.3 3497.1 3507.4 3551.3 1084.7 1095.4 1107.7 1142.3 1149.4 12882.3 12928.8 12957.0 12962.8 12989.2 4544.3 4633.5 4784.7 4804.1 4809.9 10790.3 10815.4 10836.3 10838.0 10842.9 5409.3 5412.9 5415.3 5419.5 5423.9 4417.8 4926.4 5032.7 5044.9 5068.6 4070.8 4076.1 4101.1 4130.0 4153.6 1175.3 1261.7 1303.0 1332.5 1343.4 871.9 1001.8 1007.2 1020.7 1023.7 6196.4 6215.2 6313.2 6324.0 6368.7 974.3 986.7 999.2 1007.4 1017.3 4223.0 4304.1 4322.3 4345.8 4401.3 11097.3 11405.5 11538.3 11540.5 11540.7 11385.1 11386.1 11390.0 11411.6 11414.5 7956.0 8327.1 8331.7 8487.4 8556.7 6403.4 6537.5 6659.8 6685.6 6744.8 10787.4 10839.8 10878.9 10936.7 10947.7 10549.3 11099.8 11100.1 11113.8 11117.3 7084.9 7869.6 8069.6 8118.8 8284.0 9022.7 9042.6 9067.5 9126.9 9137.9 7851.2 8079.8 8126.3 8141.2 8314.6 7891.2 8035.2 8046.6 8114.7 8139.0 6667.3 6872.1 6930.8 6949.4 7051.3 5323.5 5337.1 5401.5 5431.7 5468.5 5507.0 5509.3 5565.6 5578.6 5675.0 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | [#4] prototype.html Cycles:180 Average:4546.82 Median:5050.50 stddev:1304.85 (25.8%) stddev-sans-first:1269.50 05:36:40 INFO - PROCESS | 17748 | Values: 327.2 335.3 340.0 342.1 345.9 5357.1 5371.7 5379.3 5385.5 5413.3 5314.3 5329.9 5356.8 5364.4 5366.8 3690.2 4009.6 4119.1 4146.6 4230.5 4152.3 4173.3 4181.0 4191.2 4227.8 4132.5 4160.2 4166.6 4176.8 4181.3 3977.6 4069.7 4133.9 4157.2 4213.3 3623.4 3646.5 3661.8 3667.1 3670.2 5173.0 5203.0 5213.8 5250.6 5294.3 4522.0 4713.2 4732.8 4750.5 4775.1 5501.6 5510.5 5522.5 5541.4 5566.5 3841.8 3984.7 4001.2 4003.5 4016.6 5462.9 5625.7 5739.5 5780.9 5780.9 4088.6 4090.3 4146.4 4149.2 4171.7 4218.1 4227.2 4227.6 4235.6 4242.0 4649.5 4801.1 4802.0 4810.4 4817.1 5520.9 5569.3 5576.8 5581.4 5586.3 1442.0 1462.1 1465.2 1466.5 1469.9 927.7 944.7 947.4 949.4 965.5 4732.9 4744.6 4795.4 4832.6 4880.9 5007.7 5030.2 5054.6 5066.7 5070.9 4657.3 4786.5 4815.8 4849.3 4852.0 2698.4 2706.8 2722.7 2728.0 2738.1 5237.0 5251.4 5258.2 5262.7 5267.9 4940.2 5097.6 5150.7 5151.5 5182.7 5173.2 5186.9 5196.9 5210.4 5217.5 5034.3 5036.5 5046.4 5084.7 5103.6 4794.9 5023.2 5027.4 5029.3 5045.7 5632.7 5773.7 5900.6 5907.3 5921.6 4121.4 4146.5 4154.6 4164.7 4177.6 5523.6 5733.0 5734.1 5786.0 5814.4 5550.1 5564.4 5573.0 5588.2 5595.2 5537.3 5544.3 5557.7 5598.8 5611.9 5305.7 5501.5 5503.6 5503.9 5508.0 5529.4 5543.3 5582.7 5599.4 5603.4 5301.7 5409.2 5442.5 5466.9 5481.3 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - PROCESS | 17748 | [#5] yui.html Cycles:180 Average:20953.38 Median:4660.23 stddev:29962.10 (642.9%) stddev-sans-first:30007.65 05:36:40 INFO - PROCESS | 17748 | Values: 724.6 777.6 806.8 836.4 891.6 16084.6 16537.4 16886.2 16909.5 17520.1 16809.2 16845.5 16890.5 16946.7 16964.2 663.7 795.1 804.4 820.1 820.3 822.2 839.5 839.7 840.3 840.3 865.5 874.7 876.9 877.2 877.9 689.3 824.9 851.4 869.5 870.8 626.5 626.9 627.9 628.4 628.5 15337.2 15372.2 15391.2 15393.8 15395.0 14434.9 14435.4 14443.7 14596.9 14727.9 13159.7 13218.9 13322.3 13376.9 13460.5 4515.4 4561.8 4578.7 4741.8 4750.2 79985.0 80667.0 81146.6 82107.6 82220.6 11704.7 11710.1 11734.6 11854.8 11972.0 21543.0 21570.0 21646.4 21681.9 21726.1 8469.4 8494.0 8620.9 8793.3 8869.7 4840.9 4842.2 4925.4 4975.4 4989.1 3349.0 3436.1 3437.9 3438.1 3445.7 658.4 692.9 695.3 720.6 723.1 708.0 734.5 778.3 780.8 788.9 9499.2 9963.2 10411.6 10420.4 10728.9 683.7 700.9 703.0 706.5 727.1 4813.0 4977.0 4978.5 5022.1 5025.5 101667.0 127480.4 128963.0 129994.1 131714.0 58542.4 61136.0 62136.0 65304.0 100845.2 87812.0 89105.0 90547.5 92448.0 92692.0 9820.4 10031.5 10109.8 10303.7 10337.9 52498.0 52505.7 52551.5 53827.5 54487.2 75882.6 78898.0 80765.0 81081.0 81378.0 13466.7 13565.3 13776.2 14317.9 14374.9 14791.6 15676.7 15714.8 15908.0 16029.9 13048.3 13063.2 13073.3 13320.1 13958.7 13586.5 13740.4 13743.9 13897.9 13957.5 12494.9 12557.0 12606.6 12955.9 12972.4 10975.4 10993.9 11100.1 11127.3 11405.3 10903.8 11562.2 11790.2 12026.0 12075.2 05:36:40 INFO - PROCESS | 17748 | -------- Summary: end -------- 05:36:40 INFO - PROCESS | 17748 | 05:36:40 INFO - TEST-INFO | 17748: exit 0 05:36:40 INFO - TEST-OK | dromaeo_css | took 1113065ms 05:36:40 INFO - TEST-START | kraken 05:36:40 INFO - operating with platform_type : linux_ 05:36:40 INFO - Initialising browser for kraken test... 05:36:40 INFO - TEST-INFO | started process 17940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpACzh7p/profile http://localhost:43375/getInfo.html) 05:36:44 INFO - PROCESS | 17940 | __metrics Screen width/height:1600/1200 05:36:44 INFO - PROCESS | 17940 | colorDepth:24 05:36:44 INFO - PROCESS | 17940 | Browser inner width/height: 1024/697 05:36:44 INFO - PROCESS | 17940 | __metrics 05:36:45 INFO - PROCESS | 17940 | 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" 05:36:45 INFO - PROCESS | 17940 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:46 INFO - TEST-INFO | 17940: exit 0 05:36:46 INFO - Browser initialized. 05:36:46 INFO - Running cycle 1/1 for kraken test... 05:36:46 INFO - TEST-INFO | started process 18021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpACzh7p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:57 INFO - PROCESS | 18021 | RSS: Main: 158388224 05:36:57 INFO - PROCESS | 18021 | 05:37:00 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43375/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:01 INFO - PROCESS | 18021 | RSS: Main: 217460736 05:37:01 INFO - PROCESS | 18021 | 05:37:03 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43375/tests/kraken/driver.html?testName=audio-dft) 05:37:04 INFO - PROCESS | 18021 | RSS: Main: 206016512 05:37:04 INFO - PROCESS | 18021 | 05:37:07 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43375/tests/kraken/driver.html?testName=audio-fft) 05:37:08 INFO - PROCESS | 18021 | RSS: Main: 269959168 05:37:08 INFO - PROCESS | 18021 | 05:37:10 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43375/tests/kraken/driver.html?testName=audio-oscillator) 05:37:10 INFO - PROCESS | 18021 | RSS: Main: 181469184 05:37:10 INFO - PROCESS | 18021 | 05:37:12 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:13 INFO - PROCESS | 18021 | RSS: Main: 184999936 05:37:13 INFO - PROCESS | 18021 | 05:37:16 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43375/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:17 INFO - PROCESS | 18021 | RSS: Main: 221298688 05:37:17 INFO - PROCESS | 18021 | 05:37:20 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43375/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:21 INFO - PROCESS | 18021 | RSS: Main: 221708288 05:37:21 INFO - PROCESS | 18021 | 05:37:23 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43375/tests/kraken/driver.html?testName=json-parse-financial) 05:37:24 INFO - PROCESS | 18021 | RSS: Main: 222294016 05:37:24 INFO - PROCESS | 18021 | 05:37:25 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:26 INFO - PROCESS | 18021 | RSS: Main: 210640896 05:37:26 INFO - PROCESS | 18021 | 05:37:28 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:28 INFO - PROCESS | 18021 | RSS: Main: 215097344 05:37:28 INFO - PROCESS | 18021 | 05:37:30 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:31 INFO - PROCESS | 18021 | RSS: Main: 210972672 05:37:31 INFO - PROCESS | 18021 | 05:37:34 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:34 INFO - PROCESS | 18021 | RSS: Main: 223887360 05:37:34 INFO - PROCESS | 18021 | 05:37:37 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:38 INFO - PROCESS | 18021 | RSS: Main: 223461376 05:37:38 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:43375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43375/tests/kraken/driver.html?testName=ai-astar) 05:37:39 INFO - PROCESS | 18021 | RSS: Main: 266280960 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | __start_tp_report 05:37:39 INFO - PROCESS | 18021 | _x_x_mozilla_page_load 05:37:39 INFO - PROCESS | 18021 | _x_x_mozilla_page_load_details 05:37:39 INFO - PROCESS | 18021 | |i|pagename|runs| 05:37:39 INFO - PROCESS | 18021 | |0;ai-astar;102;112;110;111;114;111;111;110;111;111 05:37:39 INFO - PROCESS | 18021 | |1;audio-beat-detection;148;122;118;189;118;118;153;121;158;118 05:37:39 INFO - PROCESS | 18021 | |2;audio-dft;160;161;161;160;161;160;160;163;162;162 05:37:39 INFO - PROCESS | 18021 | |3;audio-fft;76;74;82;133;76;77;75;75;101;76 05:37:39 INFO - PROCESS | 18021 | |4;audio-oscillator;84;84;108;84;84;84;110;85;83;121 05:37:39 INFO - PROCESS | 18021 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;116 05:37:39 INFO - PROCESS | 18021 | |6;imaging-darkroom;146;146;145;147;147;145;145;146;147;145 05:37:39 INFO - PROCESS | 18021 | |7;imaging-desaturate;95;94;94;95;95;98;94;94;97;96 05:37:39 INFO - PROCESS | 18021 | |8;json-parse-financial;51;50;50;51;51;52;52;50;50;51 05:37:39 INFO - PROCESS | 18021 | |9;json-stringify-tinderbox;61;61;61;68;62;61;61;60;61;61 05:37:39 INFO - PROCESS | 18021 | |10;stanford-crypto-aes;77;76;82;76;75;75;74;80;74;79 05:37:39 INFO - PROCESS | 18021 | |11;stanford-crypto-ccm;121;123;126;136;130;117;122;127;170;125 05:37:39 INFO - PROCESS | 18021 | |12;stanford-crypto-pbkdf2;156;160;165;161;160;165;160;160;159;156 05:37:39 INFO - PROCESS | 18021 | |13;stanford-crypto-sha256-iterative;66;62;62;62;62;62;62;65;62;61 05:37:39 INFO - PROCESS | 18021 | __end_tp_report 05:37:39 INFO - PROCESS | 18021 | __start_cc_report 05:37:39 INFO - PROCESS | 18021 | _x_x_mozilla_cycle_collect,1670 05:37:39 INFO - PROCESS | 18021 | __end_cc_report 05:37:39 INFO - PROCESS | 18021 | __startTimestamp1468931859901__endTimestamp 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | ------- Summary: start ------- 05:37:39 INFO - PROCESS | 18021 | Number of tests: 14 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:1.20 05:37:39 INFO - PROCESS | 18021 | Values: 102.0 112.0 110.0 111.0 114.0 111.0 111.0 110.0 111.0 111.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:135.00 stddev:24.59 (18.2%) stddev-sans-first:25.71 05:37:39 INFO - PROCESS | 18021 | Values: 148.0 122.0 118.0 189.0 118.0 118.0 153.0 121.0 158.0 118.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 05:37:39 INFO - PROCESS | 18021 | Values: 160.0 161.0 161.0 160.0 161.0 160.0 160.0 163.0 162.0 162.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.00 stddev:18.84 (24.8%) stddev-sans-first:19.73 05:37:39 INFO - PROCESS | 18021 | Values: 76.0 74.0 82.0 133.0 76.0 77.0 75.0 75.0 101.0 76.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:84.00 stddev:14.40 (17.1%) stddev-sans-first:14.92 05:37:39 INFO - PROCESS | 18021 | Values: 84.0 84.0 108.0 84.0 84.0 84.0 110.0 85.0 83.0 121.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:37:39 INFO - PROCESS | 18021 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 05:37:39 INFO - PROCESS | 18021 | Values: 146.0 146.0 145.0 147.0 147.0 145.0 145.0 146.0 147.0 145.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 05:37:39 INFO - PROCESS | 18021 | Values: 95.0 94.0 94.0 95.0 95.0 98.0 94.0 94.0 97.0 96.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 05:37:39 INFO - PROCESS | 18021 | Values: 51.0 50.0 50.0 51.0 51.0 52.0 52.0 50.0 50.0 51.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.00 stddev:2.26 (3.7%) stddev-sans-first:2.39 05:37:39 INFO - PROCESS | 18021 | Values: 61.0 61.0 61.0 68.0 62.0 61.0 61.0 60.0 61.0 61.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.50 stddev:2.70 (3.5%) stddev-sans-first:2.86 05:37:39 INFO - PROCESS | 18021 | Values: 77.0 76.0 82.0 76.0 75.0 75.0 74.0 80.0 74.0 79.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:126.50 stddev:15.09 (11.9%) stddev-sans-first:15.67 05:37:39 INFO - PROCESS | 18021 | Values: 121.0 123.0 126.0 136.0 130.0 117.0 122.0 127.0 170.0 125.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:3.05 (1.9%) stddev-sans-first:2.83 05:37:39 INFO - PROCESS | 18021 | Values: 156.0 160.0 165.0 161.0 160.0 165.0 160.0 160.0 159.0 156.0 05:37:39 INFO - PROCESS | 18021 | 05:37:39 INFO - PROCESS | 18021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:1.58 (2.5%) stddev-sans-first:1.09 05:37:39 INFO - PROCESS | 18021 | Values: 66.0 62.0 62.0 62.0 62.0 62.0 62.0 65.0 62.0 61.0 05:37:39 INFO - PROCESS | 18021 | -------- Summary: end -------- 05:37:39 INFO - PROCESS | 18021 | 05:37:40 INFO - TEST-INFO | 18021: exit 0 05:37:40 INFO - TEST-OK | kraken | took 60031ms 05:37:40 INFO - SUITE-END | took 1173s 05:37:41 INFO - Completed test suite (00:19:33) 05:37:41 INFO - javascript benchmark 05:37:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.696030396959, 3043.5130379139337, 3050.786444948854, 3087.984560077202, 3097.0399176255364, 5217.243499692542, 5271.841844744659, 5295.020421222067, 5383.865403364913, 5402.216678581603, 5253.6322457428, 5268.762905669245, 5303.124984377583, 5315.601329900253, 5329.786808527664, 4761.190597598408, 4791.760411979404, 4870.391201099845, 4881.8535443936735, 5004.974975125119, 4917.50824917509, 4929.753512324387, 4930.704157750546, 4981.427135879366, 4999.525045120726, 4681.74250416227, 4714.033623107255, 4714.6464015199, 4775.14047471455, 4823.324734537167, 4813.614910807162, 4820.831270905536, 4828.5412885775795, 4892.412910450733, 4939.58013568847, 4851.660383773137, 4873.366462359906, 4874.1713908635265, 4874.634402419832, 4875.8781030474165, 5122.206058061007, 5219.634625576211, 5229.294045303874, 5302.390225124122, 5331.573474122061, 5650.745716442729, 5665.036943719578, 5671.914921276143, 5699.800506982236, 5706.172604972297, 5473.151661492475, 5700.173474846166, 5734.369219385864, 5745.683987380692, 5752.395998420147, 5254.868628284324, 5316.574674026068, 5323.254744335796, 5390.838274851682, 5391.326084239509, 5880.470757631833, 5881.05903055509, 5896.262967129109, 5903.911441328383, 5906.0, 5368.489993450616, 5537.529310008614, 5542.778288868481, 5556.444355564411, 5568.969740598002, 5672.7730890763905, 5715.942840571624, 5758.078707406795, 5773.191753154561, 5776.0, 5686.402927692533, 5706.914396284059, 5709.914351284651, 5711.086226203871, 5715.857103572361, 5471.23402723619, 5560.388357280696, 5620.297462817148, 5720.599558030898, 5729.684867332254, 4330.17726631939, 4331.220380331571, 4352.651787856964, 4386.627136693417, 4388.539203383662, 3877.0888841122314, 3890.9416358754643, 3891.2606604745006, 3927.1752931884052, 3931.76409415436, 5192.3769147702515, 5285.762140703678, 5313.628046036741, 5349.251104845324, 5398.757055932492, 5655.802046928337, 5665.915011274834, 5674.517665998436, 5677.886442271131, 5725.828225153252, 5378.865528361744, 5381.031414345455, 5382.703951282639, 5387.81142660005, 5398.217258497496, 4848.3454733610515, 4867.9269810952865, 4873.512648735098, 4905.533974272438, 4918.680285781413, 5841.2990441146485, 5844.357120716718, 5844.795432159939, 5858.50202732764, 5864.589478736533, 5459.945400545944, 5644.915326270027, 5663.235463212413, 5675.631083979528, 5676.489115979582, 5747.885042299047, 5752.798652047159, 5756.798512052058, 5804.100364443518, 5810.5351571875, 5512.972435137959, 5557.527610153183, 5566.220729097849, 5568.916466252928, 5569.498745112959, 5559.054960656617, 5564.749586268708, 5663.065594177079, 5673.8297851064535, 5682.77268909239, 5467.6719396836315, 5497.39528651856, 5510.724463776715, 5511.944880551304, 5576.0799468088935, 5505.862353441196, 5508.20131080999, 5511.4213007633625, 5513.3108361454815, 5514.228008078952, 5264.10510213257, 5351.571874249973, 5385.649932754515, 5448.809291674773, 5482.095454250004, 5510.063289240758, 5588.273524441796, 5592.245046918777, 5637.52081073097, 5657.066584013592, 5407.270018547603, 5453.345598528202, 5454.727263636723, 5458.181272809111, 5479.6164268500825], "value": 5226.623558160026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6533610505907, 615.6090882289747, 632.433971595422, 635.4884318123911, 648.9415952564268, 32884.67115328846, 41906.79046604766, 42872.571274287286, 42937.0, 43275.78362108185, 44792.552074479245, 45161.0967780645, 45181.0, 45290.0, 45443.77278113613, 8119.0, 8244.38167137464, 8929.866052009225, 9102.59038343273, 9133.0, 10497.895021049806, 10808.891911080867, 10812.189085818594, 11120.833187502154, 11147.386893720843, 10995.175361847894, 11097.056750176245, 11101.666949991473, 11102.222844400896, 11103.888961110366, 8170.632321545515, 10525.0, 10761.354318740901, 10766.354018758899, 10795.08241799448, 10712.73218169552, 10766.730831729192, 10780.946095269474, 10800.135989120852, 10809.78380432387, 33076.1730956728, 42232.366514502304, 42536.14927701459, 42547.787261063495, 42581.36127958083, 3537.5931767846514, 3830.9808450957844, 3940.5862384449506, 4084.4485994390675, 4233.894152646209, 33756.324873502395, 34158.82920585381, 34295.4855677165, 34543.30913381718, 34679.13302167441, 4294.269974104379, 4345.782710864444, 4376.5623437656295, 4433.756143412111, 4484.641228701696, 383867.0, 387526.0, 391856.0, 392691.0, 393166.0, 66009.6699516509, 66480.0, 66964.0, 66968.0, 67026.66486667634, 34009.14977125542, 34523.30953380918, 69878.65060674664, 70281.0, 70294.64852675806, 18049.819501805076, 18144.909275453538, 18159.182836772376, 18196.63606727858, 18207.08964551767, 13783.862161378258, 13849.930750346184, 13872.791908121386, 13876.861231387556, 13886.166829990232, 21122.788772112388, 21246.681299780517, 21421.78578214198, 21569.460763480725, 21726.0, 6425.646589437626, 7500.737474188377, 7610.9238907611325, 7771.72798952034, 7936.484128531627, 938.1369140390857, 960.6973803252093, 993.8012397520525, 1028.5165971993301, 1051.1328154272755, 32852.507212391836, 33008.504872426936, 33175.33649327048, 33195.834020830225, 33521.0, 1066.3921564708041, 1141.4463984967285, 1163.87197408285, 1238.2756087688622, 1259.7606454773563, 17125.657486850443, 17132.486025419257, 17224.397146100076, 17296.654066918592, 17393.0, 663273.0, 663414.0, 668160.0, 670437.0, 672111.0, 59848.0, 60339.698301508215, 60372.0, 60390.39609603935, 60409.69795150996, 1233.1183204009176, 1343.5767733164023, 1361.3465536542317, 1366.5558693424678, 1405.0445696925983, 32819.34361312712, 34107.65892341045, 34278.0, 34342.82828585941, 34412.65587344095, 49511.752441237564, 50317.0, 50375.0, 50460.0, 50467.747661262925, 404331.0, 412273.0, 413442.0, 413812.0, 414186.0, 25598.616020760077, 28215.71784282131, 28533.714662853105, 28851.278718032216, 30912.0, 48716.75641621769, 48734.26898596595, 49171.75414122907, 49200.75399622979, 50454.49545504498, 41135.0, 41256.0, 42019.57980420157, 42422.0, 43080.784596078076, 41219.1756164869, 41714.16571668489, 42461.36307955445, 42478.78760606177, 42987.57012429961, 40894.591054089076, 41768.373474397304, 41964.3705344414, 42159.578404215565, 42357.57642423536, 36324.0, 37108.814455927546, 37110.25779484341, 37867.431988519646, 38562.2287554253, 25506.23481295564, 25972.610410843474, 26112.86943565346, 26323.0, 26607.0], "value": 21106.107927339537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.3487605945949, 390.496259824826, 395.94060890866376, 396.5756640394778, 414.8133339997002, 13210.097648339108, 19021.144048517814, 20366.59266814663, 20391.388258352254, 20854.687179692315, 15398.30707618157, 18286.17712202951, 18926.148323325448, 18975.62048759024, 19112.61774764504, 5627.212190293352, 5801.883962320751, 5803.796867109652, 5803.854903627401, 5806.419358064202, 5580.91628625571, 5626.381098079208, 5652.463016013472, 5654.604177707542, 5668.093105103184, 5532.3914369419535, 5621.0, 5650.0959846424585, 5676.517496012823, 5677.744501497422, 5360.437154098802, 5631.493165615094, 5641.605087643867, 5648.887022259552, 5673.602847800615, 5367.919481207785, 5538.280023596906, 5569.359523654791, 5576.581756368289, 5581.609287349887, 14345.856541434556, 14557.199354035523, 14588.635284117876, 14613.926930365387, 15475.535733928, 2303.8156947444163, 2456.7788898998997, 2477.814163937712, 2624.973750262492, 2760.2823265950997, 10123.392596444237, 10300.742481438025, 10484.161267098614, 10629.20280978922, 10687.465626718711, 1875.606122714218, 1879.793222745497, 1911.923523059076, 1956.5988972260652, 1979.990100049505, 86683.77558906868, 88257.55871220666, 89373.99999999935, 90463.54768226182, 90914.5454272731, 10687.198460115522, 10943.398113103696, 10953.014228719294, 11019.0, 11088.65174439924, 15237.847621523864, 15455.0, 15493.225338733018, 15546.0, 15566.299516521784, 8310.0, 8325.125861784547, 8417.70538031166, 8480.448770829877, 8482.533460659599, 6561.770338038145, 8121.959390203011, 8130.552819594861, 8172.795680107926, 8329.08380078191, 4416.205083085076, 4594.65540084495, 4696.178168820443, 4750.762461876892, 4805.951940480621, 1988.6619274723332, 2020.40398082566, 2043.2439997201132, 2055.7122002919605, 2065.5455799724036, 912.3112050401904, 942.769021589715, 991.1921783746224, 1109.2678831970861, 1120.3669926491507, 19401.0, 19484.70772938407, 19998.300059497848, 20010.89994550018, 20436.897815510827, 943.5706753427174, 960.2126256469628, 1040.6825918094903, 1044.5456226541328, 1059.7085801404676, 9522.571484283224, 10962.890371096188, 11078.778424431466, 11102.555897764, 11120.110391168688, 504164.0, 506288.0, 510710.0, 520166.0, 520599.0, 97158.51420742851, 99854.0, 100716.49641751891, 101068.49465752624, 102893.48553257185, 965.5944503308627, 969.345691658128, 986.0238364019713, 986.3342243985425, 998.3760149906309, 17336.826631733522, 17573.472795816146, 17831.910840445715, 17888.373906913195, 18132.637347252716, 30742.692573073982, 33981.15047123842, 42411.575884242, 42496.78751606222, 43230.56769432266, 57525.712371437876, 58361.4163858356, 61802.0, 62729.0, 62964.68517657566, 7323.560586364835, 7723.9227607723205, 8579.184977427134, 8585.742427727178, 8706.869396959177, 12200.328981906081, 12348.753024939271, 12473.064520161206, 12527.248365098123, 12786.977041836817, 10667.519961601902, 10762.677119686421, 10866.293690910066, 11110.888891110986, 11361.659150225507, 10751.462426878468, 11021.614243501439, 11040.558377664804, 11270.154738394489, 11284.943575282072, 10931.398773067558, 11159.49782259784, 11307.43462826839, 11359.659210223706, 11419.287106933694, 7546.886796697944, 7632.8473430532185, 7678.0, 7690.0771907369235, 7935.047794264725, 9920.603175872884, 10820.513076911715, 10821.729456763644, 10887.18346124028, 11014.118870490182], "value": 9057.897210332418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.977057436348, 1469.4930249064068, 1514.1672080355802, 1628.8941218820776, 1766.1257677449664, 8455.661773529058, 8873.290136789057, 8880.8667869982, 9096.499692516909, 9099.135582119705, 8841.160089791476, 9040.321975851804, 9048.864267036, 9049.638014479413, 9050.502222377767, 2123.0, 2185.4754858833844, 2323.2449453927456, 2415.9879200603973, 2439.512097580482, 2413.8793060347, 2428.659987601737, 2433.6957880264968, 2434.3548959525738, 2435.8782060896974, 2397.3167647220544, 2427.526632306701, 2429.9514009719796, 2430.8541487510715, 2431.7689819467123, 2053.127420846142, 2289.9084036638515, 2346.0967527501866, 2371.703537057868, 2375.3230329356225, 2421.7336093029753, 2428.077330614373, 2439.5120975804734, 2449.4366295752075, 2450.4976479821594, 9067.68263110788, 9096.8635470468, 9116.589753461043, 9121.863172052424, 9133.0, 5271.525562699376, 5413.0, 5417.4289456057695, 5423.2136340230445, 5428.050091234058, 3388.932221355584, 3438.277961628061, 3497.1257185703575, 3507.4388097904466, 3551.254236610315, 1084.7071290751533, 1095.3865835132272, 1107.6787731557838, 1142.2917790969568, 1149.367847683779, 12882.291473969022, 12928.806067908989, 12957.0, 12962.80555791664, 12989.220646761225, 4544.2501987171745, 4633.4671512775785, 4784.736839473862, 4804.135255653946, 4809.879753006133, 10790.298630588986, 10815.35107893529, 10836.29564078348, 10838.0, 10842.891571084188, 5409.29679141709, 5412.864678383072, 5415.268938693226, 5419.539339156137, 5423.891522169534, 4417.845375411845, 4926.359573255454, 5032.6980381177245, 5044.9243261350375, 5068.6451948363265, 4070.75575465473, 4076.1032572834524, 4101.118259574206, 4129.97935010323, 4153.56701937831, 1175.2772045192146, 1261.6782720406238, 1302.9739405211842, 1332.5336132353793, 1343.4424713743688, 871.8997315308694, 1001.7846163074828, 1007.2395341517108, 1020.7090979071078, 1023.65195833417, 6196.411340922605, 6215.192025036717, 6313.210848643919, 6323.988161894074, 6368.713407896656, 974.332582181194, 986.7385142937128, 999.2355847776457, 1007.3502590829021, 1017.3438132404558, 4223.0, 4304.074623955865, 4322.330038843984, 4345.804438800262, 4401.317795741666, 11097.278676886139, 11405.486753096131, 11538.307701537935, 11540.538378464935, 11540.653780386601, 11385.146114041314, 11386.146039047104, 11390.0, 11411.60059397917, 11414.543418263176, 7956.0, 8327.084020757833, 8331.66673333072, 8487.405881588353, 8556.700515481929, 6403.3596640337455, 6537.5096867736065, 6659.766908158192, 6685.598864068172, 6744.763933262312, 10787.406692631981, 10839.783204335712, 10878.933002729456, 10936.726581835517, 10947.726306842393, 10549.261551691308, 11099.833502497308, 11100.11199104086, 11113.777724445305, 11117.332960022424, 7084.929150708427, 7869.645865935932, 8069.636866340911, 8118.83762324762, 8284.0, 9022.729318120468, 9042.593083311398, 9067.546622668708, 9126.863097053681, 9137.908620913706, 7851.214878512332, 8079.83840323202, 8126.349892008507, 8141.185881411811, 8314.584270786316, 7891.171427000312, 8035.156308587748, 8046.597670116588, 8114.715984940499, 8138.959305203436, 6667.2666006738245, 6872.10662613857, 6930.757423490154, 6949.409300209337, 7051.294870512907, 5323.4676532348, 5337.146056630921, 5401.540869026177, 5431.701256430934, 5468.48049435303, 5506.972465137809, 5509.256250406143, 5565.55475561946, 5578.60949733531, 5675.0], "value": 4810.764919795044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.24896362847267, 335.26744064219685, 339.984700688469, 342.1071004677792, 345.9360018396595, 5357.142857142858, 5371.677699338043, 5379.327584051994, 5385.542228910537, 5413.26920865683, 5314.3091398118195, 5329.946700532993, 5356.785728570862, 5364.436734142908, 5366.785328586861, 3690.225052738928, 4009.5789942056103, 4119.134981653856, 4146.60607242313, 4230.492340919094, 4152.335626299792, 4173.290540608104, 4181.0, 4191.245575796355, 4227.767472788995, 4132.483439570054, 4160.167966406716, 4166.604172603597, 4176.812043458051, 4181.310083836163, 3977.5823538528616, 4069.7354671946227, 4133.9173216535655, 4157.168566286755, 4213.30480470722, 3623.3840247158046, 3646.5441819772527, 3661.7986010769396, 3667.1382225177063, 3670.1925576373155, 5173.0, 5202.97398513005, 5213.791448342062, 5250.553702935255, 5294.338207724035, 4522.005158865044, 4713.198756211452, 4732.7694799352075, 4750.45369782476, 4775.092732380836, 5501.587380946445, 5510.512161716314, 5522.475364840334, 5541.362743284533, 5566.526845218162, 3841.8271177797064, 3984.6812255019527, 4001.159756451149, 4003.499562554681, 4016.5782592827622, 5462.890742185174, 5625.718714064321, 5739.450348405907, 5780.855478613026, 5780.8843823123725, 4088.591140885947, 4090.2842002650013, 4146.357314616239, 4149.190907773016, 4171.666266698657, 4218.059692541404, 4227.196832601796, 4227.619514243733, 4235.576442355739, 4242.00312926462, 4649.511801260886, 4801.135795556764, 4801.95198048015, 4810.350602668665, 4817.13291607514, 5520.91718624221, 5569.303837020372, 5576.832695019156, 5581.4371975846825, 5586.329640443173, 1442.0, 1462.1154201708025, 1465.2380762003697, 1466.4940595494538, 1469.9191544465157, 927.6753136402206, 944.6976967370513, 947.3889341374775, 949.4303417949175, 965.4738167698481, 4732.858014259577, 4744.620430365562, 4795.376601041842, 4832.565069143794, 4880.902381952341, 5007.749612519359, 5030.245463180479, 5054.620903432257, 5066.721330326867, 5070.923936140961, 4657.278121891112, 4786.497417771084, 4815.759212039454, 4849.278506130344, 4852.0, 2698.4198397344667, 2706.8090040382167, 2722.727727227301, 2728.0451841855192, 2738.1101142128887, 5236.9738151309, 5251.36983561975, 5258.184981327824, 5262.684238945675, 5267.920981185209, 4940.246212594478, 5097.61767867404, 5150.716710580879, 5151.484851514819, 5182.714950677749, 5173.198154286091, 5186.948130518646, 5196.922046169235, 5210.426853046162, 5217.50433708797, 5034.263179203169, 5036.496350364934, 5046.369203849519, 5084.720340381315, 5103.591712662904, 4794.928076078932, 5023.246513023076, 5027.446980832033, 5029.295898574275, 5045.697258164522, 5632.746526406403, 5773.74018169175, 5900.583859873514, 5907.316414821755, 5921.644701317935, 4121.381792731115, 4146.543880173239, 4154.605312495308, 4164.708470407042, 4177.603127702863, 5523.558115350682, 5733.0, 5734.111212762028, 5785.971070144622, 5814.447627475383, 5550.139728342114, 5564.360098588714, 5572.972135139461, 5588.217649529151, 5595.237500187428, 5537.335519737496, 5544.279243698294, 5557.666160121461, 5598.776048958159, 5611.859703507445, 5305.708186049805, 5501.532369748456, 5503.614746967673, 5503.862403439786, 5507.953488837108, 5529.391766905556, 5543.307086614173, 5582.720863956867, 5599.440055994368, 5603.38362780102, 5301.74675762807, 5409.188621706776, 5442.482964118402, 5466.91799622998, 5481.342238931354], "value": 4137.547872421372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.6268171891473, 777.6150805351352, 806.770070529899, 836.3518273338162, 891.598780548753, 16084.597885052879, 16537.421190258345, 16886.240119194634, 16909.49271521855, 17520.123993800324, 16809.24358403872, 16845.494635160965, 16890.49328520143, 16946.745798813026, 16964.15179241039, 663.7477758451781, 795.1015352651496, 804.3565147881686, 820.1470470710484, 820.2781552234026, 822.2229992656942, 839.4837175137308, 839.7061028639988, 840.2521755637488, 840.306746933779, 865.5153114256005, 874.6851133591902, 876.8553188723853, 877.2280393253927, 877.9253763430116, 689.3106893106893, 824.8597738384489, 851.382747508058, 869.4913475616772, 870.843248215321, 626.5207116555838, 626.9028300613412, 627.8932581461163, 628.3622123544606, 628.4877824572958, 15337.23313834315, 15372.154531500762, 15391.230438478031, 15393.769093463607, 15395.0, 14434.927825360912, 14435.422583096664, 14443.711125777425, 14596.927015364961, 14727.92636036813, 13159.736805263841, 13218.933905330508, 13322.267275299855, 13376.866231337659, 13460.461581536727, 4515.390422292981, 4561.794719237642, 4578.679492435531, 4741.786619602091, 4750.216214324632, 79985.0, 80667.0, 81146.59426702888, 82107.5894620523, 82220.58889705573, 11704.70738231534, 11710.121740869468, 11734.647960561197, 11854.762904742029, 11972.04223662105, 21543.0, 21570.0, 21646.350609481742, 21681.891590542262, 21726.13095476195, 8469.39335438458, 8494.0, 8620.870686939701, 8793.340499462438, 8869.68956086534, 4840.854774356775, 4842.15262329091, 4925.408950925912, 4975.353204083446, 4989.077020751172, 3348.9665103348657, 3436.0722604897037, 3437.8968630940612, 3438.0889064397957, 3445.7415693822563, 658.3679667519235, 692.9376356127973, 695.3429009585893, 720.5712601002396, 723.0636325957792, 708.0, 734.500539633044, 778.260652380241, 780.8047988003, 788.9487183333065, 9499.192568631745, 9963.202943764481, 10411.583536658449, 10420.426876521864, 10728.89271107279, 683.7094234950126, 700.9158900931819, 703.01398549099, 706.5230969095943, 727.1238158019573, 4813.0, 4976.975115124401, 4978.452370239271, 5022.096022715946, 5025.522575355335, 101667.0, 127480.36259818642, 128963.0, 129994.05008924873, 131714.02428963574, 58542.41457585455, 61136.0, 62136.0, 65304.0, 100845.21685235381, 87812.0, 89105.0, 90547.54726226327, 92448.0, 92692.0, 9820.361676491006, 10031.498425078862, 10109.848352274576, 10303.690889273334, 10337.896621033693, 52498.0, 52505.73747131393, 52551.47448525466, 53827.46172538224, 54487.18269225885, 75882.62058689892, 78898.0, 80765.0, 81081.0, 81378.0, 13466.730665386442, 13565.321733913463, 13776.242306672828, 14317.85682143207, 14374.928125359307, 14791.630209244855, 15676.68646627084, 15714.76427853606, 15908.0, 16029.919850400673, 13048.347582621022, 13063.246000693152, 13073.346332683517, 13320.067595268238, 13958.651033724238, 13586.45654173822, 13740.381682824496, 13743.862561374259, 13897.861021390061, 13957.511487097903, 12494.937525312314, 12557.0, 12606.621801345975, 12955.935220323838, 12972.351382430652, 10975.39635320033, 10993.945030274797, 11100.084280449635, 11127.332360058423, 11405.315681059163, 10903.83644245321, 11562.248453850472, 11790.174687771774, 12026.0, 12075.215111017756], "value": 7776.593021874796, "unit": "score"}], "name": "dromaeo_css", "value": 7326.699672032579, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 111.0, 114.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 118.0, 189.0, 118.0, 118.0, 153.0, 121.0, 158.0, 118.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 163.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 82.0, 133.0, 76.0, 77.0, 75.0, 75.0, 101.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 84.0, 84.0, 84.0, 110.0, 85.0, 83.0, 121.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 147.0, 145.0, 145.0, 146.0, 147.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 98.0, 94.0, 94.0, 97.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 51.0, 52.0, 52.0, 50.0, 50.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 68.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 82.0, 76.0, 75.0, 75.0, 74.0, 80.0, 74.0, 79.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 126.0, 136.0, 130.0, 117.0, 122.0, 127.0, 170.0, 125.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 160.0, 165.0, 161.0, 160.0, 165.0, 160.0, 160.0, 159.0, 156.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 65.0, 62.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1484.7, "alertThreshold": 2.0}]} 05:37:41 INFO - Return code: 0 05:37:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:41 INFO - # TBPL SUCCESS # 05:37:41 INFO - Running post-action listener: _resource_record_post_action 05:37:41 INFO - ##### 05:37:41 INFO - ##### Finished run-tests step (success) 05:37:41 INFO - ##### 05:37:41 INFO - Running post-run listener: _resource_record_post_run 05:37:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 557244416; Read time: 340; Write time: 491788 05:37:41 INFO - TinderboxPrint: CPU usage
13.0% 05:37:41 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 340 05:37:41 INFO - TinderboxPrint: I/O write bytes / time
557,244,416 / 491,788 05:37:41 INFO - TinderboxPrint: CPU idle
8,265.2 (86.9%) 05:37:41 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 05:37:41 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:41 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 256794624; Read time: 152; Write time: 270204 05:37:41 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300449792; Read time: 188; Write time: 221584 05:37:41 INFO - Running post-run listener: _upload_blobber_files 05:37:41 INFO - Blob upload gear active. 05:37:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:41 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 05:37:41 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'] 05:37:41 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 05:37:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:43 INFO - (blobuploader) - INFO - Done attempting. 05:37:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:48 INFO - (blobuploader) - INFO - Done attempting. 05:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:49 INFO - (blobuploader) - INFO - Done attempting. 05:37:49 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:49 INFO - Return code: 0 05:37:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8634393edb837530280f8e0eb3386f4d3dca8516d68c2a8f68711436c0b2f713a0306b79f7786016186f6652e6b95c87556017906588ec2ec5d3f66cbae44e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de3a1534498a298244e94e3206d7626746f84ce8f8cdebd4a3d1b0e0ee2486b932f7340f69b933281e37f5d72ad66d31cfecaaca5c6d4935989d4312c1ae7207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75325747ed610e08fd4a9a79e15c890da72839a8d928ffa38a7ba0a6f7235b3b2c9b08ca71f68b26e7b04152a1bc2d4f211f75d5f2d95ef76691098ebe600a19"} 05:37:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:49 INFO - Contents: 05:37:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8634393edb837530280f8e0eb3386f4d3dca8516d68c2a8f68711436c0b2f713a0306b79f7786016186f6652e6b95c87556017906588ec2ec5d3f66cbae44e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de3a1534498a298244e94e3206d7626746f84ce8f8cdebd4a3d1b0e0ee2486b932f7340f69b933281e37f5d72ad66d31cfecaaca5c6d4935989d4312c1ae7207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75325747ed610e08fd4a9a79e15c890da72839a8d928ffa38a7ba0a6f7235b3b2c9b08ca71f68b26e7b04152a1bc2d4f211f75d5f2d95ef76691098ebe600a19"} 05:37:49 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:49 INFO - Copying logs to upload dir... 05:37:49 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.888096 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-19 05:37:49.328958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 05:37:49.333766) ========= 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=923d835db2ba3686ebe126b700000192-1468927050.351699-162231268 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/8634393edb837530280f8e0eb3386f4d3dca8516d68c2a8f68711436c0b2f713a0306b79f7786016186f6652e6b95c87556017906588ec2ec5d3f66cbae44e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de3a1534498a298244e94e3206d7626746f84ce8f8cdebd4a3d1b0e0ee2486b932f7340f69b933281e37f5d72ad66d31cfecaaca5c6d4935989d4312c1ae7207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75325747ed610e08fd4a9a79e15c890da72839a8d928ffa38a7ba0a6f7235b3b2c9b08ca71f68b26e7b04152a1bc2d4f211f75d5f2d95ef76691098ebe600a19"} build_url:https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011138 build_url: 'https://queue.taskcluster.net/v1/task/dSDEuFMTQdeskTAOq7psgg/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/8634393edb837530280f8e0eb3386f4d3dca8516d68c2a8f68711436c0b2f713a0306b79f7786016186f6652e6b95c87556017906588ec2ec5d3f66cbae44e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de3a1534498a298244e94e3206d7626746f84ce8f8cdebd4a3d1b0e0ee2486b932f7340f69b933281e37f5d72ad66d31cfecaaca5c6d4935989d4312c1ae7207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75325747ed610e08fd4a9a79e15c890da72839a8d928ffa38a7ba0a6f7235b3b2c9b08ca71f68b26e7b04152a1bc2d4f211f75d5f2d95ef76691098ebe600a19"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 05:37:49.359097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:37:49.362483) ========= 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=923d835db2ba3686ebe126b700000192-1468927050.351699-162231268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:37:49.410799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 05:37:49.411122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 05:37:49.414521) ========= ========= Total master_lag: 0.16 =========