builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1473813249.28 results: success (0) buildid: 20160913143812 builduid: f7707af24f03409f81096c74c8cea879 revision: 79429ecdadfa79a101cff2add3d5c1eac5b07e7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.282575) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.283182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.283452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.310975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.311237) ========= 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=00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-13 17:34:09-- 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% 46.9M=0s 2016-09-13 17:34:09 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.455447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.455737) ========= 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=00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.507175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:09.507891) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79429ecdadfa79a101cff2add3d5c1eac5b07e7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79429ecdadfa79a101cff2add3d5c1eac5b07e7f --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=00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-13 17:34:09,666 truncating revision to first 12 chars 2016-09-13 17:34:09,666 Setting DEBUG logging. 2016-09-13 17:34:09,666 attempt 1/10 2016-09-13 17:34:09,666 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/79429ecdadfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 17:34:09,968 unpacking tar archive at: mozilla-aurora-79429ecdadfa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727601 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:10.250481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:10.250893) ========= script_repo_revision: 79429ecdadfa79a101cff2add3d5c1eac5b07e7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:10.251336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:10.251661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 17:34:10.265104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 12 secs) (at 2016-09-13 17:34:10.265411) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:10 INFO - MultiFileLogger online at 20160913 17:34:10 in /builds/slave/test 17:34:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:34:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:10 INFO - {'append_to_log': False, 17:34:10 INFO - 'base_work_dir': '/builds/slave/test', 17:34:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:34:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:10 INFO - 'branch': 'Mozilla-Aurora', 17:34:10 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:10 INFO - 'config_files': ('talos/linux_config.py',), 17:34:10 INFO - 'default_actions': ('clobber', 17:34:10 INFO - 'read-buildbot-config', 17:34:10 INFO - 'download-and-extract', 17:34:10 INFO - 'populate-webroot', 17:34:10 INFO - 'create-virtualenv', 17:34:10 INFO - 'install', 17:34:10 INFO - 'run-tests'), 17:34:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:10 INFO - 'download_minidump_stackwalk': True, 17:34:10 INFO - 'download_symbols': 'ondemand', 17:34:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:10 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:10 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:10 INFO - 'installer_path': 'installer.exe', 17:34:10 INFO - 'log_level': 'info', 17:34:10 INFO - 'log_name': 'talos', 17:34:10 INFO - 'log_to_console': True, 17:34:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:10 INFO - 'opt_config_files': (), 17:34:10 INFO - 'pip_index': False, 17:34:10 INFO - 'sps_profile': False, 17:34:10 INFO - 'sps_profile_interval': 0, 17:34:10 INFO - 'suite': 'dromaeojs-e10s', 17:34:10 INFO - 'system_bits': '32', 17:34:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:10 INFO - 'title': 'talos-linux64-ix-016', 17:34:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:10 INFO - 'use_talos_json': True, 17:34:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:10 INFO - 'work_dir': 'build'} 17:34:10 INFO - [mozharness: 2016-09-14 00:34:10.517793Z] Running clobber step. 17:34:10 INFO - Running pre-action listener: _resource_record_pre_action 17:34:10 INFO - Running main action method: clobber 17:34:10 INFO - rmtree: /builds/slave/test/build 17:34:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:10 INFO - Running post-action listener: _resource_record_post_action 17:34:10 INFO - [mozharness: 2016-09-14 00:34:10.977019Z] Finished clobber step (success) 17:34:10 INFO - [mozharness: 2016-09-14 00:34:10.977129Z] Running read-buildbot-config step. 17:34:10 INFO - Running pre-action listener: _resource_record_pre_action 17:34:10 INFO - Running main action method: read_buildbot_config 17:34:10 INFO - Using buildbot properties: 17:34:10 INFO - { 17:34:10 INFO - "project": "", 17:34:10 INFO - "product": "firefox", 17:34:10 INFO - "script_repo_revision": "production", 17:34:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:34:10 INFO - "repository": "", 17:34:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 17:34:10 INFO - "buildid": "20160913143812", 17:34:10 INFO - "pgo_build": "True", 17:34:10 INFO - "basedir": "/builds/slave/test", 17:34:10 INFO - "buildnumber": 549, 17:34:10 INFO - "slavename": "talos-linux64-ix-016", 17:34:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:34:10 INFO - "platform": "ubuntu64_hw", 17:34:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:34:10 INFO - "branch": "mozilla-aurora", 17:34:10 INFO - "repo_path": "releases/mozilla-aurora", 17:34:10 INFO - "revision": "79429ecdadfa79a101cff2add3d5c1eac5b07e7f", 17:34:10 INFO - "stage_platform": "linux64-pgo", 17:34:10 INFO - "builduid": "f7707af24f03409f81096c74c8cea879", 17:34:10 INFO - "slavebuilddir": "test" 17:34:10 INFO - } 17:34:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 17:34:10 INFO - Running post-action listener: _resource_record_post_action 17:34:10 INFO - [mozharness: 2016-09-14 00:34:10.979562Z] Finished read-buildbot-config step (success) 17:34:10 INFO - [mozharness: 2016-09-14 00:34:10.979652Z] Running download-and-extract step. 17:34:10 INFO - Running pre-action listener: _resource_record_pre_action 17:34:10 INFO - Running main action method: download_and_extract 17:34:10 INFO - mkdir: /builds/slave/test/build/tests 17:34:10 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')]} 17:34:10 INFO - https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:34:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:34:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:34:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:34:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:34:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:34:10 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:34:10 INFO - retry: Failed, sleeping 30 seconds before retrying 17:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 17:34:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:34:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:34:41 INFO - retry: Failed, sleeping 60 seconds before retrying 17:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 17:35:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:35:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:35:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 17:35:41 INFO - Caught exception: HTTP Error 404: Not Found 17:35:41 INFO - Caught exception: HTTP Error 404: Not Found 17:35:41 INFO - Caught exception: HTTP Error 404: Not Found 17:35:41 INFO - trying https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:35:41 INFO - Downloading https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:35:41 INFO - Downloaded 1361 bytes. 17:35:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:35:41 INFO - Using the following test package requirements: 17:35:41 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 17:35:41 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:35:41 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:35:41 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'jsshell-linux-x86_64.zip'], 17:35:41 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:35:41 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 17:35:41 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:35:41 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:35:41 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:35:41 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:35:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:35:41 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:35:41 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')]} 17:35:41 INFO - https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:35:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:35:41 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:35:41 INFO - retry: Failed, sleeping 30 seconds before retrying 17:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 17:36:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:36:11 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:36:11 INFO - retry: Failed, sleeping 60 seconds before retrying 17:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 17:37:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:11 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:37:11 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 17:37:11 INFO - Caught exception: HTTP Error 404: Not Found 17:37:11 INFO - Caught exception: HTTP Error 404: Not Found 17:37:11 INFO - Caught exception: HTTP Error 404: Not Found 17:37:11 INFO - trying https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:11 INFO - Downloading https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:37:13 INFO - Downloaded 21770972 bytes. 17:37:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:37:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:37:14 INFO - Return code: 0 17:37:14 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:37:14 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')]} 17:37:14 INFO - https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:37:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:37:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:37:14 INFO - retry: Failed, sleeping 30 seconds before retrying 17:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 17:37:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:37:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:37:44 INFO - retry: Failed, sleeping 60 seconds before retrying 17:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 17:38:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:38:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:38:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 17:38:44 INFO - Caught exception: HTTP Error 404: Not Found 17:38:44 INFO - Caught exception: HTTP Error 404: Not Found 17:38:44 INFO - Caught exception: HTTP Error 404: Not Found 17:38:44 INFO - trying https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:38:44 INFO - Downloading https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:38:45 INFO - Downloaded 21770972 bytes. 17:38:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:38:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:38:47 INFO - Return code: 0 17:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:47 INFO - https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:38:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:38:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:38:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:38:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:38:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:38:47 INFO - retry: Failed, sleeping 30 seconds before retrying 17:39:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 17:39:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:39:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:39:17 INFO - retry: Failed, sleeping 60 seconds before retrying 17:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 17:40:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:40:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:40:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 17:40:17 INFO - Caught exception: HTTP Error 404: Not Found 17:40:17 INFO - Caught exception: HTTP Error 404: Not Found 17:40:17 INFO - Caught exception: HTTP Error 404: Not Found 17:40:17 INFO - trying https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:40:17 INFO - Downloading https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:40:18 INFO - Downloaded 14413740 bytes. 17:40:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:40:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:40:19 INFO - Return code: 0 17:40:19 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')]} 17:40:19 INFO - https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:40:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:40:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:40:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:40:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:40:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:40:19 INFO - retry: Failed, sleeping 30 seconds before retrying 17:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 17:40:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:40:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:40:49 INFO - retry: Failed, sleeping 60 seconds before retrying 17:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 17:41:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:41:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:41:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 17:41:49 INFO - Caught exception: HTTP Error 404: Not Found 17:41:49 INFO - Caught exception: HTTP Error 404: Not Found 17:41:49 INFO - Caught exception: HTTP Error 404: Not Found 17:41:49 INFO - trying https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:41:49 INFO - Downloading https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:41:50 INFO - Downloaded 63879401 bytes. 17:41:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:41:50 INFO - mkdir: /builds/slave/test/properties 17:41:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:41:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:41:50 INFO - Contents: 17:41:50 INFO - build_url:https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:41:51 INFO - Running post-action listener: _resource_record_post_action 17:41:51 INFO - Running post-action listener: set_extra_try_arguments 17:41:51 INFO - [mozharness: 2016-09-14 00:41:51.064323Z] Finished download-and-extract step (success) 17:41:51 INFO - [mozharness: 2016-09-14 00:41:51.064556Z] Running populate-webroot step. 17:41:51 INFO - Running pre-action listener: _resource_record_pre_action 17:41:51 INFO - Running main action method: populate_webroot 17:41:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:41:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:41:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:41:51 INFO - '--tppagecycles', 17:41:51 INFO - '7'], 17:41:51 INFO - 'tests': ['tsvgm']}}, 17:41:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:41:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:41:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:41:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:41:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['damp', 'tps']}, 17:41:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'tests': ['damp', 'tps']}, 17:41:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['dromaeo_dom']}, 17:41:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:41:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['basic_compositor_video']}, 17:41:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:41:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other-e10s': {'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tsvgx', 17:41:51 INFO - 'tsvgr_opacity', 17:41:51 INFO - 'tart', 17:41:51 INFO - 'tscrollx', 17:41:51 INFO - 'cart']}, 17:41:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:41:51 INFO - 'tsvgr_opacity', 17:41:51 INFO - 'tart', 17:41:51 INFO - 'tscrollx', 17:41:51 INFO - 'cart']}, 17:41:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tp5o']}, 17:41:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'tests': ['tp5o']}, 17:41:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s', 17:41:51 INFO - '--xperf_path', 17:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:51 INFO - 'tests': ['tp5n']}, 17:41:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--xperf_path', 17:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:51 INFO - 'tests': ['tp5n']}}, 17:41:51 INFO - 'talos.zip': {'path': '', 17:41:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:41:51 INFO - Running post-action listener: _resource_record_post_action 17:41:51 INFO - [mozharness: 2016-09-14 00:41:51.085838Z] Finished populate-webroot step (success) 17:41:51 INFO - [mozharness: 2016-09-14 00:41:51.085927Z] Running create-virtualenv step. 17:41:51 INFO - Running pre-action listener: _resource_record_pre_action 17:41:51 INFO - Running main action method: create_virtualenv 17:41:51 INFO - Creating virtualenv /builds/slave/test/build/venv 17:41:51 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 17:41:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:41:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:41:51 INFO - Using real prefix '/usr' 17:41:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:41:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:41:53 INFO - Installing pip.................done. 17:41:53 INFO - Return code: 0 17:41:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:53 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')]} 17:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:53 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')]} 17:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:53 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:41:53 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 17:41:53 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 17:41:53 INFO - Using env: {'DISPLAY': ':0', 17:41:53 INFO - 'HOME': '/home/cltbld', 17:41:53 INFO - 'LANG': 'en_US.UTF-8', 17:41:53 INFO - 'LANGUAGE': 'en_US:en', 17:41:53 INFO - 'LOGNAME': 'cltbld', 17:41:53 INFO - 'MAIL': '/var/mail/cltbld', 17:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:53 INFO - 'MOZ_NO_REMOTE': '1', 17:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:53 INFO - 'NO_EM_RESTART': '1', 17:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:53 INFO - 'PWD': '/builds/slave/test', 17:41:53 INFO - 'SHELL': '/bin/bash', 17:41:53 INFO - 'SHLVL': '1', 17:41:53 INFO - 'TERM': 'linux', 17:41:53 INFO - 'TMOUT': '86400', 17:41:53 INFO - 'USER': 'cltbld', 17:41:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:53 INFO - '_': '/tools/buildbot/bin/python'} 17:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:53 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 17:41:53 INFO - Cleaning up... 17:41:53 INFO - Return code: 0 17:41:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:41:53 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')]} 17:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:53 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')]} 17:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:53 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:41:53 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 17:41:53 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 17:41:53 INFO - Using env: {'DISPLAY': ':0', 17:41:53 INFO - 'HOME': '/home/cltbld', 17:41:53 INFO - 'LANG': 'en_US.UTF-8', 17:41:53 INFO - 'LANGUAGE': 'en_US:en', 17:41:53 INFO - 'LOGNAME': 'cltbld', 17:41:53 INFO - 'MAIL': '/var/mail/cltbld', 17:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:53 INFO - 'MOZ_NO_REMOTE': '1', 17:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:53 INFO - 'NO_EM_RESTART': '1', 17:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:53 INFO - 'PWD': '/builds/slave/test', 17:41:53 INFO - 'SHELL': '/bin/bash', 17:41:53 INFO - 'SHLVL': '1', 17:41:53 INFO - 'TERM': 'linux', 17:41:53 INFO - 'TMOUT': '86400', 17:41:53 INFO - 'USER': 'cltbld', 17:41:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:53 INFO - '_': '/tools/buildbot/bin/python'} 17:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:54 INFO - Downloading/unpacking psutil>=3.1.1 17:41:54 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 17:41:54 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 17:41:54 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 17:41:54 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 17:41:54 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 17:41:54 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 17:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:56 INFO - Installing collected packages: psutil 17:41:56 INFO - Running setup.py install for psutil 17:41:56 INFO - building 'psutil._psutil_linux' extension 17:41:56 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 17:41:56 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 17:41:56 INFO - building 'psutil._psutil_posix' extension 17:41:56 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 17:41:56 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 17:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:56 INFO - Successfully installed psutil 17:41:56 INFO - Cleaning up... 17:41:56 INFO - Return code: 0 17:41:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:41:56 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')]} 17:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:56 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')]} 17:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:56 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:41:56 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 17:41:56 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 17:41:56 INFO - Using env: {'DISPLAY': ':0', 17:41:56 INFO - 'HOME': '/home/cltbld', 17:41:56 INFO - 'LANG': 'en_US.UTF-8', 17:41:56 INFO - 'LANGUAGE': 'en_US:en', 17:41:56 INFO - 'LOGNAME': 'cltbld', 17:41:56 INFO - 'MAIL': '/var/mail/cltbld', 17:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:56 INFO - 'MOZ_NO_REMOTE': '1', 17:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:56 INFO - 'NO_EM_RESTART': '1', 17:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:56 INFO - 'PWD': '/builds/slave/test', 17:41:56 INFO - 'SHELL': '/bin/bash', 17:41:56 INFO - 'SHLVL': '1', 17:41:56 INFO - 'TERM': 'linux', 17:41:56 INFO - 'TMOUT': '86400', 17:41:56 INFO - 'USER': 'cltbld', 17:41:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:56 INFO - '_': '/tools/buildbot/bin/python'} 17:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:41:56 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 17:41:56 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 17:41:56 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 17:41:56 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 17:41:56 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 17:41:56 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 17:41:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:41:58 INFO - Installing collected packages: mozsystemmonitor 17:41:58 INFO - Running setup.py install for mozsystemmonitor 17:41:58 INFO - Successfully installed mozsystemmonitor 17:41:58 INFO - Cleaning up... 17:41:58 INFO - Return code: 0 17:41:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:41:58 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')]} 17:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:58 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')]} 17:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:58 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:41:58 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 17:41:58 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 17:41:58 INFO - Using env: {'DISPLAY': ':0', 17:41:58 INFO - 'HOME': '/home/cltbld', 17:41:58 INFO - 'LANG': 'en_US.UTF-8', 17:41:58 INFO - 'LANGUAGE': 'en_US:en', 17:41:58 INFO - 'LOGNAME': 'cltbld', 17:41:58 INFO - 'MAIL': '/var/mail/cltbld', 17:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:58 INFO - 'MOZ_NO_REMOTE': '1', 17:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:58 INFO - 'NO_EM_RESTART': '1', 17:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:58 INFO - 'PWD': '/builds/slave/test', 17:41:58 INFO - 'SHELL': '/bin/bash', 17:41:58 INFO - 'SHLVL': '1', 17:41:58 INFO - 'TERM': 'linux', 17:41:58 INFO - 'TMOUT': '86400', 17:41:58 INFO - 'USER': 'cltbld', 17:41:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:58 INFO - '_': '/tools/buildbot/bin/python'} 17:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:59 INFO - Downloading/unpacking jsonschema==2.5.1 17:41:59 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 17:41:59 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 17:41:59 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 17:41:59 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 17:41:59 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 17:41:59 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 17:42:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:01 INFO - warning: no files found matching '*.txt' 17:42:01 INFO - no previously-included directories found matching 'build' 17:42:01 INFO - no previously-included directories found matching 'dist' 17:42:01 INFO - no previously-included directories found matching '.git*' 17:42:01 INFO - Installing collected packages: jsonschema, functools32 17:42:01 INFO - Running setup.py install for functools32 17:42:01 INFO - warning: no files found matching '*.txt' 17:42:01 INFO - no previously-included directories found matching 'build' 17:42:01 INFO - no previously-included directories found matching 'dist' 17:42:01 INFO - no previously-included directories found matching '.git*' 17:42:01 INFO - Successfully installed jsonschema functools32 17:42:01 INFO - Cleaning up... 17:42:01 INFO - Return code: 0 17:42:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42:01 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')]} 17:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:01 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')]} 17:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:01 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:42:01 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:42:01 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 functools32==3.2.3-2 17:42:01 INFO - Using env: {'DISPLAY': ':0', 17:42:01 INFO - 'HOME': '/home/cltbld', 17:42:01 INFO - 'LANG': 'en_US.UTF-8', 17:42:01 INFO - 'LANGUAGE': 'en_US:en', 17:42:01 INFO - 'LOGNAME': 'cltbld', 17:42:01 INFO - 'MAIL': '/var/mail/cltbld', 17:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:01 INFO - 'MOZ_NO_REMOTE': '1', 17:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:01 INFO - 'NO_EM_RESTART': '1', 17:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:01 INFO - 'PWD': '/builds/slave/test', 17:42:01 INFO - 'SHELL': '/bin/bash', 17:42:01 INFO - 'SHLVL': '1', 17:42:01 INFO - 'TERM': 'linux', 17:42:01 INFO - 'TMOUT': '86400', 17:42:01 INFO - 'USER': 'cltbld', 17:42:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:01 INFO - '_': '/tools/buildbot/bin/python'} 17:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:01 INFO - Cleaning up... 17:42:01 INFO - Return code: 0 17:42:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:01 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')]} 17:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:01 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')]} 17:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:01 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:42:01 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 17:42:01 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 17:42:01 INFO - Using env: {'DISPLAY': ':0', 17:42:01 INFO - 'HOME': '/home/cltbld', 17:42:01 INFO - 'LANG': 'en_US.UTF-8', 17:42:01 INFO - 'LANGUAGE': 'en_US:en', 17:42:01 INFO - 'LOGNAME': 'cltbld', 17:42:01 INFO - 'MAIL': '/var/mail/cltbld', 17:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:01 INFO - 'MOZ_NO_REMOTE': '1', 17:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:01 INFO - 'NO_EM_RESTART': '1', 17:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:01 INFO - 'PWD': '/builds/slave/test', 17:42:01 INFO - 'SHELL': '/bin/bash', 17:42:01 INFO - 'SHLVL': '1', 17:42:01 INFO - 'TERM': 'linux', 17:42:01 INFO - 'TMOUT': '86400', 17:42:01 INFO - 'USER': 'cltbld', 17:42:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:01 INFO - '_': '/tools/buildbot/bin/python'} 17:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 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 17:42:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:03 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 17:42:03 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 17:42:03 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 17:42:03 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 17:42:03 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 17:42:03 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 17:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:04 INFO - Downloading docopt-0.6.1.tar.gz 17:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:04 INFO - Running setup.py install for blobuploader 17:42:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:04 INFO - Running setup.py install for requests 17:42:05 INFO - Running setup.py install for docopt 17:42:05 INFO - Successfully installed blobuploader requests docopt 17:42:05 INFO - Cleaning up... 17:42:05 INFO - Return code: 0 17:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:05 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')]} 17:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:05 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')]} 17:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:05 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:42:05 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 17:42:05 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 17:42:05 INFO - Using env: {'DISPLAY': ':0', 17:42:05 INFO - 'HOME': '/home/cltbld', 17:42:05 INFO - 'LANG': 'en_US.UTF-8', 17:42:05 INFO - 'LANGUAGE': 'en_US:en', 17:42:05 INFO - 'LOGNAME': 'cltbld', 17:42:05 INFO - 'MAIL': '/var/mail/cltbld', 17:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:05 INFO - 'MOZ_NO_REMOTE': '1', 17:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:05 INFO - 'NO_EM_RESTART': '1', 17:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:05 INFO - 'PWD': '/builds/slave/test', 17:42:05 INFO - 'SHELL': '/bin/bash', 17:42:05 INFO - 'SHLVL': '1', 17:42:05 INFO - 'TERM': 'linux', 17:42:05 INFO - 'TMOUT': '86400', 17:42:05 INFO - 'USER': 'cltbld', 17:42:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:05 INFO - '_': '/tools/buildbot/bin/python'} 17:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:05 INFO - Running setup.py (path:/tmp/pip-mCXQoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:05 INFO - Running setup.py (path:/tmp/pip-z_RePL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:05 INFO - Running setup.py (path:/tmp/pip-YSiF59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:05 INFO - Running setup.py (path:/tmp/pip-VJrnyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:05 INFO - Running setup.py (path:/tmp/pip-5cSPBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:05 INFO - Running setup.py (path:/tmp/pip-BVHsuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:05 INFO - Running setup.py (path:/tmp/pip-emx6u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:05 INFO - Running setup.py (path:/tmp/pip-gr41to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:06 INFO - Running setup.py (path:/tmp/pip-lG8XG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:06 INFO - Running setup.py (path:/tmp/pip-6CIkvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:06 INFO - Running setup.py (path:/tmp/pip-YGenw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:06 INFO - Running setup.py (path:/tmp/pip-XfWQNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:06 INFO - Running setup.py (path:/tmp/pip-2gchYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:06 INFO - Running setup.py (path:/tmp/pip-n0ZG0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:06 INFO - Running setup.py (path:/tmp/pip-5w5QeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:06 INFO - Running setup.py (path:/tmp/pip-z6KkCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:06 INFO - Running setup.py (path:/tmp/pip-SST0Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:06 INFO - Running setup.py install for manifestparser 17:42:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:06 INFO - Running setup.py install for mozcrash 17:42:06 INFO - Running setup.py install for mozdebug 17:42:06 INFO - Running setup.py install for mozdevice 17:42:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Running setup.py install for mozfile 17:42:07 INFO - Running setup.py install for mozhttpd 17:42:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Running setup.py install for mozinfo 17:42:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Running setup.py install for mozInstall 17:42:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Running setup.py install for mozleak 17:42:07 INFO - Running setup.py install for mozlog 17:42:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Running setup.py install for moznetwork 17:42:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:07 INFO - Running setup.py install for mozprocess 17:42:07 INFO - Running setup.py install for mozprofile 17:42:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:08 INFO - Running setup.py install for mozrunner 17:42:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:08 INFO - Running setup.py install for mozscreenshot 17:42:08 INFO - Running setup.py install for moztest 17:42:08 INFO - Running setup.py install for mozversion 17:42:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:08 INFO - Cleaning up... 17:42:08 INFO - Return code: 0 17:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:08 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:42:08 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 17:42:08 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 17:42:08 INFO - Using env: {'DISPLAY': ':0', 17:42:08 INFO - 'HOME': '/home/cltbld', 17:42:08 INFO - 'LANG': 'en_US.UTF-8', 17:42:08 INFO - 'LANGUAGE': 'en_US:en', 17:42:08 INFO - 'LOGNAME': 'cltbld', 17:42:08 INFO - 'MAIL': '/var/mail/cltbld', 17:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:08 INFO - 'MOZ_NO_REMOTE': '1', 17:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:08 INFO - 'NO_EM_RESTART': '1', 17:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:08 INFO - 'PWD': '/builds/slave/test', 17:42:08 INFO - 'SHELL': '/bin/bash', 17:42:08 INFO - 'SHLVL': '1', 17:42:08 INFO - 'TERM': 'linux', 17:42:08 INFO - 'TMOUT': '86400', 17:42:08 INFO - 'USER': 'cltbld', 17:42:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:08 INFO - '_': '/tools/buildbot/bin/python'} 17:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:08 INFO - Running setup.py (path:/tmp/pip-06irvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:08 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)) 17:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:08 INFO - Running setup.py (path:/tmp/pip-jLOukr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:08 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)) 17:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:08 INFO - Running setup.py (path:/tmp/pip-KxKR6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:08 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)) 17:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:08 INFO - Running setup.py (path:/tmp/pip-A2WmTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:08 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)) 17:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:08 INFO - Running setup.py (path:/tmp/pip-e2YO_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:09 INFO - Running setup.py (path:/tmp/pip-LM1Rjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:09 INFO - Running setup.py (path:/tmp/pip-CrUinR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:09 INFO - Running setup.py (path:/tmp/pip-3eGDql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:09 INFO - Running setup.py (path:/tmp/pip-TOqhvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:09 INFO - Running setup.py (path:/tmp/pip-RpbL7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:09 INFO - Running setup.py (path:/tmp/pip-5l1eum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:09 INFO - Running setup.py (path:/tmp/pip-Vi8Flk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:09 INFO - Running setup.py (path:/tmp/pip-_w01gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:09 INFO - Running setup.py (path:/tmp/pip-ka_J9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:09 INFO - Running setup.py (path:/tmp/pip-0MPTft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:09 INFO - Running setup.py (path:/tmp/pip-LVjdot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:09 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)) 17:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:09 INFO - Running setup.py (path:/tmp/pip-lhKhC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:09 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)) 17:42:09 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)) 17:42:09 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)) 17:42:09 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)) 17:42:09 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)) 17:42:09 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)) 17:42:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:09 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 17:42:09 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 17:42:09 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 17:42:09 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 17:42:09 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 17:42:09 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 17:42:11 INFO - Downloading blessings-1.6.tar.gz 17:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:11 INFO - Installing collected packages: blessings 17:42:11 INFO - Running setup.py install for blessings 17:42:11 INFO - Successfully installed blessings 17:42:11 INFO - Cleaning up... 17:42:12 INFO - Return code: 0 17:42:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:12 INFO - Reading from file tmpfile_stdout 17:42:12 INFO - Current package versions: 17:42:12 INFO - argparse == 1.2.1 17:42:12 INFO - blessings == 1.6 17:42:12 INFO - blobuploader == 1.2.4 17:42:12 INFO - docopt == 0.6.1 17:42:12 INFO - functools32 == 3.2.3-2 17:42:12 INFO - jsonschema == 2.5.1 17:42:12 INFO - manifestparser == 1.1 17:42:12 INFO - mozInstall == 1.12 17:42:12 INFO - mozcrash == 0.17 17:42:12 INFO - mozdebug == 0.1 17:42:12 INFO - mozdevice == 0.48 17:42:12 INFO - mozfile == 1.2 17:42:12 INFO - mozhttpd == 0.7 17:42:12 INFO - mozinfo == 0.9 17:42:12 INFO - mozleak == 0.1 17:42:12 INFO - mozlog == 3.3 17:42:12 INFO - moznetwork == 0.27 17:42:12 INFO - mozprocess == 0.23 17:42:12 INFO - mozprofile == 0.28 17:42:12 INFO - mozrunner == 6.12 17:42:12 INFO - mozscreenshot == 0.1 17:42:12 INFO - mozsystemmonitor == 0.3 17:42:12 INFO - moztest == 0.7 17:42:12 INFO - mozversion == 1.4 17:42:12 INFO - psutil == 3.1.1 17:42:12 INFO - requests == 1.2.3 17:42:12 INFO - wsgiref == 0.1.2 17:42:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:12 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')]} 17:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:12 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')]} 17:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:12 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:42:12 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 17:42:12 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 17:42:12 INFO - Using env: {'DISPLAY': ':0', 17:42:12 INFO - 'HOME': '/home/cltbld', 17:42:12 INFO - 'LANG': 'en_US.UTF-8', 17:42:12 INFO - 'LANGUAGE': 'en_US:en', 17:42:12 INFO - 'LOGNAME': 'cltbld', 17:42:12 INFO - 'MAIL': '/var/mail/cltbld', 17:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:12 INFO - 'MOZ_NO_REMOTE': '1', 17:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:12 INFO - 'NO_EM_RESTART': '1', 17:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:12 INFO - 'PWD': '/builds/slave/test', 17:42:12 INFO - 'SHELL': '/bin/bash', 17:42:12 INFO - 'SHLVL': '1', 17:42:12 INFO - 'TERM': 'linux', 17:42:12 INFO - 'TMOUT': '86400', 17:42:12 INFO - 'USER': 'cltbld', 17:42:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:12 INFO - '_': '/tools/buildbot/bin/python'} 17:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 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)) 17:42:12 INFO - Cleaning up... 17:42:12 INFO - Return code: 0 17:42:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42:12 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')]} 17:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:12 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')]} 17:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:12 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 0xb71030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, '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': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', '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 17:42:12 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 17:42:12 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 17:42:12 INFO - Using env: {'DISPLAY': ':0', 17:42:12 INFO - 'HOME': '/home/cltbld', 17:42:12 INFO - 'LANG': 'en_US.UTF-8', 17:42:12 INFO - 'LANGUAGE': 'en_US:en', 17:42:12 INFO - 'LOGNAME': 'cltbld', 17:42:12 INFO - 'MAIL': '/var/mail/cltbld', 17:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:12 INFO - 'MOZ_NO_REMOTE': '1', 17:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:12 INFO - 'NO_EM_RESTART': '1', 17:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:12 INFO - 'PWD': '/builds/slave/test', 17:42:12 INFO - 'SHELL': '/bin/bash', 17:42:12 INFO - 'SHLVL': '1', 17:42:12 INFO - 'TERM': 'linux', 17:42:12 INFO - 'TMOUT': '86400', 17:42:12 INFO - 'USER': 'cltbld', 17:42:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:12 INFO - '_': '/tools/buildbot/bin/python'} 17:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:42:12 INFO - Cleaning up... 17:42:12 INFO - Return code: 0 17:42:12 INFO - Running post-action listener: _resource_record_post_action 17:42:12 INFO - Running post-action listener: _start_resource_monitoring 17:42:12 INFO - Starting resource monitoring. 17:42:12 INFO - [mozharness: 2016-09-14 00:42:12.741772Z] Finished create-virtualenv step (success) 17:42:12 INFO - [mozharness: 2016-09-14 00:42:12.742204Z] Running install step. 17:42:12 INFO - Running pre-action listener: _resource_record_pre_action 17:42:12 INFO - Running main action method: install 17:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:12 INFO - Reading from file tmpfile_stdout 17:42:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:13 INFO - Reading from file tmpfile_stdout 17:42:13 INFO - Output received: 17:42:13 INFO - Usage: mozinstall [options] installer 17:42:13 INFO - Options: 17:42:13 INFO - -h, --help show this help message and exit 17:42:13 INFO - -d DEST, --destination=DEST 17:42:13 INFO - Directory to install application into. [default: 17:42:13 INFO - "/builds/slave/test"] 17:42:13 INFO - --app=APP Application being installed. [default: firefox] 17:42:13 INFO - mkdir: /builds/slave/test/build/application 17:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:42:29 INFO - Reading from file tmpfile_stdout 17:42:29 INFO - Output received: 17:42:29 INFO - /builds/slave/test/build/application/firefox/firefox 17:42:29 INFO - Running post-action listener: _resource_record_post_action 17:42:29 INFO - [mozharness: 2016-09-14 00:42:29.652504Z] Finished install step (success) 17:42:29 INFO - [mozharness: 2016-09-14 00:42:29.652785Z] Running run-tests step. 17:42:29 INFO - Running pre-action listener: _resource_record_pre_action 17:42:29 INFO - Running main action method: run_tests 17:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:29 INFO - Python 2.7.3 17:42:29 INFO - Return code: 0 17:42:29 INFO - grabbing minidump binary from tooltool 17:42:29 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')]} 17:42:29 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 0xe2f570>, '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 0xe30470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:29 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 17:42:29 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 17:42:29 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 17:42:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:29 INFO - Return code: 0 17:42:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:42:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:42:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:42:29 INFO - Using env: {'DISPLAY': ':0', 17:42:29 INFO - 'HOME': '/home/cltbld', 17:42:29 INFO - 'LANG': 'en_US.UTF-8', 17:42:29 INFO - 'LANGUAGE': 'en_US:en', 17:42:29 INFO - 'LOGNAME': 'cltbld', 17:42:29 INFO - 'MAIL': '/var/mail/cltbld', 17:42:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:29 INFO - 'MOZ_NO_REMOTE': '1', 17:42:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:29 INFO - 'NO_EM_RESTART': '1', 17:42:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:29 INFO - 'PWD': '/builds/slave/test', 17:42:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:29 INFO - 'SHELL': '/bin/bash', 17:42:29 INFO - 'SHLVL': '1', 17:42:29 INFO - 'TERM': 'linux', 17:42:29 INFO - 'TMOUT': '86400', 17:42:29 INFO - 'USER': 'cltbld', 17:42:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470', 17:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:29 INFO - '_': '/tools/buildbot/bin/python'} 17:42:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:42:29 INFO - mozversion application_buildid: 20160913143812 17:42:29 INFO - mozversion application_changeset: 79429ecdadfa79a101cff2add3d5c1eac5b07e7f 17:42:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:42:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:29 INFO - mozversion application_name: Firefox 17:42:29 INFO - mozversion application_remotingname: firefox-dev 17:42:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:42:29 INFO - mozversion application_vendor: Mozilla 17:42:29 INFO - mozversion application_version: 50.0a2 17:42:29 INFO - mozversion platform_buildid: 20160913143812 17:42:29 INFO - mozversion platform_changeset: 79429ecdadfa79a101cff2add3d5c1eac5b07e7f 17:42:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:42:29 INFO - mozversion platform_version: 50.0a2 17:42:29 INFO - using testdate: 1473813749 17:42:29 INFO - actual date: 1473813749 17:42:29 INFO - starting webserver on 'localhost:44976' 17:42:29 INFO - SUITE-START | Running 2 tests 17:42:29 INFO - TEST-START | dromaeo_css 17:42:29 INFO - operating with platform_type : linux_ 17:42:29 INFO - Initialising browser for dromaeo_css test... 17:42:29 INFO - TEST-INFO | started process 6238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTyGNtr/profile http://localhost:44976/getInfo.html) 17:42:34 INFO - PROCESS | 6238 | __metrics Screen width/height:1600/1200 17:42:34 INFO - PROCESS | 6238 | colorDepth:24 17:42:34 INFO - PROCESS | 6238 | Browser inner width/height: 1024/697 17:42:34 INFO - PROCESS | 6238 | __metrics 17:42:35 ERROR - PROCESS | 6238 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:42:35 INFO - TEST-INFO | 6238: exit 0 17:42:35 INFO - Browser initialized. 17:42:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:35 INFO - TEST-INFO | started process 6366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTyGNtr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:47 INFO - PROCESS | 6366 | RSS: Main: 153395200 17:42:47 INFO - PROCESS | 6366 | 17:43:37 INFO - PROCESS | 6366 | 1473813817262 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] 17:45:45 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44976/tests/dromaeo/cssquery-ext.html) 17:45:46 INFO - PROCESS | 6366 | RSS: Main: 160743424 17:45:46 INFO - PROCESS | 6366 | 17:48:48 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-ext.html (next: http://localhost:44976/tests/dromaeo/cssquery-jquery.html) 17:48:49 INFO - PROCESS | 6366 | RSS: Main: 156041216 17:48:49 INFO - PROCESS | 6366 | 17:51:51 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44976/tests/dromaeo/cssquery-mootools.html) 17:51:51 INFO - PROCESS | 6366 | RSS: Main: 155860992 17:51:51 INFO - PROCESS | 6366 | 17:54:53 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44976/tests/dromaeo/cssquery-prototype.html) 17:54:54 INFO - PROCESS | 6366 | RSS: Main: 154320896 17:54:54 INFO - PROCESS | 6366 | 17:57:56 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44976/tests/dromaeo/cssquery-yui.html) 17:57:57 INFO - PROCESS | 6366 | RSS: Main: 156876800 17:57:57 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-yui.html (next: http://localhost:44976/tests/dromaeo/cssquery-dojo.html) 18:00:59 INFO - PROCESS | 6366 | RSS: Main: 158212096 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | __start_tp_report 18:00:59 INFO - PROCESS | 6366 | _x_x_mozilla_page_load 18:00:59 INFO - PROCESS | 6366 | _x_x_mozilla_page_load_details 18:00:59 INFO - PROCESS | 6366 | |i|pagename|runs| 18:00:59 INFO - PROCESS | 6366 | |0;dojo.html;3226.596675415573;3356.7482438817096;3369.393509168349;3375.6793104655067;3377.9155521111984;5846.21076154719;5888.793892213774;5914.378990206031;5925.585209035369;5937.495312898409;5730.05454100074;5798.5361171106315;5824.854378640536;5831.591788574801;5837;5254.973725131378;5305.973470132644;5337.06601344765;5340.893182136355;5350.27771250882;5228.137357336035;5248.973755131238;5262.079136151158;5262.684238945656;5310.575153987672;5303.814366497173;5328.094223981913;5335.413104558495;5346.331708536433;5396.946030539683;5394.730263486829;5395.460453954613;5399.676019438826;5400.567954563626;5404.297441332641;5047.899042019176;5075.0357432087785;5230.032443997835;5296.205569164617;5390.4879036491475;5121.795128194868;5630.577706672016;5646.124850648156;5700.629459085188;5805.216295800055;6164.87670246597;6194.783182588633;6203.534734894901;6213.689315534205;6213.813585592439;6230.937690623081;6242.250929888442;6254.280757712831;6258.092576576371;6266.717997690069;5582.91625625616;5670.149477578355;5691.06097493913;5703.258576385043;5805.332386775491;6268.373162683786;6296.496280297565;6296.748130074838;6307.621542707452;6319.273283572448;6005.6997150142315;6022.608530445507;6038.033914573735;6076.210092687922;6080.635161890301;5976.671283079472;6002.429769171922;6009.699515024231;6012;6114.38856114385;6016.8796624068145;6034.577579569388;6042.6978651067275;6043.214382130295;6048.727807248684;5989.8203053908455;6019.067044608093;6055.969720151371;6071.939280607137;6091;4637.281221410687;4665.533446655308;4676.041411510632;4717.410323709536;4784.9951510182555;4190.53904070552;4203.306454434984;4217.388478670576;4218.557051509609;4243.724157929724;5918.852028699317;5980.312264089598;5988;5996.1005849122985;5996.760129594854;6149.569530132848;6189.783357582463;6194.163787888668;6270.059491076375;6270.843228919313;5970.671613061323;5983.341832398432;5989.520838332923;6008.289352058917;6046.183765191643;5289.338832645919;5374.3013408256675;5391.973040134774;5406.540444062299;5414.945850541444;6292.811215663537;6311.400416960381;6329.367063293634;6423.4861211103;6426.228852537725;6193.163922870445;6198.163247961467;6202.255729312511;6222.751089956351;6234.407731265523;6200.255969283715;6416.037594360883;6422.839429014312;6424.614523128627;6430.582012169194;6001.009833377619;6009.308929473166;6047.5464340173785;6115.938840611537;6117.357677443804;6195.3312718863535;6203.596766210182;6204.565680402328;6211.378862113753;6228.626282423069;5914.556408269311;6025.126356678169;6092.390760923872;6099.3900609938655;6115.1438798569125;6078.027515597483;6090.269167699905;6105.755769769159;6168.784092556739;6174.166487524127;5995.61028533144;6034.668093254913;6085.417791374363;6103.847403814762;6115.052166914135;5931.733072011683;6155.446009859134;6202.4417802398;6210.31686514474;6211.565190436807;5944.405559444021;5949.405059494016;5997.610155339889;6068.848278793065;6100.786472473442 18:00:59 INFO - PROCESS | 6366 | |1;ext.html;562.6848964579835;600.1298117729292;616.6392660293725;623.8128561431571;682.113252771397;39735.80132099339;43953.7802310988;44157;44174.11651766967;44269.33595996063;44913.7754311228;45317.546824531746;45499.77250113753;45520.54479455204;45614;8904.910950890473;9033.864492032624;9054.4114632549;9055.049219831888;9060.229880460136;9065.229455496257;9117.772055698595;9166.450012999208;9168.679096231634;9180.403273787217;9174.449533028006;9202;9239.122283383067;9245.72262832116;9251.768705782342;9151.542422878829;9160.312976526788;9205.171534561889;9229.03095175007;9255.907440925572;9002.27981761464;9106.63573457061;9108.8633670495;9132.908670913339;9147.54262286883;42877.35683964743;43163.35254971178;43465.78267108676;43487.78256108731;43568.564314357085;4012.217617564576;4037.394390841368;4067.2475592015276;4253.893652658678;4283.443152390169;34270.48594271088;34582.308353832785;34670.47994280062;35005.47491787625;35019.29961400783;4656.790444429975;4700.083483720676;4705.835295764632;4722.386089808338;4729.739864307462;381541;390538;391658;525218;527479.9999999962;65306.67346663236;66098.33901661017;66151.33848661548;66226.33773662298;66239.33760662332;34588.13529661779;35529.64470355315;68666;69300.30699692939;69319;17138;17186.31254749796;17276.827231727773;17280.567985800204;17329.826701733073;12987.960963122927;13012.934935325262;13056.08607397492;13086.607401777961;13098.738025239632;19470.20264598915;19732.50668733293;19741.40775776729;19812.108455119553;20046.89976550108;7172.856542869218;7227.7831665050135;7333.266673332624;7361.926380736231;7508.924910750932;1011.7875246198233;1056.0126281926423;1104.1553211792984;1107.5293000474767;1114.6433141394675;31440.52839207414;31548;31581;32004.879829205867;32144.83927580394;1140.7604403075281;1144.6852115668091;1194.5759255464186;1194.7371578252944;1214.0348423003734;16337.834539577023;16638.334466621443;17195.656086878193;17220.569485762957;17347.306107755547;501686;503500;503773;504799;505973;58058.7097064512;58071.709641451525;58688.70655646695;58772.41227587755;58837;1439.834433822809;1457.9125252484885;1459.4745891479058;1475.4835807467516;1483.0879009409352;30677.386452271276;30833.920812771445;30942;31646.36707265888;31837.68162318347;50806.49193508018;57639.423605765085;59362.70318648379;59531.404685954316;64482;448880;449302;450629;452426;452596;46415.07169856651;46770;47222.52777472181;47299;47964.040719184726;50613.964906351925;50975.49024509856;51040.48959510357;51569.48430515797;52234.73882630563;43041.78479107584;43875.341869871336;44228.33657495076;44571.55428445674;44839.775801120784;43513;43700.78149609359;44070.33894491521;44205.55794442014;44994;42889.78555107205;43731.562684374025;43768.12463750644;43835.56164438443;45763.54236457593;35928.4610730834;37256.44115338326;37651.623483764815;38080;38300.6169938297;28240.0443749281;29418.852905735333;29626.555601666423;29857.25356866096;29950.70049299479 18:00:59 INFO - PROCESS | 6366 | |2;jquery.html;402.79054891456445;418.40377462116516;421.61632914048215;422.1599017954271;430.5930895303937;19391.321303754372;20563.897180514115;21116.89441552794;22175.44561385966;22634;19615.509612259702;20205.797942020614;20448;20589.38231853043;21273.787262127375;5489.423610520887;5660.235868157787;5664.490195882369;5670.858228544299;5686.147077938301;5599.440055994409;5617.269754931853;5640.887182256373;6076.2708474983065;6139.6316221026655;5943.316518600352;6028.125921741344;6029.974904266263;6051.818445446622;6132.233470816148;5466.1527463243265;5550.888982220333;5579.218909352714;5841.503472204868;6082.878342433149;5432.864178395532;5467.589930755209;5478.671279723229;5484.643498172606;5512.283403157564;13606.93196534011;13621.387037583332;13721.45114195431;13733.381997810022;13796.517121900686;2469.77772000519;2471.7033955925403;2573.099415204682;2724.945501089967;2877.3525956659582;11142.554297828077;11369.317840929489;12198.451069701885;15267.236638168048;15368.231588420535;1990.7511561054869;2036.1651722793583;2060.804223598771;2068.6069646767064;2151.66649169379;83926;85862.99999999937;86483.56758216232;88038;89054;11234.438278086227;11531.365774882293;11662.416879156008;11699.06407487399;11764.58823941158;16540.6691866162;16569.171541422882;16607.41874034403;16629.750553741702;16661.6667666646;8174.713885013996;8176.7955801105445;8215.219554142346;8315.334773218128;8561.529115898686;7793.220677932161;7965.4822436541435;8056.798580035546;8102.108768035511;8128.431009829255;4953.0589188054155;4968.105740966588;4998.550130488274;5034.446210916796;5107.591392688576;1964.1063316191098;2068.2347531413475;2068.813806757399;2152.1176317709665;2196.8572042817163;927.4435338796668;980.8921018687938;1009.1976878381704;1047.2512153810062;1047.5495536919045;19242.903785480983;19380.2247910082;20337.288194913108;20356.083976221107;20520.179192832118;1046.5029111172285;1049.6850944716555;1050.417018554694;1073.6510634043966;1074.9408782517037;10533.262671612914;11271.718207044889;11273.718157045976;11302;11306.604268850551;513418;517537;518684;542655;566674;92542;106709.46645266724;110360;110463;111027;1040.4953597505205;1047.3035431438009;1103.2828661370174;1106.9335839849634;1116.905063069632;18323.35868244605;18615.44153675392;18727.71908421402;19180;19262.22951081941;46325.76837115793;46533.534664654275;46721;47237.763811180725;48163.518364817304;66440.66779666071;67045.66477167583;67086;67300.32699673137;68623.65688171727;8476.703315384178;8510.191531804468;8670.913290867264;8767.517786521803;8793.736187914374;9716.126132874111;12682.809757853454;13111.475540978636;13206.867931320949;13357.265350405822;11932.76134477323;12111.454984525893;12148.453319600816;12333.198342107735;12435.93782031084;11719.472623732123;11840.467178976794;11846.585369512026;11869.643910682693;12031.398430078636;12107.394630268627;12160.391980401122;12358.320292384005;12408;12440.129190956546;8594.570271486526;8619.470260685812;8697.52163630981;8874.733757987271;9152.313576481658;11463.713407164887;11579.13156513248;11593.420328983686;12285.938570307091;12382 18:00:59 INFO - PROCESS | 6366 | |3;mootools.html;1527.5493729349841;1528.831828498865;1695.3727120965236;1829.7529833472477;1851.694470412382;8553.444026138297;8969.730908072752;9027.187553120219;9612.807743845127;9725.756856078602;9164.908350916488;9457.33798634096;9502.334836561444;9511.904880951188;9585.089416505438;2512.7612876776675;2547.7070136934212;2559;2580.303318104111;2584.3539115221197;2484.4782595654933;2545.350935511442;2556.437583731576;2557.565213913639;2567.9871600642064;2542.9364265893314;2547.4013606802387;2568.0626571301527;2578.355411147213;2591.624214488898;2491.4767898741197;2495.625656151574;2496.10140349474;2507.109975958536;2517.446161844391;2518.597024476075;2524.343670645627;2527.9494410111693;2532.430203204283;2551.719310875802;9639.084286992724;9709.951450242703;9737.367071140425;9755.902440975571;9828.4102953823;5637.661740295554;5732.426757324276;5764.913526297109;5768.250127483442;5771.682557459338;3540.6990405815536;3640.271945610862;3643.344198044351;3767.5478942526797;3785.8674946376746;1302.6417735122823;1362.989217550607;1397.699494608664;1415.2782081138591;1423.1887823940358;13517.256550889697;13579.660508487268;13587.660308492366;13599.932000340033;13659.043866929318;5001.824936127291;5022.723750193702;5139.922901156486;5152.896942061137;5230.372355317386;11777.52889884395;11777.941110294565;11817.350045747566;11875.346855922835;11883.346415947206;5820.563457740686;5824.767009319665;5843.3864444233595;5845.707714614252;5895.64626122434;4714.4106986626675;5252.763625636855;5366.543843773245;5368.194770784336;5402.216678581583;4393.758343291086;4427.867163985085;4452.220861349251;4482.618977386958;4482.731036137842;1429.592566118672;1446.3708286895235;1462.5612316305067;1472.7275454041037;1473.7789331600345;1040.292601031306;1044.3316277582353;1050.669039252633;1057.8889216632142;1074.1138560687464;6353.555251132377;6369.363063693593;6504.9674751625935;6517.51118666102;6580.539362244597;513.2173435510875;522.3914140026826;524.8976449592293;527.3460908473465;536.7691892486268;4460.107978404332;4493.932591011137;4497.123061003073;4564.817407303737;4565.589096981221;11645.941770291094;12222.083343749076;12379.381030948596;12558.309292988974;12560.81158782619;12124.333161676017;12510.624681259576;12562.748745025048;12570.371481425893;12587.30769807651;8781.121887811169;8803.911960880438;8817.735467935972;8897.822043559092;8961.910380896108;6549.7380104795275;6709.060731497691;6741.292164322872;6820.897686534607;6898.827529311808;11280.379579122899;11294.322340659586;11340.319580825177;11343.716407089558;11560.884391155982;11353.148513861328;11388.316700997966;11475.426228688699;11601.245919015237;11662.94168529152;7802.141764406025;8414.789630259293;8468.491890486344;8674.219320261207;8910;9428.905710942803;9432.528373581155;9451.574679139592;9465.290103242147;9538.666146684833;8547.316214702932;8576.171982111877;8625.266852317623;8671.609777560152;8767.649294028168;8196.631151598312;8285.710000149966;8307;8338.374621903502;8341.708040218564;7436.888446673413;7512.624368781649;7619.161892191743;7627.847443050997;7650.081990161217;5754.251947246831;5830.737616807339;5861.501772349227;5884.323302820059;5885.117232415172;5675.31896172462;5750.022496175577;5756.769729210785;5790.652560846363;5912.172295878667 18:00:59 INFO - PROCESS | 6366 | |4;prototype.html;343.2397240113149;345.083802504351;346.11567445177576;355.21851925763326;356.4617427684197;5795.246617939667;5873.794417195399;5882.411718859296;5909.113632955059;5971.686229029618;5769.1923130761725;5799.304083509975;5805.941940580593;5829.358770535237;5845.444682755142;4201.138766552865;4544.659500357318;4551;4568.634509239269;4579.313103034555;4538.410006699124;4545.431821022372;4549.021960278539;4552.08958208358;4575.771211439432;4476.171908196994;4561.543845615429;4570.3829982952375;4591.265397536395;4601.585857272845;4529.750863702511;4534.818607255722;4544.750038747868;4545.954320555763;4559.430071241095;4060.8172632231326;4064.2887494688607;4069.1861627674584;4078.4305887290816;4089.141280331134;5526.253955715967;5613.382527921925;5647.915281270784;5650.802221922213;5664.773409063632;5187.533122018998;5216.374035115772;5221.39953905302;5235.790568377261;5252.947470525284;6053.424924632197;6077.088436734481;6104.816855494342;6165.815025549241;6167.629942203482;4297.484301883794;4394.274944634131;4446.177457170434;4466.12910482456;4498.977505112453;6309.706510165451;6314.494840412802;6325.146105275775;6335.239771227436;6372.3946225108075;4533;4573.519780423074;4584.747838868828;4587;4629.768511574408;4498.145352383037;4557.270836666117;4597.563231493003;4663.067386522641;4679.859604211879;5165.431802501722;5170.6122040847085;5172.586193104543;5222.895542089137;5262.657927234717;6029.577929544977;6042;6111.419415155553;6127.601705889103;6217.564770466024;1480.5410322799967;1553.720330340527;1565.4051460445185;1570.3561539768868;1588.626672731907;965.3146266151111;967.9642782223094;984.2372161574837;1024.472396715692;1054.0618849224197;5800.854978625568;5841.561882858802;5880.941190588125;5883.264591926009;5911.733971971272;6192;6283.874322513524;6285.271550323698;6322.841928951813;6331.4301712845145;5678.352335563285;5798.768049277982;5840.393891679822;5879.323877754027;5913.763449461973;3320.625752586912;3345.7787907413617;3346.5147553604593;3349.5478110455265;3362.34434285312;6157.876842463125;6428.292887782341;6466.612003279818;6489.253735820346;6548.6725663716625;6360.840978975562;6448;6455.838604034937;6473.417392434703;6479.639275752051;6363.681815909279;6468.450181734605;6626.370494802986;6634.303398143222;6649.235337936103;6276.654783986742;6282.717277722422;6286.779962701284;6334.9366506334345;6423.614583125028;6167.907481387693;6246.812595622138;6288.339724328879;6313.526485513697;6316.62100273985;6563.442107420923;6564.606123632598;6578.111954886221;6595.406413422815;6646.83382915431;4517.457905051415;4532.5694059064335;4534.546545345439;4545.65907556928;4560.612347950461;6160.291566469913;6309.400606942333;6392.4246817786625;6448.419642232222;6453.419192272718;6194.38056194395;6224.315325314303;6226.906596401148;6258.311585725475;6278.811635650938;5877.059670452707;6190.81427557174;6203.565750397429;6206.751729930933;6252.718627661857;5943.970280148572;6014.398560143951;6068.302145253176;6077.149199112039;6129.601575897553;6164.815055548341;6182.072689096672;6215.316315205414;6215.65813880241;6216.285127210248;5960.284765828128;6018.578699490994;6023.819285421444;6071.057261676221;6093.48205402528 18:00:59 INFO - PROCESS | 6366 | |5;yui.html;812.9837403251935;831.0733532111698;866.2939704141127;884.3765145572372;925.3984909808619;15964.680706385865;16812.915935420322;17399.217035233414;17690;17768.466945991608;15569;15806.209689515536;15884.126373049477;16074.5981350466;16137.435189768361;842.5366048673236;861.8017855893148;887.7469921072495;896.4397251717677;897.107378158733;883.6244596046687;883.7525492862009;888.4669198480924;888.9822203555957;891.3715830339595;936.8220038192721;937.3813283233068;942.8585712143165;945.7446489447844;948.0614191949954;939.6523286384013;945.5508633399115;946.2477330522217;948.8576713492962;949.0841338108689;691.7198534593498;692.6571347183126;694.9409300209488;695.2873304862505;695.6000299827568;16984.320627174897;16991.830081699147;17097.914510427494;17114.229859656345;17142.742858857127;14494.637634059127;15059.247037648074;15261.923690381587;15529.611759706098;15878.52364429069;13569.1858488491;13801.378937947817;13838.30808459583;13885.791713124312;13900.93049534756;4066.1054567994993;4073.7963101845085;4144.109016561454;4165.125323682;4178;95373;96737;96950.03049969481;97414;97465.51267243689;11760.176787624956;11821;12648.747025059447;12686.80969785454;12944.935275323563;23885.283441496784;23909.16317928864;23915;23923;23932.40168995789;9053.230475409664;9122.635094596275;9466.95266523663;9491.003444638352;9583.137517623447;5139.743012849342;5340.198970154508;5340.679559226459;5355.732213389315;5571.860703482364;4234.38601402801;4324.459442569679;4374.693771436033;4386.2762644163995;4393.692441529062;817.6811043692965;818.2267756969726;834.5076404921004;835.2399316621967;852.4075767341762;758.0486489455698;766.9525789152572;767.6545554500497;773.6905237904771;778.8870613761086;9754.414735115915;10684;10735.731606709738;10773.138148948223;10842.566297348018;697.5605368617738;698.8183072401213;712.3090602115939;769.8344855855905;816.6365967144683;5152.613553983466;5193.221016847503;5230;5238.659487133325;5255.474452554714;72606.63696681483;119678.4016079914;123995.38002309931;125900.37049814692;127033;61991.38008619946;86516;99582.5020874891;103374.48312758388;103677.48161259145;88335.55832220927;91095.54452227696;91520;94203.05796941943;94431.52784236034;9692;9902.900970990486;9907;9907.504624768877;9976.650817221362;52335.73832130815;54884.45115548953;54988.45011549833;55739.72130139486;56028.71985640209;46657;47569.52430475789;60837.69581152066;78228;82083.17916820756;13334.599962001155;13369;13440.059195856196;13600.52398166099;13704.24626645544;14635.487757928422;15016.47442339513;15074.321655525308;15303;15562.221888905737;13920.234387108401;14322.364641322087;14575.854241457873;14642.633934151305;14660.340284687001;12371.319577423328;12680.112392132462;12730.936345318214;14588.708225835637;15162.924185379003;15610.687786243985;16065.598360040625;16402.589935251715;16770.245338959532;17003;11744.412779360828;11769.058475321783;12062.921348314607;12396.256224626191;12444.751104978031;11370.886291137314;13134.474621015052;13279.269640169883;13301.334933253493;13566.525171618947 18:00:59 INFO - PROCESS | 6366 | __end_tp_report 18:00:59 INFO - PROCESS | 6366 | __start_cc_report 18:00:59 INFO - PROCESS | 6366 | _x_x_mozilla_cycle_collect,336 18:00:59 INFO - PROCESS | 6366 | __end_cc_report 18:00:59 INFO - PROCESS | 6366 | __startTimestamp1473814859770__endTimestamp 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | ------- Summary: start ------- 18:00:59 INFO - PROCESS | 6366 | Number of tests: 6 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | [#0] dojo.html Cycles:165 Average:5752.40 Median:6002.43 stddev:650.07 (10.8%) stddev-sans-first:621.13 18:00:59 INFO - PROCESS | 6366 | Values: 3226.6 3356.7 3369.4 3375.7 3377.9 5846.2 5888.8 5914.4 5925.6 5937.5 5730.1 5798.5 5824.9 5831.6 5837.0 5255.0 5306.0 5337.1 5340.9 5350.3 5228.1 5249.0 5262.1 5262.7 5310.6 5303.8 5328.1 5335.4 5346.3 5396.9 5394.7 5395.5 5399.7 5400.6 5404.3 5047.9 5075.0 5230.0 5296.2 5390.5 5121.8 5630.6 5646.1 5700.6 5805.2 6164.9 6194.8 6203.5 6213.7 6213.8 6230.9 6242.3 6254.3 6258.1 6266.7 5582.9 5670.1 5691.1 5703.3 5805.3 6268.4 6296.5 6296.7 6307.6 6319.3 6005.7 6022.6 6038.0 6076.2 6080.6 5976.7 6002.4 6009.7 6012.0 6114.4 6016.9 6034.6 6042.7 6043.2 6048.7 5989.8 6019.1 6056.0 6071.9 6091.0 4637.3 4665.5 4676.0 4717.4 4785.0 4190.5 4203.3 4217.4 4218.6 4243.7 5918.9 5980.3 5988.0 5996.1 5996.8 6149.6 6189.8 6194.2 6270.1 6270.8 5970.7 5983.3 5989.5 6008.3 6046.2 5289.3 5374.3 5392.0 5406.5 5414.9 6292.8 6311.4 6329.4 6423.5 6426.2 6193.2 6198.2 6202.3 6222.8 6234.4 6200.3 6416.0 6422.8 6424.6 6430.6 6001.0 6009.3 6047.5 6115.9 6117.4 6195.3 6203.6 6204.6 6211.4 6228.6 5914.6 6025.1 6092.4 6099.4 6115.1 6078.0 6090.3 6105.8 6168.8 6174.2 5995.6 6034.7 6085.4 6103.8 6115.1 5931.7 6155.4 6202.4 6210.3 6211.6 5944.4 5949.4 5997.6 6068.8 6100.8 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | [#1] ext.html Cycles:180 Average:63793.98 Median:44420.45 stddev:123939.98 (279.0%) stddev-sans-first:124196.73 18:00:59 INFO - PROCESS | 6366 | Values: 562.7 600.1 616.6 623.8 682.1 39735.8 43953.8 44157.0 44174.1 44269.3 44913.8 45317.5 45499.8 45520.5 45614.0 8904.9 9033.9 9054.4 9055.0 9060.2 9065.2 9117.8 9166.5 9168.7 9180.4 9174.4 9202.0 9239.1 9245.7 9251.8 9151.5 9160.3 9205.2 9229.0 9255.9 9002.3 9106.6 9108.9 9132.9 9147.5 42877.4 43163.4 43465.8 43487.8 43568.6 4012.2 4037.4 4067.2 4253.9 4283.4 34270.5 34582.3 34670.5 35005.5 35019.3 4656.8 4700.1 4705.8 4722.4 4729.7 381541.0 390538.0 391658.0 525218.0 527480.0 65306.7 66098.3 66151.3 66226.3 66239.3 34588.1 35529.6 68666.0 69300.3 69319.0 17138.0 17186.3 17276.8 17280.6 17329.8 12988.0 13012.9 13056.1 13086.6 13098.7 19470.2 19732.5 19741.4 19812.1 20046.9 7172.9 7227.8 7333.3 7361.9 7508.9 1011.8 1056.0 1104.2 1107.5 1114.6 31440.5 31548.0 31581.0 32004.9 32144.8 1140.8 1144.7 1194.6 1194.7 1214.0 16337.8 16638.3 17195.7 17220.6 17347.3 501686.0 503500.0 503773.0 504799.0 505973.0 58058.7 58071.7 58688.7 58772.4 58837.0 1439.8 1457.9 1459.5 1475.5 1483.1 30677.4 30833.9 30942.0 31646.4 31837.7 50806.5 57639.4 59362.7 59531.4 64482.0 448880.0 449302.0 450629.0 452426.0 452596.0 46415.1 46770.0 47222.5 47299.0 47964.0 50614.0 50975.5 51040.5 51569.5 52234.7 43041.8 43875.3 44228.3 44571.6 44839.8 43513.0 43700.8 44070.3 44205.6 44994.0 42889.8 43731.6 43768.1 43835.6 45763.5 35928.5 37256.4 37651.6 38080.0 38300.6 28240.0 29418.9 29626.6 29857.3 29950.7 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | [#2] jquery.html Cycles:180 Average:31217.42 Median:11712.73 stddev:88036.37 (751.6%) stddev-sans-first:88252.93 18:00:59 INFO - PROCESS | 6366 | Values: 402.8 418.4 421.6 422.2 430.6 19391.3 20563.9 21116.9 22175.4 22634.0 19615.5 20205.8 20448.0 20589.4 21273.8 5489.4 5660.2 5664.5 5670.9 5686.1 5599.4 5617.3 5640.9 6076.3 6139.6 5943.3 6028.1 6030.0 6051.8 6132.2 5466.2 5550.9 5579.2 5841.5 6082.9 5432.9 5467.6 5478.7 5484.6 5512.3 13606.9 13621.4 13721.5 13733.4 13796.5 2469.8 2471.7 2573.1 2724.9 2877.4 11142.6 11369.3 12198.5 15267.2 15368.2 1990.8 2036.2 2060.8 2068.6 2151.7 83926.0 85863.0 86483.6 88038.0 89054.0 11234.4 11531.4 11662.4 11699.1 11764.6 16540.7 16569.2 16607.4 16629.8 16661.7 8174.7 8176.8 8215.2 8315.3 8561.5 7793.2 7965.5 8056.8 8102.1 8128.4 4953.1 4968.1 4998.6 5034.4 5107.6 1964.1 2068.2 2068.8 2152.1 2196.9 927.4 980.9 1009.2 1047.3 1047.5 19242.9 19380.2 20337.3 20356.1 20520.2 1046.5 1049.7 1050.4 1073.7 1074.9 10533.3 11271.7 11273.7 11302.0 11306.6 513418.0 517537.0 518684.0 542655.0 566674.0 92542.0 106709.5 110360.0 110463.0 111027.0 1040.5 1047.3 1103.3 1106.9 1116.9 18323.4 18615.4 18727.7 19180.0 19262.2 46325.8 46533.5 46721.0 47237.8 48163.5 66440.7 67045.7 67086.0 67300.3 68623.7 8476.7 8510.2 8670.9 8767.5 8793.7 9716.1 12682.8 13111.5 13206.9 13357.3 11932.8 12111.5 12148.5 12333.2 12435.9 11719.5 11840.5 11846.6 11869.6 12031.4 12107.4 12160.4 12358.3 12408.0 12440.1 8594.6 8619.5 8697.5 8874.7 9152.3 11463.7 11579.1 11593.4 12285.9 12382.0 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | [#3] mootools.html Cycles:180 Average:6411.85 Median:4858.12 stddev:3700.85 (76.2%) stddev-sans-first:3693.03 18:00:59 INFO - PROCESS | 6366 | Values: 1527.5 1528.8 1695.4 1829.8 1851.7 8553.4 8969.7 9027.2 9612.8 9725.8 9164.9 9457.3 9502.3 9511.9 9585.1 2512.8 2547.7 2559.0 2580.3 2584.4 2484.5 2545.4 2556.4 2557.6 2568.0 2542.9 2547.4 2568.1 2578.4 2591.6 2491.5 2495.6 2496.1 2507.1 2517.4 2518.6 2524.3 2527.9 2532.4 2551.7 9639.1 9710.0 9737.4 9755.9 9828.4 5637.7 5732.4 5764.9 5768.3 5771.7 3540.7 3640.3 3643.3 3767.5 3785.9 1302.6 1363.0 1397.7 1415.3 1423.2 13517.3 13579.7 13587.7 13599.9 13659.0 5001.8 5022.7 5139.9 5152.9 5230.4 11777.5 11777.9 11817.4 11875.3 11883.3 5820.6 5824.8 5843.4 5845.7 5895.6 4714.4 5252.8 5366.5 5368.2 5402.2 4393.8 4427.9 4452.2 4482.6 4482.7 1429.6 1446.4 1462.6 1472.7 1473.8 1040.3 1044.3 1050.7 1057.9 1074.1 6353.6 6369.4 6505.0 6517.5 6580.5 513.2 522.4 524.9 527.3 536.8 4460.1 4493.9 4497.1 4564.8 4565.6 11645.9 12222.1 12379.4 12558.3 12560.8 12124.3 12510.6 12562.7 12570.4 12587.3 8781.1 8803.9 8817.7 8897.8 8961.9 6549.7 6709.1 6741.3 6820.9 6898.8 11280.4 11294.3 11340.3 11343.7 11560.9 11353.1 11388.3 11475.4 11601.2 11662.9 7802.1 8414.8 8468.5 8674.2 8910.0 9428.9 9432.5 9451.6 9465.3 9538.7 8547.3 8576.2 8625.3 8671.6 8767.6 8196.6 8285.7 8307.0 8338.4 8341.7 7436.9 7512.6 7619.2 7627.8 7650.1 5754.3 5830.7 5861.5 5884.3 5885.1 5675.3 5750.0 5756.8 5790.7 5912.2 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | [#4] prototype.html Cycles:180 Average:5179.48 Median:5880.13 stddev:1529.22 (26.0%) stddev-sans-first:1489.80 18:00:59 INFO - PROCESS | 6366 | Values: 343.2 345.1 346.1 355.2 356.5 5795.2 5873.8 5882.4 5909.1 5971.7 5769.2 5799.3 5805.9 5829.4 5845.4 4201.1 4544.7 4551.0 4568.6 4579.3 4538.4 4545.4 4549.0 4552.1 4575.8 4476.2 4561.5 4570.4 4591.3 4601.6 4529.8 4534.8 4544.8 4546.0 4559.4 4060.8 4064.3 4069.2 4078.4 4089.1 5526.3 5613.4 5647.9 5650.8 5664.8 5187.5 5216.4 5221.4 5235.8 5252.9 6053.4 6077.1 6104.8 6165.8 6167.6 4297.5 4394.3 4446.2 4466.1 4499.0 6309.7 6314.5 6325.1 6335.2 6372.4 4533.0 4573.5 4584.7 4587.0 4629.8 4498.1 4557.3 4597.6 4663.1 4679.9 5165.4 5170.6 5172.6 5222.9 5262.7 6029.6 6042.0 6111.4 6127.6 6217.6 1480.5 1553.7 1565.4 1570.4 1588.6 965.3 968.0 984.2 1024.5 1054.1 5800.9 5841.6 5880.9 5883.3 5911.7 6192.0 6283.9 6285.3 6322.8 6331.4 5678.4 5798.8 5840.4 5879.3 5913.8 3320.6 3345.8 3346.5 3349.5 3362.3 6157.9 6428.3 6466.6 6489.3 6548.7 6360.8 6448.0 6455.8 6473.4 6479.6 6363.7 6468.5 6626.4 6634.3 6649.2 6276.7 6282.7 6286.8 6334.9 6423.6 6167.9 6246.8 6288.3 6313.5 6316.6 6563.4 6564.6 6578.1 6595.4 6646.8 4517.5 4532.6 4534.5 4545.7 4560.6 6160.3 6309.4 6392.4 6448.4 6453.4 6194.4 6224.3 6226.9 6258.3 6278.8 5877.1 6190.8 6203.6 6206.8 6252.7 5944.0 6014.4 6068.3 6077.1 6129.6 6164.8 6182.1 6215.3 6215.7 6216.3 5960.3 6018.6 6023.8 6071.1 6093.5 18:00:59 INFO - PROCESS | 6366 | 18:00:59 INFO - PROCESS | 6366 | [#5] yui.html Cycles:180 Average:21698.54 Median:47113.26 stddev:30712.76 (65.2%) stddev-sans-first:30758.88 18:00:59 INFO - PROCESS | 6366 | Values: 813.0 831.1 866.3 884.4 925.4 15964.7 16812.9 17399.2 17690.0 17768.5 15569.0 15806.2 15884.1 16074.6 16137.4 842.5 861.8 887.7 896.4 897.1 883.6 883.8 888.5 889.0 891.4 936.8 937.4 942.9 945.7 948.1 939.7 945.6 946.2 948.9 949.1 691.7 692.7 694.9 695.3 695.6 16984.3 16991.8 17097.9 17114.2 17142.7 14494.6 15059.2 15261.9 15529.6 15878.5 13569.2 13801.4 13838.3 13885.8 13900.9 4066.1 4073.8 4144.1 4165.1 4178.0 95373.0 96737.0 96950.0 97414.0 97465.5 11760.2 11821.0 12648.7 12686.8 12944.9 23885.3 23909.2 23915.0 23923.0 23932.4 9053.2 9122.6 9467.0 9491.0 9583.1 5139.7 5340.2 5340.7 5355.7 5571.9 4234.4 4324.5 4374.7 4386.3 4393.7 817.7 818.2 834.5 835.2 852.4 758.0 767.0 767.7 773.7 778.9 9754.4 10684.0 10735.7 10773.1 10842.6 697.6 698.8 712.3 769.8 816.6 5152.6 5193.2 5230.0 5238.7 5255.5 72606.6 119678.4 123995.4 125900.4 127033.0 61991.4 86516.0 99582.5 103374.5 103677.5 88335.6 91095.5 91520.0 94203.1 94431.5 9692.0 9902.9 9907.0 9907.5 9976.7 52335.7 54884.5 54988.5 55739.7 56028.7 46657.0 47569.5 60837.7 78228.0 82083.2 13334.6 13369.0 13440.1 13600.5 13704.2 14635.5 15016.5 15074.3 15303.0 15562.2 13920.2 14322.4 14575.9 14642.6 14660.3 12371.3 12680.1 12730.9 14588.7 15162.9 15610.7 16065.6 16402.6 16770.2 17003.0 11744.4 11769.1 12062.9 12396.3 12444.8 11370.9 13134.5 13279.3 13301.3 13566.5 18:00:59 INFO - PROCESS | 6366 | -------- Summary: end -------- 18:00:59 INFO - PROCESS | 6366 | 18:01:00 INFO - TEST-INFO | 6366: exit 0 18:01:00 INFO - TEST-OK | dromaeo_css | took 1110621ms 18:01:00 INFO - TEST-START | kraken 18:01:00 INFO - operating with platform_type : linux_ 18:01:00 INFO - Initialising browser for kraken test... 18:01:00 INFO - TEST-INFO | started process 6626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbloBVw/profile http://localhost:44976/getInfo.html) 18:01:04 INFO - PROCESS | 6626 | __metrics Screen width/height:1600/1200 18:01:04 INFO - PROCESS | 6626 | colorDepth:24 18:01:04 INFO - PROCESS | 6626 | Browser inner width/height: 1024/697 18:01:04 INFO - PROCESS | 6626 | __metrics 18:01:05 ERROR - PROCESS | 6626 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:01:06 INFO - TEST-INFO | 6626: exit 0 18:01:06 INFO - Browser initialized. 18:01:06 INFO - Running cycle 1/1 for kraken test... 18:01:06 INFO - TEST-INFO | started process 6754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbloBVw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:18 INFO - PROCESS | 6754 | RSS: Main: 153006080 18:01:18 INFO - PROCESS | 6754 | 18:01:20 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:21 INFO - PROCESS | 6754 | RSS: Main: 158433280 18:01:21 INFO - PROCESS | 6754 | 18:01:24 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-dft) 18:01:24 INFO - PROCESS | 6754 | RSS: Main: 156676096 18:01:24 INFO - PROCESS | 6754 | 18:01:27 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-fft) 18:01:28 INFO - PROCESS | 6754 | RSS: Main: 157884416 18:01:28 INFO - PROCESS | 6754 | 18:01:30 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-oscillator) 18:01:31 INFO - PROCESS | 6754 | RSS: Main: 157310976 18:01:31 INFO - PROCESS | 6754 | 18:01:33 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:01:33 INFO - PROCESS | 6754 | RSS: Main: 158048256 18:01:33 INFO - PROCESS | 6754 | 18:01:36 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-darkroom) 18:01:37 INFO - PROCESS | 6754 | RSS: Main: 157716480 18:01:37 INFO - PROCESS | 6754 | 18:01:40 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-desaturate) 18:01:41 INFO - PROCESS | 6754 | RSS: Main: 157888512 18:01:41 INFO - PROCESS | 6754 | 18:01:44 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44976/tests/kraken/driver.html?testName=json-parse-financial) 18:01:45 INFO - PROCESS | 6754 | RSS: Main: 157851648 18:01:45 INFO - PROCESS | 6754 | 18:01:46 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:01:47 INFO - PROCESS | 6754 | RSS: Main: 157929472 18:01:47 INFO - PROCESS | 6754 | 18:01:48 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:01:49 INFO - PROCESS | 6754 | RSS: Main: 158064640 18:01:49 INFO - PROCESS | 6754 | 18:01:51 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:01:52 INFO - PROCESS | 6754 | RSS: Main: 157380608 18:01:52 INFO - PROCESS | 6754 | 18:01:54 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:01:55 INFO - PROCESS | 6754 | RSS: Main: 157835264 18:01:55 INFO - PROCESS | 6754 | 18:01:58 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:01:58 INFO - PROCESS | 6754 | RSS: Main: 158924800 18:01:58 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44976/tests/kraken/driver.html?testName=ai-astar) 18:02:00 INFO - PROCESS | 6754 | RSS: Main: 160354304 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | __start_tp_report 18:02:00 INFO - PROCESS | 6754 | _x_x_mozilla_page_load 18:02:00 INFO - PROCESS | 6754 | _x_x_mozilla_page_load_details 18:02:00 INFO - PROCESS | 6754 | |i|pagename|runs| 18:02:00 INFO - PROCESS | 6754 | |0;ai-astar;101;109;111;109;110;109;110;112;111;120 18:02:00 INFO - PROCESS | 6754 | |1;audio-beat-detection;143;117;141;179;121;143;146;122;181;115 18:02:00 INFO - PROCESS | 6754 | |2;audio-dft;164;164;161;161;163;160;162;162;163;162 18:02:00 INFO - PROCESS | 6754 | |3;audio-fft;76;75;75;184;78;74;76;75;171;75 18:02:00 INFO - PROCESS | 6754 | |4;audio-oscillator;84;84;143;85;84;83;144;84;84;148 18:02:00 INFO - PROCESS | 6754 | |5;imaging-gaussian-blur;118;118;117;118;118;118;119;118;118;118 18:02:00 INFO - PROCESS | 6754 | |6;imaging-darkroom;147;147;146;146;148;147;147;147;147;148 18:02:00 INFO - PROCESS | 6754 | |7;imaging-desaturate;95;96;97;95;95;96;95;96;96;95 18:02:00 INFO - PROCESS | 6754 | |8;json-parse-financial;52;52;52;51;55;51;51;55;53;52 18:02:00 INFO - PROCESS | 6754 | |9;json-stringify-tinderbox;61;60;59;62;60;59;60;61;60;60 18:02:00 INFO - PROCESS | 6754 | |10;stanford-crypto-aes;72;72;80;72;71;77;80;72;75;72 18:02:00 INFO - PROCESS | 6754 | |11;stanford-crypto-ccm;130;128;119;133;124;118;118;127;150;115 18:02:00 INFO - PROCESS | 6754 | |12;stanford-crypto-pbkdf2;151;149;153;151;151;156;153;149;149;150 18:02:00 INFO - PROCESS | 6754 | |13;stanford-crypto-sha256-iterative;62;62;62;62;62;64;61;62;61;61 18:02:00 INFO - PROCESS | 6754 | __end_tp_report 18:02:00 INFO - PROCESS | 6754 | __start_cc_report 18:02:00 INFO - PROCESS | 6754 | _x_x_mozilla_cycle_collect,882 18:02:00 INFO - PROCESS | 6754 | __end_cc_report 18:02:00 INFO - PROCESS | 6754 | __startTimestamp1473814920579__endTimestamp 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | ------- Summary: start ------- 18:02:00 INFO - PROCESS | 6754 | Number of tests: 14 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:4.59 (4.2%) stddev-sans-first:3.46 18:02:00 INFO - PROCESS | 6754 | Values: 101.0 109.0 111.0 109.0 110.0 109.0 110.0 112.0 111.0 120.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:143.00 stddev:23.78 (16.6%) stddev-sans-first:25.21 18:02:00 INFO - PROCESS | 6754 | Values: 143.0 117.0 141.0 179.0 121.0 143.0 146.0 122.0 181.0 115.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.32 (0.8%) stddev-sans-first:1.22 18:02:00 INFO - PROCESS | 6754 | Values: 164.0 164.0 161.0 161.0 163.0 160.0 162.0 162.0 163.0 162.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#3] audio-fft Cycles:10 Average:95.90 Median:75.00 stddev:43.13 (57.5%) stddev-sans-first:45.14 18:02:00 INFO - PROCESS | 6754 | Values: 76.0 75.0 75.0 184.0 78.0 74.0 76.0 75.0 171.0 75.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:29.50 (35.1%) stddev-sans-first:30.53 18:02:00 INFO - PROCESS | 6754 | Values: 84.0 84.0 143.0 85.0 84.0 83.0 144.0 84.0 84.0 148.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 18:02:00 INFO - PROCESS | 6754 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 18:02:00 INFO - PROCESS | 6754 | Values: 147.0 147.0 146.0 146.0 148.0 147.0 147.0 147.0 147.0 148.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 18:02:00 INFO - PROCESS | 6754 | Values: 95.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:1.51 (2.9%) stddev-sans-first:1.59 18:02:00 INFO - PROCESS | 6754 | Values: 52.0 52.0 52.0 51.0 55.0 51.0 51.0 55.0 53.0 52.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 18:02:00 INFO - PROCESS | 6754 | Values: 61.0 60.0 59.0 62.0 60.0 59.0 60.0 61.0 60.0 60.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.50 stddev:3.50 (4.8%) stddev-sans-first:3.61 18:02:00 INFO - PROCESS | 6754 | Values: 72.0 72.0 80.0 72.0 71.0 77.0 80.0 72.0 75.0 72.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.50 stddev:10.26 (8.0%) stddev-sans-first:10.79 18:02:00 INFO - PROCESS | 6754 | Values: 130.0 128.0 119.0 133.0 124.0 118.0 118.0 127.0 150.0 115.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:151.00 stddev:2.25 (1.5%) stddev-sans-first:2.39 18:02:00 INFO - PROCESS | 6754 | Values: 151.0 149.0 153.0 151.0 151.0 156.0 153.0 149.0 149.0 150.0 18:02:00 INFO - PROCESS | 6754 | 18:02:00 INFO - PROCESS | 6754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 18:02:00 INFO - PROCESS | 6754 | Values: 62.0 62.0 62.0 62.0 62.0 64.0 61.0 62.0 61.0 61.0 18:02:00 INFO - PROCESS | 6754 | -------- Summary: end -------- 18:02:00 INFO - PROCESS | 6754 | 18:02:01 INFO - TEST-INFO | 6754: exit 0 18:02:01 INFO - TEST-OK | kraken | took 61019ms 18:02:01 INFO - SUITE-END | took 1171s 18:02:01 INFO - Completed test suite (00:19:31) 18:02:01 INFO - javascript benchmark 18:02:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7807.585871580067, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3226.596675415573, 3356.7482438817096, 3369.393509168349, 3375.6793104655067, 3377.9155521111984, 5846.21076154719, 5888.793892213774, 5914.378990206031, 5925.585209035369, 5937.495312898409, 5730.05454100074, 5798.5361171106315, 5824.854378640536, 5831.591788574801, 5837.0, 5254.973725131378, 5305.973470132644, 5337.06601344765, 5340.893182136355, 5350.27771250882, 5228.137357336035, 5248.973755131238, 5262.079136151158, 5262.684238945656, 5310.575153987672, 5303.814366497173, 5328.094223981913, 5335.413104558495, 5346.331708536433, 5396.946030539683, 5394.730263486829, 5395.460453954613, 5399.676019438826, 5400.567954563626, 5404.297441332641, 5047.899042019176, 5075.0357432087785, 5230.032443997835, 5296.205569164617, 5390.4879036491475, 5121.795128194868, 5630.577706672016, 5646.124850648156, 5700.629459085188, 5805.216295800055, 6164.87670246597, 6194.783182588633, 6203.534734894901, 6213.689315534205, 6213.813585592439, 6230.937690623081, 6242.250929888442, 6254.280757712831, 6258.092576576371, 6266.717997690069, 5582.91625625616, 5670.149477578355, 5691.06097493913, 5703.258576385043, 5805.332386775491, 6268.373162683786, 6296.496280297565, 6296.748130074838, 6307.621542707452, 6319.273283572448, 6005.6997150142315, 6022.608530445507, 6038.033914573735, 6076.210092687922, 6080.635161890301, 5976.671283079472, 6002.429769171922, 6009.699515024231, 6012.0, 6114.38856114385, 6016.8796624068145, 6034.577579569388, 6042.6978651067275, 6043.214382130295, 6048.727807248684, 5989.8203053908455, 6019.067044608093, 6055.969720151371, 6071.939280607137, 6091.0, 4637.281221410687, 4665.533446655308, 4676.041411510632, 4717.410323709536, 4784.9951510182555, 4190.53904070552, 4203.306454434984, 4217.388478670576, 4218.557051509609, 4243.724157929724, 5918.852028699317, 5980.312264089598, 5988.0, 5996.1005849122985, 5996.760129594854, 6149.569530132848, 6189.783357582463, 6194.163787888668, 6270.059491076375, 6270.843228919313, 5970.671613061323, 5983.341832398432, 5989.520838332923, 6008.289352058917, 6046.183765191643, 5289.338832645919, 5374.3013408256675, 5391.973040134774, 5406.540444062299, 5414.945850541444, 6292.811215663537, 6311.400416960381, 6329.367063293634, 6423.4861211103, 6426.228852537725, 6193.163922870445, 6198.163247961467, 6202.255729312511, 6222.751089956351, 6234.407731265523, 6200.255969283715, 6416.037594360883, 6422.839429014312, 6424.614523128627, 6430.582012169194, 6001.009833377619, 6009.308929473166, 6047.5464340173785, 6115.938840611537, 6117.357677443804, 6195.3312718863535, 6203.596766210182, 6204.565680402328, 6211.378862113753, 6228.626282423069, 5914.556408269311, 6025.126356678169, 6092.390760923872, 6099.3900609938655, 6115.1438798569125, 6078.027515597483, 6090.269167699905, 6105.755769769159, 6168.784092556739, 6174.166487524127, 5995.61028533144, 6034.668093254913, 6085.417791374363, 6103.847403814762, 6115.052166914135, 5931.733072011683, 6155.446009859134, 6202.4417802398, 6210.31686514474, 6211.565190436807, 5944.405559444021, 5949.405059494016, 5997.610155339889, 6068.848278793065, 6100.786472473442], "value": 5708.554767136134, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.6848964579835, 600.1298117729292, 616.6392660293725, 623.8128561431571, 682.113252771397, 39735.80132099339, 43953.7802310988, 44157.0, 44174.11651766967, 44269.33595996063, 44913.7754311228, 45317.546824531746, 45499.77250113753, 45520.54479455204, 45614.0, 8904.910950890473, 9033.864492032624, 9054.4114632549, 9055.049219831888, 9060.229880460136, 9065.229455496257, 9117.772055698595, 9166.450012999208, 9168.679096231634, 9180.403273787217, 9174.449533028006, 9202.0, 9239.122283383067, 9245.72262832116, 9251.768705782342, 9151.542422878829, 9160.312976526788, 9205.171534561889, 9229.03095175007, 9255.907440925572, 9002.27981761464, 9106.63573457061, 9108.8633670495, 9132.908670913339, 9147.54262286883, 42877.35683964743, 43163.35254971178, 43465.78267108676, 43487.78256108731, 43568.564314357085, 4012.217617564576, 4037.394390841368, 4067.2475592015276, 4253.893652658678, 4283.443152390169, 34270.48594271088, 34582.308353832785, 34670.47994280062, 35005.47491787625, 35019.29961400783, 4656.790444429975, 4700.083483720676, 4705.835295764632, 4722.386089808338, 4729.739864307462, 381541.0, 390538.0, 391658.0, 525218.0, 527479.9999999962, 65306.67346663236, 66098.33901661017, 66151.33848661548, 66226.33773662298, 66239.33760662332, 34588.13529661779, 35529.64470355315, 68666.0, 69300.30699692939, 69319.0, 17138.0, 17186.31254749796, 17276.827231727773, 17280.567985800204, 17329.826701733073, 12987.960963122927, 13012.934935325262, 13056.08607397492, 13086.607401777961, 13098.738025239632, 19470.20264598915, 19732.50668733293, 19741.40775776729, 19812.108455119553, 20046.89976550108, 7172.856542869218, 7227.7831665050135, 7333.266673332624, 7361.926380736231, 7508.924910750932, 1011.7875246198233, 1056.0126281926423, 1104.1553211792984, 1107.5293000474767, 1114.6433141394675, 31440.52839207414, 31548.0, 31581.0, 32004.879829205867, 32144.83927580394, 1140.7604403075281, 1144.6852115668091, 1194.5759255464186, 1194.7371578252944, 1214.0348423003734, 16337.834539577023, 16638.334466621443, 17195.656086878193, 17220.569485762957, 17347.306107755547, 501686.0, 503500.0, 503773.0, 504799.0, 505973.0, 58058.7097064512, 58071.709641451525, 58688.70655646695, 58772.41227587755, 58837.0, 1439.834433822809, 1457.9125252484885, 1459.4745891479058, 1475.4835807467516, 1483.0879009409352, 30677.386452271276, 30833.920812771445, 30942.0, 31646.36707265888, 31837.68162318347, 50806.49193508018, 57639.423605765085, 59362.70318648379, 59531.404685954316, 64482.0, 448880.0, 449302.0, 450629.0, 452426.0, 452596.0, 46415.07169856651, 46770.0, 47222.52777472181, 47299.0, 47964.040719184726, 50613.964906351925, 50975.49024509856, 51040.48959510357, 51569.48430515797, 52234.73882630563, 43041.78479107584, 43875.341869871336, 44228.33657495076, 44571.55428445674, 44839.775801120784, 43513.0, 43700.78149609359, 44070.33894491521, 44205.55794442014, 44994.0, 42889.78555107205, 43731.562684374025, 43768.12463750644, 43835.56164438443, 45763.54236457593, 35928.4610730834, 37256.44115338326, 37651.623483764815, 38080.0, 38300.6169938297, 28240.0443749281, 29418.852905735333, 29626.555601666423, 29857.25356866096, 29950.70049299479], "value": 21295.870693325334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.79054891456445, 418.40377462116516, 421.61632914048215, 422.1599017954271, 430.5930895303937, 19391.321303754372, 20563.897180514115, 21116.89441552794, 22175.44561385966, 22634.0, 19615.509612259702, 20205.797942020614, 20448.0, 20589.38231853043, 21273.787262127375, 5489.423610520887, 5660.235868157787, 5664.490195882369, 5670.858228544299, 5686.147077938301, 5599.440055994409, 5617.269754931853, 5640.887182256373, 6076.2708474983065, 6139.6316221026655, 5943.316518600352, 6028.125921741344, 6029.974904266263, 6051.818445446622, 6132.233470816148, 5466.1527463243265, 5550.888982220333, 5579.218909352714, 5841.503472204868, 6082.878342433149, 5432.864178395532, 5467.589930755209, 5478.671279723229, 5484.643498172606, 5512.283403157564, 13606.93196534011, 13621.387037583332, 13721.45114195431, 13733.381997810022, 13796.517121900686, 2469.77772000519, 2471.7033955925403, 2573.099415204682, 2724.945501089967, 2877.3525956659582, 11142.554297828077, 11369.317840929489, 12198.451069701885, 15267.236638168048, 15368.231588420535, 1990.7511561054869, 2036.1651722793583, 2060.804223598771, 2068.6069646767064, 2151.66649169379, 83926.0, 85862.99999999937, 86483.56758216232, 88038.0, 89054.0, 11234.438278086227, 11531.365774882293, 11662.416879156008, 11699.06407487399, 11764.58823941158, 16540.6691866162, 16569.171541422882, 16607.41874034403, 16629.750553741702, 16661.6667666646, 8174.713885013996, 8176.7955801105445, 8215.219554142346, 8315.334773218128, 8561.529115898686, 7793.220677932161, 7965.4822436541435, 8056.798580035546, 8102.108768035511, 8128.431009829255, 4953.0589188054155, 4968.105740966588, 4998.550130488274, 5034.446210916796, 5107.591392688576, 1964.1063316191098, 2068.2347531413475, 2068.813806757399, 2152.1176317709665, 2196.8572042817163, 927.4435338796668, 980.8921018687938, 1009.1976878381704, 1047.2512153810062, 1047.5495536919045, 19242.903785480983, 19380.2247910082, 20337.288194913108, 20356.083976221107, 20520.179192832118, 1046.5029111172285, 1049.6850944716555, 1050.417018554694, 1073.6510634043966, 1074.9408782517037, 10533.262671612914, 11271.718207044889, 11273.718157045976, 11302.0, 11306.604268850551, 513418.0, 517537.0, 518684.0, 542655.0, 566674.0, 92542.0, 106709.46645266724, 110360.0, 110463.0, 111027.0, 1040.4953597505205, 1047.3035431438009, 1103.2828661370174, 1106.9335839849634, 1116.905063069632, 18323.35868244605, 18615.44153675392, 18727.71908421402, 19180.0, 19262.22951081941, 46325.76837115793, 46533.534664654275, 46721.0, 47237.763811180725, 48163.518364817304, 66440.66779666071, 67045.66477167583, 67086.0, 67300.32699673137, 68623.65688171727, 8476.703315384178, 8510.191531804468, 8670.913290867264, 8767.517786521803, 8793.736187914374, 9716.126132874111, 12682.809757853454, 13111.475540978636, 13206.867931320949, 13357.265350405822, 11932.76134477323, 12111.454984525893, 12148.453319600816, 12333.198342107735, 12435.93782031084, 11719.472623732123, 11840.467178976794, 11846.585369512026, 11869.643910682693, 12031.398430078636, 12107.394630268627, 12160.391980401122, 12358.320292384005, 12408.0, 12440.129190956546, 8594.570271486526, 8619.470260685812, 8697.52163630981, 8874.733757987271, 9152.313576481658, 11463.713407164887, 11579.13156513248, 11593.420328983686, 12285.938570307091, 12382.0], "value": 9583.189457281493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.5493729349841, 1528.831828498865, 1695.3727120965236, 1829.7529833472477, 1851.694470412382, 8553.444026138297, 8969.730908072752, 9027.187553120219, 9612.807743845127, 9725.756856078602, 9164.908350916488, 9457.33798634096, 9502.334836561444, 9511.904880951188, 9585.089416505438, 2512.7612876776675, 2547.7070136934212, 2559.0, 2580.303318104111, 2584.3539115221197, 2484.4782595654933, 2545.350935511442, 2556.437583731576, 2557.565213913639, 2567.9871600642064, 2542.9364265893314, 2547.4013606802387, 2568.0626571301527, 2578.355411147213, 2591.624214488898, 2491.4767898741197, 2495.625656151574, 2496.10140349474, 2507.109975958536, 2517.446161844391, 2518.597024476075, 2524.343670645627, 2527.9494410111693, 2532.430203204283, 2551.719310875802, 9639.084286992724, 9709.951450242703, 9737.367071140425, 9755.902440975571, 9828.4102953823, 5637.661740295554, 5732.426757324276, 5764.913526297109, 5768.250127483442, 5771.682557459338, 3540.6990405815536, 3640.271945610862, 3643.344198044351, 3767.5478942526797, 3785.8674946376746, 1302.6417735122823, 1362.989217550607, 1397.699494608664, 1415.2782081138591, 1423.1887823940358, 13517.256550889697, 13579.660508487268, 13587.660308492366, 13599.932000340033, 13659.043866929318, 5001.824936127291, 5022.723750193702, 5139.922901156486, 5152.896942061137, 5230.372355317386, 11777.52889884395, 11777.941110294565, 11817.350045747566, 11875.346855922835, 11883.346415947206, 5820.563457740686, 5824.767009319665, 5843.3864444233595, 5845.707714614252, 5895.64626122434, 4714.4106986626675, 5252.763625636855, 5366.543843773245, 5368.194770784336, 5402.216678581583, 4393.758343291086, 4427.867163985085, 4452.220861349251, 4482.618977386958, 4482.731036137842, 1429.592566118672, 1446.3708286895235, 1462.5612316305067, 1472.7275454041037, 1473.7789331600345, 1040.292601031306, 1044.3316277582353, 1050.669039252633, 1057.8889216632142, 1074.1138560687464, 6353.555251132377, 6369.363063693593, 6504.9674751625935, 6517.51118666102, 6580.539362244597, 513.2173435510875, 522.3914140026826, 524.8976449592293, 527.3460908473465, 536.7691892486268, 4460.107978404332, 4493.932591011137, 4497.123061003073, 4564.817407303737, 4565.589096981221, 11645.941770291094, 12222.083343749076, 12379.381030948596, 12558.309292988974, 12560.81158782619, 12124.333161676017, 12510.624681259576, 12562.748745025048, 12570.371481425893, 12587.30769807651, 8781.121887811169, 8803.911960880438, 8817.735467935972, 8897.822043559092, 8961.910380896108, 6549.7380104795275, 6709.060731497691, 6741.292164322872, 6820.897686534607, 6898.827529311808, 11280.379579122899, 11294.322340659586, 11340.319580825177, 11343.716407089558, 11560.884391155982, 11353.148513861328, 11388.316700997966, 11475.426228688699, 11601.245919015237, 11662.94168529152, 7802.141764406025, 8414.789630259293, 8468.491890486344, 8674.219320261207, 8910.0, 9428.905710942803, 9432.528373581155, 9451.574679139592, 9465.290103242147, 9538.666146684833, 8547.316214702932, 8576.171982111877, 8625.266852317623, 8671.609777560152, 8767.649294028168, 8196.631151598312, 8285.710000149966, 8307.0, 8338.374621903502, 8341.708040218564, 7436.888446673413, 7512.624368781649, 7619.161892191743, 7627.847443050997, 7650.081990161217, 5754.251947246831, 5830.737616807339, 5861.501772349227, 5884.323302820059, 5885.117232415172, 5675.31896172462, 5750.022496175577, 5756.769729210785, 5790.652560846363, 5912.172295878667], "value": 5045.143675043211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.2397240113149, 345.083802504351, 346.11567445177576, 355.21851925763326, 356.4617427684197, 5795.246617939667, 5873.794417195399, 5882.411718859296, 5909.113632955059, 5971.686229029618, 5769.1923130761725, 5799.304083509975, 5805.941940580593, 5829.358770535237, 5845.444682755142, 4201.138766552865, 4544.659500357318, 4551.0, 4568.634509239269, 4579.313103034555, 4538.410006699124, 4545.431821022372, 4549.021960278539, 4552.08958208358, 4575.771211439432, 4476.171908196994, 4561.543845615429, 4570.3829982952375, 4591.265397536395, 4601.585857272845, 4529.750863702511, 4534.818607255722, 4544.750038747868, 4545.954320555763, 4559.430071241095, 4060.8172632231326, 4064.2887494688607, 4069.1861627674584, 4078.4305887290816, 4089.141280331134, 5526.253955715967, 5613.382527921925, 5647.915281270784, 5650.802221922213, 5664.773409063632, 5187.533122018998, 5216.374035115772, 5221.39953905302, 5235.790568377261, 5252.947470525284, 6053.424924632197, 6077.088436734481, 6104.816855494342, 6165.815025549241, 6167.629942203482, 4297.484301883794, 4394.274944634131, 4446.177457170434, 4466.12910482456, 4498.977505112453, 6309.706510165451, 6314.494840412802, 6325.146105275775, 6335.239771227436, 6372.3946225108075, 4533.0, 4573.519780423074, 4584.747838868828, 4587.0, 4629.768511574408, 4498.145352383037, 4557.270836666117, 4597.563231493003, 4663.067386522641, 4679.859604211879, 5165.431802501722, 5170.6122040847085, 5172.586193104543, 5222.895542089137, 5262.657927234717, 6029.577929544977, 6042.0, 6111.419415155553, 6127.601705889103, 6217.564770466024, 1480.5410322799967, 1553.720330340527, 1565.4051460445185, 1570.3561539768868, 1588.626672731907, 965.3146266151111, 967.9642782223094, 984.2372161574837, 1024.472396715692, 1054.0618849224197, 5800.854978625568, 5841.561882858802, 5880.941190588125, 5883.264591926009, 5911.733971971272, 6192.0, 6283.874322513524, 6285.271550323698, 6322.841928951813, 6331.4301712845145, 5678.352335563285, 5798.768049277982, 5840.393891679822, 5879.323877754027, 5913.763449461973, 3320.625752586912, 3345.7787907413617, 3346.5147553604593, 3349.5478110455265, 3362.34434285312, 6157.876842463125, 6428.292887782341, 6466.612003279818, 6489.253735820346, 6548.6725663716625, 6360.840978975562, 6448.0, 6455.838604034937, 6473.417392434703, 6479.639275752051, 6363.681815909279, 6468.450181734605, 6626.370494802986, 6634.303398143222, 6649.235337936103, 6276.654783986742, 6282.717277722422, 6286.779962701284, 6334.9366506334345, 6423.614583125028, 6167.907481387693, 6246.812595622138, 6288.339724328879, 6313.526485513697, 6316.62100273985, 6563.442107420923, 6564.606123632598, 6578.111954886221, 6595.406413422815, 6646.83382915431, 4517.457905051415, 4532.5694059064335, 4534.546545345439, 4545.65907556928, 4560.612347950461, 6160.291566469913, 6309.400606942333, 6392.4246817786625, 6448.419642232222, 6453.419192272718, 6194.38056194395, 6224.315325314303, 6226.906596401148, 6258.311585725475, 6278.811635650938, 5877.059670452707, 6190.81427557174, 6203.565750397429, 6206.751729930933, 6252.718627661857, 5943.970280148572, 6014.398560143951, 6068.302145253176, 6077.149199112039, 6129.601575897553, 6164.815055548341, 6182.072689096672, 6215.316315205414, 6215.65813880241, 6216.285127210248, 5960.284765828128, 6018.578699490994, 6023.819285421444, 6071.057261676221, 6093.48205402528], "value": 4681.738681639909, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.9837403251935, 831.0733532111698, 866.2939704141127, 884.3765145572372, 925.3984909808619, 15964.680706385865, 16812.915935420322, 17399.217035233414, 17690.0, 17768.466945991608, 15569.0, 15806.209689515536, 15884.126373049477, 16074.5981350466, 16137.435189768361, 842.5366048673236, 861.8017855893148, 887.7469921072495, 896.4397251717677, 897.107378158733, 883.6244596046687, 883.7525492862009, 888.4669198480924, 888.9822203555957, 891.3715830339595, 936.8220038192721, 937.3813283233068, 942.8585712143165, 945.7446489447844, 948.0614191949954, 939.6523286384013, 945.5508633399115, 946.2477330522217, 948.8576713492962, 949.0841338108689, 691.7198534593498, 692.6571347183126, 694.9409300209488, 695.2873304862505, 695.6000299827568, 16984.320627174897, 16991.830081699147, 17097.914510427494, 17114.229859656345, 17142.742858857127, 14494.637634059127, 15059.247037648074, 15261.923690381587, 15529.611759706098, 15878.52364429069, 13569.1858488491, 13801.378937947817, 13838.30808459583, 13885.791713124312, 13900.93049534756, 4066.1054567994993, 4073.7963101845085, 4144.109016561454, 4165.125323682, 4178.0, 95373.0, 96737.0, 96950.03049969481, 97414.0, 97465.51267243689, 11760.176787624956, 11821.0, 12648.747025059447, 12686.80969785454, 12944.935275323563, 23885.283441496784, 23909.16317928864, 23915.0, 23923.0, 23932.40168995789, 9053.230475409664, 9122.635094596275, 9466.95266523663, 9491.003444638352, 9583.137517623447, 5139.743012849342, 5340.198970154508, 5340.679559226459, 5355.732213389315, 5571.860703482364, 4234.38601402801, 4324.459442569679, 4374.693771436033, 4386.2762644163995, 4393.692441529062, 817.6811043692965, 818.2267756969726, 834.5076404921004, 835.2399316621967, 852.4075767341762, 758.0486489455698, 766.9525789152572, 767.6545554500497, 773.6905237904771, 778.8870613761086, 9754.414735115915, 10684.0, 10735.731606709738, 10773.138148948223, 10842.566297348018, 697.5605368617738, 698.8183072401213, 712.3090602115939, 769.8344855855905, 816.6365967144683, 5152.613553983466, 5193.221016847503, 5230.0, 5238.659487133325, 5255.474452554714, 72606.63696681483, 119678.4016079914, 123995.38002309931, 125900.37049814692, 127033.0, 61991.38008619946, 86516.0, 99582.5020874891, 103374.48312758388, 103677.48161259145, 88335.55832220927, 91095.54452227696, 91520.0, 94203.05796941943, 94431.52784236034, 9692.0, 9902.900970990486, 9907.0, 9907.504624768877, 9976.650817221362, 52335.73832130815, 54884.45115548953, 54988.45011549833, 55739.72130139486, 56028.71985640209, 46657.0, 47569.52430475789, 60837.69581152066, 78228.0, 82083.17916820756, 13334.599962001155, 13369.0, 13440.059195856196, 13600.52398166099, 13704.24626645544, 14635.487757928422, 15016.47442339513, 15074.321655525308, 15303.0, 15562.221888905737, 13920.234387108401, 14322.364641322087, 14575.854241457873, 14642.633934151305, 14660.340284687001, 12371.319577423328, 12680.112392132462, 12730.936345318214, 14588.708225835637, 15162.924185379003, 15610.687786243985, 16065.598360040625, 16402.589935251715, 16770.245338959532, 17003.0, 11744.412779360828, 11769.058475321783, 12062.921348314607, 12396.256224626191, 12444.751104978031, 11370.886291137314, 13134.474621015052, 13279.269640169883, 13301.334933253493, 13566.525171618947], "value": 8230.924563440742, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 111.0, 109.0, 110.0, 109.0, 110.0, 112.0, 111.0, 120.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 141.0, 179.0, 121.0, 143.0, 146.0, 122.0, 181.0, 115.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 161.0, 163.0, 160.0, 162.0, 162.0, 163.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 184.0, 78.0, 74.0, 76.0, 75.0, 171.0, 75.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 85.0, 84.0, 83.0, 144.0, 84.0, 84.0, 148.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 51.0, 55.0, 51.0, 51.0, 55.0, 53.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 62.0, 60.0, 59.0, 60.0, 61.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 80.0, 72.0, 71.0, 77.0, 80.0, 72.0, 75.0, 72.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 119.0, 133.0, 124.0, 118.0, 118.0, 127.0, 150.0, 115.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 153.0, 151.0, 151.0, 156.0, 153.0, 149.0, 149.0, 150.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 64.0, 61.0, 62.0, 61.0, 61.0], "value": 61.9, "unit": "score"}]}]} 18:02:01 INFO - Return code: 0 18:02:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:01 ERROR - # TBPL SUCCESS # 18:02:01 INFO - Running post-action listener: _resource_record_post_action 18:02:01 INFO - [mozharness: 2016-09-14 01:02:01.890008Z] Finished run-tests step (success) 18:02:01 INFO - Running post-run listener: _resource_record_post_run 18:02:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 327987200; Read time: 0; Write time: 226564 18:02:01 INFO - TinderboxPrint: CPU usage
13.2% 18:02:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:02:01 INFO - TinderboxPrint: I/O write bytes / time
327,987,200 / 226,564 18:02:01 INFO - TinderboxPrint: CPU idle
8,234.5 (86.8%) 18:02:01 INFO - TinderboxPrint: CPU user
1,195.9 (12.6%) 18:02:01 INFO - TinderboxPrint: Swap in / out
0 / 0 18:02:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77213696; Read time: 0; Write time: 84188 18:02:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 248426496; Read time: 0; Write time: 142032 18:02:02 INFO - Running post-run listener: _upload_blobber_files 18:02:02 INFO - Blob upload gear active. 18:02:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:02 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 18:02:02 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:02:02 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:02:02 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:02:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:02:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:03 INFO - (blobuploader) - INFO - Done attempting. 18:02:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:02:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:02:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:04 INFO - (blobuploader) - INFO - Done attempting. 18:02:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:09 INFO - (blobuploader) - INFO - Done attempting. 18:02:09 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:09 INFO - Return code: 0 18:02:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82264701985661885e78e8fcf86827805399a23e713e84dbb0d1442f32baba906f190fe5d61d4cce2efa80630fb1978417ce3df9068e29d20147a46431707e4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac03c239933de8c5d580b2818686de253191e53b1f81b65e99b2c314f0d2c48f69d6079ed3c596a52b6183a45af98d935a0df2466a01f9d4784e431b18caab24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ec66f65f5a539fb22f55f848990290f4870240669586d75c24a346eb9b873dd65b8999331bcc39e62ff15b358e5b1911e13252729ac53ccba02dfce9bf65fe"} 18:02:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:09 INFO - Contents: 18:02:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82264701985661885e78e8fcf86827805399a23e713e84dbb0d1442f32baba906f190fe5d61d4cce2efa80630fb1978417ce3df9068e29d20147a46431707e4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac03c239933de8c5d580b2818686de253191e53b1f81b65e99b2c314f0d2c48f69d6079ed3c596a52b6183a45af98d935a0df2466a01f9d4784e431b18caab24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ec66f65f5a539fb22f55f848990290f4870240669586d75c24a346eb9b873dd65b8999331bcc39e62ff15b358e5b1911e13252729ac53ccba02dfce9bf65fe"} 18:02:09 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:09 INFO - Copying logs to upload dir... 18:02:09 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1679.255904 ========= master_lag: 13.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 12 secs) (at 2016-09-13 18:02:22.875952) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 18:02:22.879180) ========= 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=00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82264701985661885e78e8fcf86827805399a23e713e84dbb0d1442f32baba906f190fe5d61d4cce2efa80630fb1978417ce3df9068e29d20147a46431707e4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac03c239933de8c5d580b2818686de253191e53b1f81b65e99b2c314f0d2c48f69d6079ed3c596a52b6183a45af98d935a0df2466a01f9d4784e431b18caab24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ec66f65f5a539fb22f55f848990290f4870240669586d75c24a346eb9b873dd65b8999331bcc39e62ff15b358e5b1911e13252729ac53ccba02dfce9bf65fe"} build_url:https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/MuJZDmgLRaGAYmyJVm8pzA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82264701985661885e78e8fcf86827805399a23e713e84dbb0d1442f32baba906f190fe5d61d4cce2efa80630fb1978417ce3df9068e29d20147a46431707e4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac03c239933de8c5d580b2818686de253191e53b1f81b65e99b2c314f0d2c48f69d6079ed3c596a52b6183a45af98d935a0df2466a01f9d4784e431b18caab24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79ec66f65f5a539fb22f55f848990290f4870240669586d75c24a346eb9b873dd65b8999331bcc39e62ff15b358e5b1911e13252729ac53ccba02dfce9bf65fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 18:02:22.907966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 18:02:22.908672) ========= 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=00204705a9daa57ed339a427000001b9-1473813189.337943-1805291470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 18:02:22.959921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 18:02:22.960283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 18:02:22.960668) ========= ========= Total master_lag: 13.48 =========