builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1472383635.34 results: success (0) buildid: 20160827004001 builduid: 5275c599c6904397a1806c151c356c46 revision: 4d38a69eda61f663463af8f020447e9afbb118b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.339623) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.340158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.340494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.355087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.355484) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-28 04:27:15-- 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% 66.6M=0s 2016-08-28 04:27:15 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136354 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.508670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.509113) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018437 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.559946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:15.560335) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4d38a69eda61f663463af8f020447e9afbb118b1 --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 4d38a69eda61f663463af8f020447e9afbb118b1 --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=03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-28 04:27:15,966 truncating revision to first 12 chars 2016-08-28 04:27:15,966 Setting DEBUG logging. 2016-08-28 04:27:15,966 attempt 1/10 2016-08-28 04:27:15,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4d38a69eda61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-28 04:27:16,234 unpacking tar archive at: mozilla-aurora-4d38a69eda61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538482 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:16.112511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:16.112876) ========= script_repo_revision: 4d38a69eda61f663463af8f020447e9afbb118b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:16.113327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:16.113632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:27:16.124448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-08-28 04:27:16.124753) ========= /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=03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:27:16 INFO - MultiFileLogger online at 20160828 04:27:16 in /builds/slave/test 04:27:16 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 04:27:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:16 INFO - {'append_to_log': False, 04:27:16 INFO - 'base_work_dir': '/builds/slave/test', 04:27:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:27:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:16 INFO - 'branch': 'Mozilla-Aurora', 04:27:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:16 INFO - 'config_files': ('talos/linux_config.py',), 04:27:16 INFO - 'default_actions': ('clobber', 04:27:16 INFO - 'read-buildbot-config', 04:27:16 INFO - 'download-and-extract', 04:27:16 INFO - 'populate-webroot', 04:27:16 INFO - 'create-virtualenv', 04:27:16 INFO - 'install', 04:27:16 INFO - 'run-tests'), 04:27:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:16 INFO - 'download_minidump_stackwalk': True, 04:27:16 INFO - 'download_symbols': 'ondemand', 04:27:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:16 INFO - 'installer_path': 'installer.exe', 04:27:16 INFO - 'log_level': 'info', 04:27:16 INFO - 'log_name': 'talos', 04:27:16 INFO - 'log_to_console': True, 04:27:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:27:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:27:16 INFO - 'opt_config_files': (), 04:27:16 INFO - 'pip_index': False, 04:27:16 INFO - 'sps_profile': False, 04:27:16 INFO - 'sps_profile_interval': 0, 04:27:16 INFO - 'suite': 'dromaeojs-e10s', 04:27:16 INFO - 'system_bits': '32', 04:27:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:16 INFO - 'title': 'talos-linux64-ix-047', 04:27:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:16 INFO - 'use_talos_json': True, 04:27:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:16 INFO - 'work_dir': 'build'} 04:27:16 INFO - [mozharness: 2016-08-28 11:27:16.627090Z] Running clobber step. 04:27:16 INFO - Running pre-action listener: _resource_record_pre_action 04:27:16 INFO - Running main action method: clobber 04:27:16 INFO - rmtree: /builds/slave/test/build 04:27:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:17 INFO - Running post-action listener: _resource_record_post_action 04:27:17 INFO - [mozharness: 2016-08-28 11:27:17.632886Z] Finished clobber step (success) 04:27:17 INFO - [mozharness: 2016-08-28 11:27:17.632987Z] Running read-buildbot-config step. 04:27:17 INFO - Running pre-action listener: _resource_record_pre_action 04:27:17 INFO - Running main action method: read_buildbot_config 04:27:17 INFO - Using buildbot properties: 04:27:17 INFO - { 04:27:17 INFO - "project": "", 04:27:17 INFO - "product": "firefox", 04:27:17 INFO - "script_repo_revision": "production", 04:27:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:27:17 INFO - "repository": "", 04:27:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:27:17 INFO - "buildid": "20160827004001", 04:27:17 INFO - "stage_platform": "linux64-pgo", 04:27:17 INFO - "basedir": "/builds/slave/test", 04:27:17 INFO - "nightly_build": "True", 04:27:17 INFO - "buildnumber": 516, 04:27:17 INFO - "slavename": "talos-linux64-ix-047", 04:27:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:27:17 INFO - "platform": "ubuntu64_hw", 04:27:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:27:17 INFO - "branch": "mozilla-aurora", 04:27:17 INFO - "repo_path": "releases/mozilla-aurora", 04:27:17 INFO - "revision": "4d38a69eda61f663463af8f020447e9afbb118b1", 04:27:17 INFO - "pgo_build": "True", 04:27:17 INFO - "builduid": "5275c599c6904397a1806c151c356c46", 04:27:17 INFO - "slavebuilddir": "test" 04:27:17 INFO - } 04:27:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 04:27:17 INFO - Running post-action listener: _resource_record_post_action 04:27:17 INFO - [mozharness: 2016-08-28 11:27:17.635530Z] Finished read-buildbot-config step (success) 04:27:17 INFO - [mozharness: 2016-08-28 11:27:17.635620Z] Running download-and-extract step. 04:27:17 INFO - Running pre-action listener: _resource_record_pre_action 04:27:17 INFO - Running main action method: download_and_extract 04:27:17 INFO - mkdir: /builds/slave/test/build/tests 04:27:17 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')]} 04:27:17 INFO - https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:27:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:27:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:27:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:27:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:27:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:27:17 INFO - retry: Failed, sleeping 30 seconds before retrying 04:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:27:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:27:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:27:47 INFO - retry: Failed, sleeping 60 seconds before retrying 04:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:28:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:28:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:28:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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! 04:28:47 INFO - Caught exception: HTTP Error 404: Not Found 04:28:47 INFO - Caught exception: HTTP Error 404: Not Found 04:28:47 INFO - Caught exception: HTTP Error 404: Not Found 04:28:47 INFO - trying https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:28:47 INFO - Downloading https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:28:48 INFO - Downloaded 1361 bytes. 04:28:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:28:48 INFO - Using the following test package requirements: 04:28:48 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:28:48 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:28:48 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:28:48 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'jsshell-linux-x86_64.zip'], 04:28:48 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:28:48 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:28:48 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:28:48 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:28:48 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:28:48 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:28:48 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:28:48 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')]} 04:28:48 INFO - https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:28:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:28:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:28:48 INFO - retry: Failed, sleeping 30 seconds before retrying 04:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:29:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:29:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:29:18 INFO - retry: Failed, sleeping 60 seconds before retrying 04:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:30:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:30:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:30:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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! 04:30:18 INFO - Caught exception: HTTP Error 404: Not Found 04:30:18 INFO - Caught exception: HTTP Error 404: Not Found 04:30:18 INFO - Caught exception: HTTP Error 404: Not Found 04:30:18 INFO - trying https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:30:18 INFO - Downloading https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:30:19 INFO - Downloaded 21770875 bytes. 04:30:19 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'] 04:30:19 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 04:30:20 INFO - Return code: 0 04:30:20 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 04:30:20 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')]} 04:30:20 INFO - https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:30:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:30:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:30:20 INFO - retry: Failed, sleeping 30 seconds before retrying 04:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:30:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:30:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:30:50 INFO - retry: Failed, sleeping 60 seconds before retrying 04:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:31:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:31:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:31:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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! 04:31:50 INFO - Caught exception: HTTP Error 404: Not Found 04:31:50 INFO - Caught exception: HTTP Error 404: Not Found 04:31:50 INFO - Caught exception: HTTP Error 404: Not Found 04:31:50 INFO - trying https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:31:50 INFO - Downloading https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:31:51 INFO - Downloaded 21770875 bytes. 04:31:51 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'] 04:31:51 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 04:31:52 INFO - Return code: 0 04:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:52 INFO - https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:31:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:31:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:31:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:31:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:31:52 INFO - retry: Failed, sleeping 30 seconds before retrying 04:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:32:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:32:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:32:22 INFO - retry: Failed, sleeping 60 seconds before retrying 04:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:33:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:33:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:33:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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! 04:33:22 INFO - Caught exception: HTTP Error 404: Not Found 04:33:22 INFO - Caught exception: HTTP Error 404: Not Found 04:33:22 INFO - Caught exception: HTTP Error 404: Not Found 04:33:22 INFO - trying https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:33:22 INFO - Downloading https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:33:23 INFO - Downloaded 14413723 bytes. 04:33:23 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'] 04:33:23 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 04:33:23 INFO - Return code: 0 04:33:23 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')]} 04:33:23 INFO - https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:33:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:33:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:33:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:33:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:33:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:33:23 INFO - retry: Failed, sleeping 30 seconds before retrying 04:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:33:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:33:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:33:53 INFO - retry: Failed, sleeping 60 seconds before retrying 04:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:34:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:34:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:34:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DceP3cLkSRyynuNxN1DWbg/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! 04:34:54 INFO - Caught exception: HTTP Error 404: Not Found 04:34:54 INFO - Caught exception: HTTP Error 404: Not Found 04:34:54 INFO - Caught exception: HTTP Error 404: Not Found 04:34:54 INFO - trying https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:34:54 INFO - Downloading https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/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 04:34:55 INFO - Downloaded 63746809 bytes. 04:34:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:34:55 INFO - mkdir: /builds/slave/test/properties 04:34:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:55 INFO - Contents: 04:34:55 INFO - build_url:https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:34:55 INFO - Running post-action listener: _resource_record_post_action 04:34:55 INFO - Running post-action listener: set_extra_try_arguments 04:34:55 INFO - [mozharness: 2016-08-28 11:34:55.855452Z] Finished download-and-extract step (success) 04:34:55 INFO - [mozharness: 2016-08-28 11:34:55.855685Z] Running populate-webroot step. 04:34:55 INFO - Running pre-action listener: _resource_record_pre_action 04:34:55 INFO - Running main action method: populate_webroot 04:34:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:55 INFO - '--tppagecycles', 04:34:55 INFO - '7'], 04:34:55 INFO - 'tests': ['tsvgm']}}, 04:34:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['damp', 'tps']}, 04:34:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'tests': ['damp', 'tps']}, 04:34:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['dromaeo_dom']}, 04:34:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['basic_compositor_video']}, 04:34:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['a11yr', 04:34:55 INFO - 'ts_paint', 04:34:55 INFO - 'tpaint', 04:34:55 INFO - 'sessionrestore', 04:34:55 INFO - 'sessionrestore_no_auto_restore', 04:34:55 INFO - 'tabpaint']}, 04:34:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:55 INFO - 'ts_paint', 04:34:55 INFO - 'tpaint', 04:34:55 INFO - 'sessionrestore', 04:34:55 INFO - 'sessionrestore_no_auto_restore', 04:34:55 INFO - 'tabpaint']}, 04:34:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:55 INFO - 'ts_paint', 04:34:55 INFO - 'tpaint', 04:34:55 INFO - 'sessionrestore', 04:34:55 INFO - 'sessionrestore_no_auto_restore', 04:34:55 INFO - 'tabpaint']}, 04:34:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:55 INFO - 'ts_paint', 04:34:55 INFO - 'tpaint', 04:34:55 INFO - 'sessionrestore', 04:34:55 INFO - 'sessionrestore_no_auto_restore', 04:34:55 INFO - 'tabpaint']}, 04:34:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['a11yr', 04:34:55 INFO - 'ts_paint', 04:34:55 INFO - 'tpaint', 04:34:55 INFO - 'sessionrestore', 04:34:55 INFO - 'sessionrestore_no_auto_restore', 04:34:55 INFO - 'tabpaint']}, 04:34:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['a11yr', 04:34:55 INFO - 'ts_paint', 04:34:55 INFO - 'tpaint', 04:34:55 INFO - 'sessionrestore', 04:34:55 INFO - 'sessionrestore_no_auto_restore', 04:34:55 INFO - 'tabpaint']}, 04:34:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['tsvgx', 04:34:55 INFO - 'tsvgr_opacity', 04:34:55 INFO - 'tart', 04:34:55 INFO - 'tscrollx', 04:34:55 INFO - 'cart']}, 04:34:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:55 INFO - 'tsvgr_opacity', 04:34:55 INFO - 'tart', 04:34:55 INFO - 'tscrollx', 04:34:55 INFO - 'cart']}, 04:34:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'talos_options': ['--disable-e10s'], 04:34:55 INFO - 'tests': ['tp5o']}, 04:34:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'tests': ['tp5o']}, 04:34:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'talos_options': ['--disable-e10s', 04:34:55 INFO - '--xperf_path', 04:34:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:55 INFO - 'tests': ['tp5n']}, 04:34:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:55 INFO - 'talos_options': ['--xperf_path', 04:34:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:55 INFO - 'tests': ['tp5n']}}, 04:34:55 INFO - 'talos.zip': {'path': '', 04:34:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:55 INFO - Running post-action listener: _resource_record_post_action 04:34:55 INFO - [mozharness: 2016-08-28 11:34:55.876048Z] Finished populate-webroot step (success) 04:34:55 INFO - [mozharness: 2016-08-28 11:34:55.876148Z] Running create-virtualenv step. 04:34:55 INFO - Running pre-action listener: _resource_record_pre_action 04:34:55 INFO - Running main action method: create_virtualenv 04:34:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:55 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 04:34:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:55 INFO - Using real prefix '/usr' 04:34:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:58 INFO - Installing pip.................done. 04:34:58 INFO - Return code: 0 04:34:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:34: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', 'pip>=1.5'] in /builds/slave/test/build 04:34: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 pip>=1.5 04:34:58 INFO - Using env: {'DISPLAY': ':0', 04:34:58 INFO - 'HOME': '/home/cltbld', 04:34:58 INFO - 'LANG': 'en_US.UTF-8', 04:34:58 INFO - 'LANGUAGE': 'en_US:en', 04:34:58 INFO - 'LOGNAME': 'cltbld', 04:34:58 INFO - 'MAIL': '/var/mail/cltbld', 04:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:58 INFO - 'MOZ_NO_REMOTE': '1', 04:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:58 INFO - 'NO_EM_RESTART': '1', 04:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:58 INFO - 'PWD': '/builds/slave/test', 04:34:58 INFO - 'SHELL': '/bin/bash', 04:34:58 INFO - 'SHLVL': '1', 04:34:58 INFO - 'TERM': 'linux', 04:34:58 INFO - 'TMOUT': '86400', 04:34:58 INFO - 'USER': 'cltbld', 04:34:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:58 INFO - '_': '/tools/buildbot/bin/python'} 04:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:58 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 04:34:58 INFO - Cleaning up... 04:34:58 INFO - Return code: 0 04:34:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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', '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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:34: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:34: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 psutil>=3.1.1 04:34:58 INFO - Using env: {'DISPLAY': ':0', 04:34:58 INFO - 'HOME': '/home/cltbld', 04:34:58 INFO - 'LANG': 'en_US.UTF-8', 04:34:58 INFO - 'LANGUAGE': 'en_US:en', 04:34:58 INFO - 'LOGNAME': 'cltbld', 04:34:58 INFO - 'MAIL': '/var/mail/cltbld', 04:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:58 INFO - 'MOZ_NO_REMOTE': '1', 04:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:58 INFO - 'NO_EM_RESTART': '1', 04:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:58 INFO - 'PWD': '/builds/slave/test', 04:34:58 INFO - 'SHELL': '/bin/bash', 04:34:58 INFO - 'SHLVL': '1', 04:34:58 INFO - 'TERM': 'linux', 04:34:58 INFO - 'TMOUT': '86400', 04:34:58 INFO - 'USER': 'cltbld', 04:34:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:58 INFO - '_': '/tools/buildbot/bin/python'} 04:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:58 INFO - Downloading/unpacking psutil>=3.1.1 04:34:58 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 04:34:58 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 04:34:58 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 04:34:58 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 04:34:58 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 04:34:58 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 04:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:00 INFO - Installing collected packages: psutil 04:35:00 INFO - Running setup.py install for psutil 04:35:00 INFO - building 'psutil._psutil_linux' extension 04:35:00 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 04:35:01 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 04:35:01 INFO - building 'psutil._psutil_posix' extension 04:35:01 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 04:35:01 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 04:35:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:01 INFO - Successfully installed psutil 04:35:01 INFO - Cleaning up... 04:35:01 INFO - Return code: 0 04:35:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:35: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 mozsystemmonitor==0.3 04:35:01 INFO - Using env: {'DISPLAY': ':0', 04:35:01 INFO - 'HOME': '/home/cltbld', 04:35:01 INFO - 'LANG': 'en_US.UTF-8', 04:35:01 INFO - 'LANGUAGE': 'en_US:en', 04:35:01 INFO - 'LOGNAME': 'cltbld', 04:35:01 INFO - 'MAIL': '/var/mail/cltbld', 04:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:01 INFO - 'MOZ_NO_REMOTE': '1', 04:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:01 INFO - 'NO_EM_RESTART': '1', 04:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:01 INFO - 'PWD': '/builds/slave/test', 04:35:01 INFO - 'SHELL': '/bin/bash', 04:35:01 INFO - 'SHLVL': '1', 04:35:01 INFO - 'TERM': 'linux', 04:35:01 INFO - 'TMOUT': '86400', 04:35:01 INFO - 'USER': 'cltbld', 04:35:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:01 INFO - '_': '/tools/buildbot/bin/python'} 04:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:35:03 INFO - Installing collected packages: mozsystemmonitor 04:35:03 INFO - Running setup.py install for mozsystemmonitor 04:35:03 INFO - Successfully installed mozsystemmonitor 04:35:03 INFO - Cleaning up... 04:35:03 INFO - Return code: 0 04:35:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:35:03 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')]} 04:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:03 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')]} 04:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:03 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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35:03 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 04:35:03 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 04:35:03 INFO - Using env: {'DISPLAY': ':0', 04:35:03 INFO - 'HOME': '/home/cltbld', 04:35:03 INFO - 'LANG': 'en_US.UTF-8', 04:35:03 INFO - 'LANGUAGE': 'en_US:en', 04:35:03 INFO - 'LOGNAME': 'cltbld', 04:35:03 INFO - 'MAIL': '/var/mail/cltbld', 04:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:03 INFO - 'MOZ_NO_REMOTE': '1', 04:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:03 INFO - 'NO_EM_RESTART': '1', 04:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:03 INFO - 'PWD': '/builds/slave/test', 04:35:03 INFO - 'SHELL': '/bin/bash', 04:35:03 INFO - 'SHLVL': '1', 04:35:03 INFO - 'TERM': 'linux', 04:35:03 INFO - 'TMOUT': '86400', 04:35:03 INFO - 'USER': 'cltbld', 04:35:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:03 INFO - '_': '/tools/buildbot/bin/python'} 04:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:04 INFO - Downloading/unpacking jsonschema==2.5.1 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:06 INFO - warning: no files found matching '*.txt' 04:35:06 INFO - no previously-included directories found matching 'build' 04:35:06 INFO - no previously-included directories found matching 'dist' 04:35:06 INFO - no previously-included directories found matching '.git*' 04:35:06 INFO - Installing collected packages: jsonschema, functools32 04:35:06 INFO - Running setup.py install for functools32 04:35:06 INFO - warning: no files found matching '*.txt' 04:35:06 INFO - no previously-included directories found matching 'build' 04:35:06 INFO - no previously-included directories found matching 'dist' 04:35:06 INFO - no previously-included directories found matching '.git*' 04:35:06 INFO - Successfully installed jsonschema functools32 04:35:06 INFO - Cleaning up... 04:35:06 INFO - Return code: 0 04:35:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:35:06 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')]} 04:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 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')]} 04:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35:06 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 04:35:06 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 04:35:06 INFO - Using env: {'DISPLAY': ':0', 04:35:06 INFO - 'HOME': '/home/cltbld', 04:35:06 INFO - 'LANG': 'en_US.UTF-8', 04:35:06 INFO - 'LANGUAGE': 'en_US:en', 04:35:06 INFO - 'LOGNAME': 'cltbld', 04:35:06 INFO - 'MAIL': '/var/mail/cltbld', 04:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:06 INFO - 'MOZ_NO_REMOTE': '1', 04:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:06 INFO - 'NO_EM_RESTART': '1', 04:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:06 INFO - 'PWD': '/builds/slave/test', 04:35:06 INFO - 'SHELL': '/bin/bash', 04:35:06 INFO - 'SHLVL': '1', 04:35:06 INFO - 'TERM': 'linux', 04:35:06 INFO - 'TMOUT': '86400', 04:35:06 INFO - 'USER': 'cltbld', 04:35:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:06 INFO - '_': '/tools/buildbot/bin/python'} 04:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:35:06 INFO - Cleaning up... 04:35:06 INFO - Return code: 0 04:35:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35:06 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')]} 04:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 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')]} 04:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35:06 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 04:35:06 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 04:35:06 INFO - Using env: {'DISPLAY': ':0', 04:35:06 INFO - 'HOME': '/home/cltbld', 04:35:06 INFO - 'LANG': 'en_US.UTF-8', 04:35:06 INFO - 'LANGUAGE': 'en_US:en', 04:35:06 INFO - 'LOGNAME': 'cltbld', 04:35:06 INFO - 'MAIL': '/var/mail/cltbld', 04:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:06 INFO - 'MOZ_NO_REMOTE': '1', 04:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:06 INFO - 'NO_EM_RESTART': '1', 04:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:06 INFO - 'PWD': '/builds/slave/test', 04:35:06 INFO - 'SHELL': '/bin/bash', 04:35:06 INFO - 'SHLVL': '1', 04:35:06 INFO - 'TERM': 'linux', 04:35:06 INFO - 'TMOUT': '86400', 04:35:06 INFO - 'USER': 'cltbld', 04:35:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:06 INFO - '_': '/tools/buildbot/bin/python'} 04:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:06 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 04:35:06 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 04:35:06 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 04:35:06 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 04:35:06 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 04:35:06 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 04:35:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:08 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 04:35:08 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 04:35:08 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 04:35:08 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 04:35:08 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 04:35:08 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 04:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35:09 INFO - Downloading docopt-0.6.1.tar.gz 04:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:09 INFO - Running setup.py install for blobuploader 04:35:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:09 INFO - Running setup.py install for requests 04:35:09 INFO - Running setup.py install for docopt 04:35:10 INFO - Successfully installed blobuploader requests docopt 04:35:10 INFO - Cleaning up... 04:35:10 INFO - Return code: 0 04:35:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:10 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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35:10 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 04:35:10 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 04:35:10 INFO - Using env: {'DISPLAY': ':0', 04:35:10 INFO - 'HOME': '/home/cltbld', 04:35:10 INFO - 'LANG': 'en_US.UTF-8', 04:35:10 INFO - 'LANGUAGE': 'en_US:en', 04:35:10 INFO - 'LOGNAME': 'cltbld', 04:35:10 INFO - 'MAIL': '/var/mail/cltbld', 04:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:10 INFO - 'MOZ_NO_REMOTE': '1', 04:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:10 INFO - 'NO_EM_RESTART': '1', 04:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:10 INFO - 'PWD': '/builds/slave/test', 04:35:10 INFO - 'SHELL': '/bin/bash', 04:35:10 INFO - 'SHLVL': '1', 04:35:10 INFO - 'TERM': 'linux', 04:35:10 INFO - 'TMOUT': '86400', 04:35:10 INFO - 'USER': 'cltbld', 04:35:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:10 INFO - '_': '/tools/buildbot/bin/python'} 04:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:10 INFO - Running setup.py (path:/tmp/pip-bwp6NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:10 INFO - Running setup.py (path:/tmp/pip-4mOKmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:10 INFO - Running setup.py (path:/tmp/pip-Z5_WJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:10 INFO - Running setup.py (path:/tmp/pip-Ki8AlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:10 INFO - Running setup.py (path:/tmp/pip-XDFuVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:10 INFO - Running setup.py (path:/tmp/pip-CJtRGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:10 INFO - Running setup.py (path:/tmp/pip-A2k8Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:10 INFO - Running setup.py (path:/tmp/pip-ZawHba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:10 INFO - Running setup.py (path:/tmp/pip-WMPYUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:10 INFO - Running setup.py (path:/tmp/pip-KljiLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:11 INFO - Running setup.py (path:/tmp/pip-LQRmmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:11 INFO - Running setup.py (path:/tmp/pip-kaRUYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:11 INFO - Running setup.py (path:/tmp/pip-IczMyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:11 INFO - Running setup.py (path:/tmp/pip-pVEoKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:11 INFO - Running setup.py (path:/tmp/pip-KVMIcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:11 INFO - Running setup.py (path:/tmp/pip-QueuMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:11 INFO - Running setup.py (path:/tmp/pip-cHnNte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:11 INFO - Running setup.py install for manifestparser 04:35:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Running setup.py install for mozcrash 04:35:11 INFO - Running setup.py install for mozdebug 04:35:11 INFO - Running setup.py install for mozdevice 04:35:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Running setup.py install for mozfile 04:35:12 INFO - Running setup.py install for mozhttpd 04:35:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Running setup.py install for mozinfo 04:35:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Running setup.py install for mozInstall 04:35:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Running setup.py install for mozleak 04:35:12 INFO - Running setup.py install for mozlog 04:35:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Running setup.py install for moznetwork 04:35:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Running setup.py install for mozprocess 04:35:12 INFO - Running setup.py install for mozprofile 04:35:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:12 INFO - Running setup.py install for mozrunner 04:35:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:13 INFO - Running setup.py install for mozscreenshot 04:35:13 INFO - Running setup.py install for moztest 04:35:13 INFO - Running setup.py install for mozversion 04:35:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:13 INFO - Cleaning up... 04:35:13 INFO - Return code: 0 04:35:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:13 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')]} 04:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:13 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')]} 04:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:13 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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35:13 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 04:35:13 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 04:35:13 INFO - Using env: {'DISPLAY': ':0', 04:35:13 INFO - 'HOME': '/home/cltbld', 04:35:13 INFO - 'LANG': 'en_US.UTF-8', 04:35:13 INFO - 'LANGUAGE': 'en_US:en', 04:35:13 INFO - 'LOGNAME': 'cltbld', 04:35:13 INFO - 'MAIL': '/var/mail/cltbld', 04:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:13 INFO - 'MOZ_NO_REMOTE': '1', 04:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:13 INFO - 'NO_EM_RESTART': '1', 04:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:13 INFO - 'PWD': '/builds/slave/test', 04:35:13 INFO - 'SHELL': '/bin/bash', 04:35:13 INFO - 'SHLVL': '1', 04:35:13 INFO - 'TERM': 'linux', 04:35:13 INFO - 'TMOUT': '86400', 04:35:13 INFO - 'USER': 'cltbld', 04:35:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:13 INFO - '_': '/tools/buildbot/bin/python'} 04:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:13 INFO - Running setup.py (path:/tmp/pip-RMKVql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:13 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)) 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:13 INFO - Running setup.py (path:/tmp/pip-DwgEOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:13 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)) 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:13 INFO - Running setup.py (path:/tmp/pip-lmVsm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:13 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)) 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:13 INFO - Running setup.py (path:/tmp/pip-0c_uJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:13 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)) 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:13 INFO - Running setup.py (path:/tmp/pip-Z523CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:13 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)) 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:13 INFO - Running setup.py (path:/tmp/pip-M4nPxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:14 INFO - Running setup.py (path:/tmp/pip-dHjPEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:14 INFO - Running setup.py (path:/tmp/pip-VaDcIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:14 INFO - Running setup.py (path:/tmp/pip-Lbv_am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:14 INFO - Running setup.py (path:/tmp/pip-Gy1PJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:14 INFO - Running setup.py (path:/tmp/pip-iYaT5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:14 INFO - Running setup.py (path:/tmp/pip-QAa9f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:14 INFO - Running setup.py (path:/tmp/pip-0sXPEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:14 INFO - Running setup.py (path:/tmp/pip-m3m0O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:14 INFO - Running setup.py (path:/tmp/pip-qoDxYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:14 INFO - Running setup.py (path:/tmp/pip-iyhUJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:14 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)) 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:14 INFO - Running setup.py (path:/tmp/pip-4F4pac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:14 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)) 04:35:14 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)) 04:35:14 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)) 04:35:14 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)) 04:35:14 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)) 04:35:14 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)) 04:35:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:14 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 04:35:14 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 04:35:14 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 04:35:14 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 04:35:14 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 04:35:14 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 04:35:16 INFO - Downloading blessings-1.6.tar.gz 04:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:16 INFO - Installing collected packages: blessings 04:35:16 INFO - Running setup.py install for blessings 04:35:16 INFO - Successfully installed blessings 04:35:16 INFO - Cleaning up... 04:35:16 INFO - Return code: 0 04:35:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:17 INFO - Reading from file tmpfile_stdout 04:35:17 INFO - Current package versions: 04:35:17 INFO - argparse == 1.2.1 04:35:17 INFO - blessings == 1.6 04:35:17 INFO - blobuploader == 1.2.4 04:35:17 INFO - docopt == 0.6.1 04:35:17 INFO - functools32 == 3.2.3-2 04:35:17 INFO - jsonschema == 2.5.1 04:35:17 INFO - manifestparser == 1.1 04:35:17 INFO - mozInstall == 1.12 04:35:17 INFO - mozcrash == 0.17 04:35:17 INFO - mozdebug == 0.1 04:35:17 INFO - mozdevice == 0.48 04:35:17 INFO - mozfile == 1.2 04:35:17 INFO - mozhttpd == 0.7 04:35:17 INFO - mozinfo == 0.9 04:35:17 INFO - mozleak == 0.1 04:35:17 INFO - mozlog == 3.3 04:35:17 INFO - moznetwork == 0.27 04:35:17 INFO - mozprocess == 0.23 04:35:17 INFO - mozprofile == 0.28 04:35:17 INFO - mozrunner == 6.12 04:35:17 INFO - mozscreenshot == 0.1 04:35:17 INFO - mozsystemmonitor == 0.3 04:35:17 INFO - moztest == 0.7 04:35:17 INFO - mozversion == 1.4 04:35:17 INFO - psutil == 3.1.1 04:35:17 INFO - requests == 1.2.3 04:35:17 INFO - wsgiref == 0.1.2 04:35:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:17 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')]} 04:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 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')]} 04:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35:17 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 04:35:17 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 04:35:17 INFO - Using env: {'DISPLAY': ':0', 04:35:17 INFO - 'HOME': '/home/cltbld', 04:35:17 INFO - 'LANG': 'en_US.UTF-8', 04:35:17 INFO - 'LANGUAGE': 'en_US:en', 04:35:17 INFO - 'LOGNAME': 'cltbld', 04:35:17 INFO - 'MAIL': '/var/mail/cltbld', 04:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:17 INFO - 'MOZ_NO_REMOTE': '1', 04:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:17 INFO - 'NO_EM_RESTART': '1', 04:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:17 INFO - 'PWD': '/builds/slave/test', 04:35:17 INFO - 'SHELL': '/bin/bash', 04:35:17 INFO - 'SHLVL': '1', 04:35:17 INFO - 'TERM': 'linux', 04:35:17 INFO - 'TMOUT': '86400', 04:35:17 INFO - 'USER': 'cltbld', 04:35:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:17 INFO - '_': '/tools/buildbot/bin/python'} 04:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 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)) 04:35:17 INFO - Cleaning up... 04:35:17 INFO - Return code: 0 04:35:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35:17 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')]} 04:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 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')]} 04:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 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 0x1dab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fda400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', '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 04:35:17 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 04:35:17 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 04:35:17 INFO - Using env: {'DISPLAY': ':0', 04:35:17 INFO - 'HOME': '/home/cltbld', 04:35:17 INFO - 'LANG': 'en_US.UTF-8', 04:35:17 INFO - 'LANGUAGE': 'en_US:en', 04:35:17 INFO - 'LOGNAME': 'cltbld', 04:35:17 INFO - 'MAIL': '/var/mail/cltbld', 04:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:17 INFO - 'MOZ_NO_REMOTE': '1', 04:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:17 INFO - 'NO_EM_RESTART': '1', 04:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:17 INFO - 'PWD': '/builds/slave/test', 04:35:17 INFO - 'SHELL': '/bin/bash', 04:35:17 INFO - 'SHLVL': '1', 04:35:17 INFO - 'TERM': 'linux', 04:35:17 INFO - 'TMOUT': '86400', 04:35:17 INFO - 'USER': 'cltbld', 04:35:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:17 INFO - '_': '/tools/buildbot/bin/python'} 04:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:35:17 INFO - Cleaning up... 04:35:17 INFO - Return code: 0 04:35:17 INFO - Running post-action listener: _resource_record_post_action 04:35:17 INFO - Running post-action listener: _start_resource_monitoring 04:35:17 INFO - Starting resource monitoring. 04:35:17 INFO - [mozharness: 2016-08-28 11:35:17.625182Z] Finished create-virtualenv step (success) 04:35:17 INFO - [mozharness: 2016-08-28 11:35:17.625653Z] Running install step. 04:35:17 INFO - Running pre-action listener: _resource_record_pre_action 04:35:17 INFO - Running main action method: install 04:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:17 INFO - Reading from file tmpfile_stdout 04:35:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:17 INFO - Reading from file tmpfile_stdout 04:35:17 INFO - Output received: 04:35:17 INFO - Usage: mozinstall [options] installer 04:35:17 INFO - Options: 04:35:17 INFO - -h, --help show this help message and exit 04:35:17 INFO - -d DEST, --destination=DEST 04:35:17 INFO - Directory to install application into. [default: 04:35:17 INFO - "/builds/slave/test"] 04:35:17 INFO - --app=APP Application being installed. [default: firefox] 04:35:17 INFO - mkdir: /builds/slave/test/build/application 04:35:17 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'] 04:35:17 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 04:35:34 INFO - Reading from file tmpfile_stdout 04:35:34 INFO - Output received: 04:35:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:35:34 INFO - Running post-action listener: _resource_record_post_action 04:35:34 INFO - [mozharness: 2016-08-28 11:35:34.615339Z] Finished install step (success) 04:35:34 INFO - [mozharness: 2016-08-28 11:35:34.615615Z] Running run-tests step. 04:35:34 INFO - Running pre-action listener: _resource_record_pre_action 04:35:34 INFO - Running main action method: run_tests 04:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:34 INFO - Python 2.7.3 04:35:34 INFO - Return code: 0 04:35:34 INFO - grabbing minidump binary from tooltool 04:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:34 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 0x2069570>, '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 0x206a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:34 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 04:35:34 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 04:35:34 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 04:35:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:34 INFO - Return code: 0 04:35:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:35:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:35:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:34 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/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 04:35:34 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/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 04:35:34 INFO - Using env: {'DISPLAY': ':0', 04:35:34 INFO - 'HOME': '/home/cltbld', 04:35:34 INFO - 'LANG': 'en_US.UTF-8', 04:35:34 INFO - 'LANGUAGE': 'en_US:en', 04:35:34 INFO - 'LOGNAME': 'cltbld', 04:35:34 INFO - 'MAIL': '/var/mail/cltbld', 04:35:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:34 INFO - 'MOZ_NO_REMOTE': '1', 04:35:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:34 INFO - 'NO_EM_RESTART': '1', 04:35:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:34 INFO - 'PWD': '/builds/slave/test', 04:35:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:34 INFO - 'SHELL': '/bin/bash', 04:35:34 INFO - 'SHLVL': '1', 04:35:34 INFO - 'TERM': 'linux', 04:35:34 INFO - 'TMOUT': '86400', 04:35:34 INFO - 'USER': 'cltbld', 04:35:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022', 04:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:34 INFO - '_': '/tools/buildbot/bin/python'} 04:35:34 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/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 04:35:34 INFO - mozversion application_buildid: 20160827004001 04:35:34 INFO - mozversion application_changeset: 4d38a69eda61f663463af8f020447e9afbb118b1 04:35:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:35:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:34 INFO - mozversion application_name: Firefox 04:35:34 INFO - mozversion application_remotingname: firefox-dev 04:35:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:35:34 INFO - mozversion application_vendor: Mozilla 04:35:34 INFO - mozversion application_version: 50.0a2 04:35:34 INFO - mozversion platform_buildid: 20160827004001 04:35:34 INFO - mozversion platform_changeset: 4d38a69eda61f663463af8f020447e9afbb118b1 04:35:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:35:34 INFO - mozversion platform_version: 50.0a2 04:35:34 INFO - using testdate: 1472384134 04:35:34 INFO - actual date: 1472384134 04:35:34 INFO - starting webserver on 'localhost:37897' 04:35:34 INFO - SUITE-START | Running 2 tests 04:35:34 INFO - TEST-START | dromaeo_css 04:35:34 INFO - operating with platform_type : linux_ 04:35:34 INFO - Initialising browser for dromaeo_css test... 04:35:34 INFO - TEST-INFO | started process 18842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7pSRvz/profile http://localhost:37897/getInfo.html) 04:35:39 INFO - PROCESS | 18842 | __metrics Screen width/height:1600/1200 04:35:39 INFO - PROCESS | 18842 | colorDepth:24 04:35:39 INFO - PROCESS | 18842 | Browser inner width/height: 1024/697 04:35:39 INFO - PROCESS | 18842 | __metrics 04:35:40 ERROR - PROCESS | 18842 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:35:40 INFO - TEST-INFO | 18842: exit 0 04:35:40 INFO - Browser initialized. 04:35:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:40 INFO - TEST-INFO | started process 18966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7pSRvz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:52 INFO - PROCESS | 18966 | RSS: Main: 152616960 04:35:52 INFO - PROCESS | 18966 | 04:36:42 INFO - PROCESS | 18966 | 1472384202221 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] 04:38:50 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:37897/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37897/tests/dromaeo/cssquery-ext.html) 04:38:51 INFO - PROCESS | 18966 | RSS: Main: 158146560 04:38:51 INFO - PROCESS | 18966 | 04:41:53 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:37897/tests/dromaeo/cssquery-ext.html (next: http://localhost:37897/tests/dromaeo/cssquery-jquery.html) 04:41:54 INFO - PROCESS | 18966 | RSS: Main: 154660864 04:41:54 INFO - PROCESS | 18966 | 04:44:56 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:37897/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37897/tests/dromaeo/cssquery-mootools.html) 04:44:56 INFO - PROCESS | 18966 | RSS: Main: 154411008 04:44:56 INFO - PROCESS | 18966 | 04:47:58 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:37897/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37897/tests/dromaeo/cssquery-prototype.html) 04:47:59 INFO - PROCESS | 18966 | RSS: Main: 153047040 04:47:59 INFO - PROCESS | 18966 | 04:51:01 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:37897/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37897/tests/dromaeo/cssquery-yui.html) 04:51:02 INFO - PROCESS | 18966 | RSS: Main: 155865088 04:51:02 INFO - PROCESS | 18966 | 04:54:04 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:37897/tests/dromaeo/cssquery-yui.html (next: http://localhost:37897/tests/dromaeo/cssquery-dojo.html) 04:54:05 INFO - PROCESS | 18966 | RSS: Main: 155738112 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | __start_tp_report 04:54:05 INFO - PROCESS | 18966 | _x_x_mozilla_page_load 04:54:05 INFO - PROCESS | 18966 | _x_x_mozilla_page_load_details 04:54:05 INFO - PROCESS | 18966 | |i|pagename|runs| 04:54:05 INFO - PROCESS | 18966 | |0;dojo.html;3329.051220402185;3336.416127177744;3345.046661701414;3352.1619595101224;3370.073229861789;5849.064149736043;5891.204687367204;5913.526917846572;5923.555733319997;5933.1396947442645;5905.734241959111;5971.880562388749;5974.402559744023;5976.6712830794395;5984.790532331369;5332.33345831772;5354.437784032679;5408.2698835657075;5410.377806552257;5456.154296084113;5261.973690131544;5266.736663166846;5317.255584218213;5341.145416733323;5407.324084489419;5353.08997470429;5360.785568577252;5375.166849138371;5392.946070539284;5475.698836563987;5359.919601205966;5416.1063424534905;5419.945800542003;5423.2949716537;5424.1321388578035;5124.5131712487255;5249.606279529051;5305.73471326436;5364.061289274361;5402.297701298806;5692;5721.256236689245;5735.2257445245195;5806.854828629276;5858.56060795442;6183.876322473526;6254.781082662131;6258.405451482102;6259.405356491126;6266.780662676784;6096.329403765582;6310;6343.746250149989;6344.302126766052;6358.618482890995;5776.682282474462;5785.71071446426;5809.070548712186;5820.505257053155;5894.970525147347;6349.301576826545;6355.555111142268;6388.872222555523;6394.680265986682;6409.615423074631;6049.516038716892;6121.571489995747;6122.938770612326;6160.414760597826;6167.044108163242;6167.444929956326;6202.906956395657;6240.157578726814;6327.335629758901;6340.080688300171;6204.441600255998;6243.125962365272;6270.372962703693;6295.811125666238;6303.842403939847;6130.448259656563;6184.8763024739255;6238.750449982041;6258.780942666985;6266.216722909637;4755.619550435957;4764.475907650156;4778.068276686013;4795.856124316276;4825.855224343275;4201.768902710381;4233.809478573472;4250.128723611652;4264.317709166518;4285.635720963753;5843.737031833492;6052.12244224585;6083.13417122791;6107.816765497042;6139.907901381483;6223.471004964538;6230.937690623126;6230.968845155836;6361.332060133712;6362;6050.2437195350585;6073.51411887048;6079.240094988127;6095.512359011268;6107.969460152671;5116.181410974226;5298.390685071189;5304.602154838402;5309.840704778863;5326.227696983916;6447.709853056624;6457;6486.643234622141;6606.339366063451;6616.8345791355605;6336.112944187726;6353.491720662243;6390.648514331757;6400.327965563642;6404.743810247538;6273.121762953099;6573.408393244631;6621.3047629998155;6629.867402651824;6638.900416493853;6111.86523267538;6122.245686735438;6178.165947597017;6246.562740608114;6246.843828904313;6372.808815735535;6379.234491861006;6383.170187875547;6386.329435409215;6387.744490220339;6006.489448396936;6251.437370636482;6256.280527739368;6274.247090349188;6292.842678933063;6108;6124.3809352984035;6124.846878828065;6196;6199.659018754011;6105.262111899988;6119.082137679384;6147.754089836535;6151.9384806151365;6170.50635949132;6020.789272375446;6183.886900357978;6269.216347956505;6272.937270627235;6301.054841773587;6005.87988240224;6026.939730602638;6042.879142417215;6109.34393638171;6141.240538582456 04:54:05 INFO - PROCESS | 18966 | |1;ext.html;588.576225117915;643.6749441532027;667.7462564225593;673.1988933169528;709.7898083767177;41891;46978;47046.29430558544;47069.529304706986;47229.76385118078;45438.772806136;45787.771061144646;46092.539074609245;46229.53770462294;46320;9223.953880230589;9268.860967085498;9350.111739384747;9384.24926005918;9399.671011514598;9246.953765231165;9329.440233586007;9333.859992100124;9359.064093590654;9374;9441.480718560477;9494.810103797954;9495.857562136538;9503.429794212334;9522.57148428319;9390.060993900624;9396.577154028051;9398.201152902011;9425.34022618417;9438.433693978315;9290.070992900723;9333.533323333873;9338.206252468548;9340.579673914623;9371.109744574254;44231;44287;44398;44433.33349999753;44751;3842.769433833979;4021.2761702893467;4150.107726838744;4195.769232692201;4601.102784956935;34979.4753078704;35036.824815875756;35273.82363088194;35684.107897302776;36595.451068234;4751.1922973094315;4760.523947605247;4779.928301075487;4785.138675038492;4816.7350795706225;393149;394135;397488.01255993824;399653;401112;65279.34720652732;65394;65402.345976539626;65520.67239663866;65535.34464655293;40415.191696165915;40858.1828363437;41245;42860.35709464361;42873;19773.110210040584;19854.70217946732;19867.205311787366;19877.105530251174;19886;15227.923860380848;15376.923115384576;15377.769333460006;15383;15383.230838458032;21338.893305533373;21403.892980534998;21430.78569214288;21452.570948580942;21610.135594576357;7545.7358992435;7607.16321204667;7852.450328476952;7865.449418540762;7876;1002.4085789384299;1049.5067318360511;1095.1293721491434;1109.046220250584;1167.7664467106442;33706.831465843;33918.321633567684;33990.830045849616;34122.14694632654;34226.82886585551;1189.6312143235625;1190.4107466803814;1217.5555922088552;1244.6390546741343;1272.6754677557165;17820.732689009674;18055.187516561786;18145.364912228273;18225.544361391072;18454.35409760652;588981;590623;592305;594815;595134;65267;65435.345646542926;65607;65627.34372656212;65724.34275657278;1437.116173553257;1464.414234306286;1468.2218424235386;1470.7720303352996;1487.5834766265464;32725.509117363734;33786.49320260149;34126.48810267897;34237.315253695284;34334.82832585821;62772.686136570854;64992.35007650052;65092.67453662701;69907.30092699008;70122.64938675275;575686;576998;578035;579714;582996;49169;49289.26066108939;49595;50115.24827127669;50442;54255;54575.72712136573;54730.45269547254;54742.72628636831;55204.723976379864;46493.76753116213;46691.533084670074;46843.29735054045;48007.27989080236;48079.278810817166;45700;46183.76908115438;46759.76620117014;47250.29124563066;47686.28470573013;39587.80206099066;44664.77667611641;44995.77502112468;45619;46197.53802462067;39240.60759392484;39414.40878386769;40582.59417405788;41808;41989.37015944702;30397;30583.694163058975;30822.845885771323;31077.205973709355;31131 04:54:05 INFO - PROCESS | 18966 | |2;jquery.html;422.8799281683411;424.14958009191565;434.8456298014205;437.4619218361415;441.6025576980717;19137.234510619575;21052.89473552632;21322.786772132273;21589.46026349342;22295.331140065784;20164.39506814798;20962.790372096275;21145.47136321589;21172.788272117275;21202.46993825155;5966.701664916748;6117.877642447148;6198.907016394735;6216.1918950536365;6230.875382492348;6077.1491991121275;6100.298465676437;6131.448169664729;6155.353687862777;6156.076588511737;6026.0659597762415;6047.939520604804;6053.606515576495;6096.96951515244;6108.877822443548;6014.909776353336;6042.848928776772;6053.606515576495;6088.178095957033;6129.1725617041575;5432.239486471897;5488.9725551371985;5512.366077901052;5512.779488820443;5517.834464966058;24773.132940347;24788.5042299153;24992.125275615446;25039;25749.74250257511;2606.973930260711;2739.9726002739917;2832.929176770597;3168.429682657121;3200.943688582762;15798.526044218577;16051.839481605151;16161.4343497977;16389.42637007699;16786.74819877703;1966.429735376739;1976.901154942247;2035.0943829995658;2095.863768855035;2132.0618927671776;80363.19636803615;81501.59249203716;81883;83029.99999999939;83295;10035.548400322003;10095.141912937483;11163.665090047312;11932.164748467523;11969.281843089442;16514.917425412797;16577.254023568967;16593.170341482877;16638.667226655398;16704.582385440463;9186.816263674822;9194.12655797698;9209.76975575616;9308.95345523268;9495.14543691071;9202.723918282461;9206.217471514863;9265.25877929764;9399.154076133182;9489.288303377274;7077.256888026786;7094.822629434306;7236.819079523054;7269.563826170447;7328.487005909642;2084.6143463459307;2101.590189912983;2106.5155014346788;2164.577907308091;2191.2878314547515;1037.6523864505325;1082.5615625671617;1144.8837383551138;1167.9605151415246;1228.2446295528187;21107.366778996653;21201.681974770392;21325.68011479829;21507.247246346615;21549.46126346854;1114.437209209344;1158.2355645274079;1167.7229402664668;1170.268582136165;1217.6893795962371;11958.282503049844;12184.695382615506;12206.267623942415;12209.877901221053;12296;495336;496542;505921;512130;557137;71354;76299.61850190714;81399.18600814034;82277.17722822815;83405;1073.7530368015557;1094.6825420628088;1120.0647459371353;1124.3815901254277;1142.2974870454777;19156.521086972938;19212;19587.70618440696;19661.705074424182;19803.10886010162;40728.79635601803;42490.36264455974;42641.573584265;42747;42758.78620606877;54849.725751370985;55013;55239.44760552343;55973.72013139908;56413.71793141008;8819.162179592928;8827.867581986404;8883.73348799537;8945.507997059964;9000.50497222659;7280.817979550554;10418.791624167627;12601.495940162291;12925.224486530838;13282.86717132855;11900.940495297815;12114.697132571757;12225.699061253234;12249.571265005681;12266.509339626315;11479.598214062467;11574.537018519164;11742.471588778355;11798.528058877891;11869.10981676395;11488.655340339803;11516.366599837089;11726.179167458537;11802.173847830913;12330.260184388966;7814.53112813233;8180.590970451334;8361.99656041279;8767.342449316198;9075.727728167902;9016.684416045407;11281.887181128084;11470.655880323604;11953.581624643095;12043.75912481728 04:54:05 INFO - PROCESS | 18966 | |3;mootools.html;1593.0441734959022;1600.2478834947574;1799.1364145210298;1862.8137186281383;1911.7419148414967;8844.204021638052;9299.72100836976;9441.858372124423;10252.077313041826;10257;9360.204382627468;9553.856692149624;9848.310618256724;9850.60597576096;9851.65519206828;2473.0973194783955;2545.618157276405;2549.579319412304;2559.1810620601414;2561.2316305108484;2401.3756423329974;2535.5055764126005;2553.0681301325067;2553.668023156987;2557.0794513974956;2540.27602133392;2548.3119557719406;2599.6490473785984;2602.0762629266624;2602.1152808045263;2466.790322822553;2485.7389974052735;2487.7139129000216;2528.7344828792898;2530.253575195322;2463.2487091437106;2463.4210960424284;2464.7658472445087;2473.418746594549;2491.526609944123;9799.16707079899;9927.702168934944;9934.205263578897;9939.155171810406;9942.5028748563;5821.50517206038;5935.258092738408;5964.7315870785915;5973.1040343948325;5979.983402821531;3491.7904925704283;3609.5848977367677;3650.379435495972;3656.524651795276;3665.8533658653623;1201.6635342104225;1269.4033804112053;1271.161033717742;1281.980770288437;1286.7876800327936;13463.461461541527;13630.250336231504;13739.381727822272;13788;13859.861401385857;4954.5540901319055;5355.196720491879;5391.110466773017;5434.184872269191;5434.212039254286;11926.284422934652;11968.10239232061;12040.036797056215;12055.638330850088;12062.758744825054;6051.667158306247;6079.726412311368;6105.206323177958;6105.633661980207;6117.632942023492;5381.408045115034;5512.310961129859;5544.417836127149;5578.135389014709;5608.186812912187;4350.151720414488;4430.82276708928;4496.64026877849;4523.773811309421;4685.976570117127;1359.4698067753584;1411.6682579593787;1419.09887221615;1428.350100704177;1435.9928200358931;1055.6885718712997;1059.5814653212092;1060.9045185933303;1068.4070340960686;1089.096050278267;6457.580257283262;6569.507286953498;6586.901196482057;6683.131192944886;6886.931130688729;502.78882869195024;509.1420955689601;513.8766695992935;517.9326687530597;518.132128684452;4422.181896349186;4448.1770872388715;4463.652196349127;4491.88770280739;4556.270996640522;12170.208936419105;12703.491860325668;12726.045546584044;12774.744505109846;12798.360081995863;11605.825912611317;12668.619941401772;12673.809892851614;12695.87304126947;12769.553065642658;8777.561121943878;9071.81856362869;9083.81832363349;9121;9133.588988495401;6336.809895703136;6463.418292353711;6496.805095847132;6504.73981040772;6693.694729527695;10954.342739435659;11329.603463878724;11399.829002565135;11411.201215914807;11616.244944078608;10594.364338139429;11311.773764524827;11627.53489860396;11723.706907327385;11748.882511175121;8670.479771213748;8977.506237156758;9030.774230644023;9051.954740226256;9127.863082053642;9573.473458959825;9682.951585242028;9700.85448718284;9761.60953561878;9801.754956126153;8648.221660050374;8668.523231222343;8742.56287185651;8763.868541971748;8860.734177974671;8623.137686231326;8647.827043459221;8664.046954834837;8680.565971701264;8805.471671699719;7734.806629834299;7765.145833958373;7798.610069496616;7805.2194780521495;7856.528608283521;5557.916206339725;5676.091825307931;5740.514440702221;5750.166225897138;5759.51044161251;5612.354579223442;5669.858253543694;5743.282089738783;5798.362180160095;5801.796937107181 04:54:05 INFO - PROCESS | 18966 | |4;prototype.html;355.06971734056776;356.6059504247806;358.0922361812805;360.13208168314367;364.8868850656298;5757.827265182046;5782.045962416201;5797.1883936248905;5799.304083509975;5826.883462330751;5657.547396208303;5694;5714.71426428679;5741.770329186827;5792.884142317151;4430.977845110786;4483.910321793563;4484.618807401359;4507.571780680846;4529.411176547044;4502.594766471017;4512.811286526032;4518.322251662261;4536.183486972343;4565.360849481075;4125.236831186226;4291.270484017725;4521.118381915528;4548.795304211302;4589.5869371756535;4416.425864637608;4423.225935461313;4423.611249925037;4423.969580837121;4455.732656040615;3970.1265721541213;3987.7208595398333;3988.102676897675;4015.759054456742;4029.133736246721;5503.523414463508;5593.188987596816;5632.155176723524;5632.633878797865;5656.1798539211995;5100.974495127501;5142.871428214287;5149.897002059975;5165.405978312505;5173.508516690908;5970.731317090741;5971.193888824996;6004.949133901549;6016.759329626853;6023.789167379165;4349.782061022887;4402.80187391565;4413.6910416270875;4458.108378324316;4465.642748580106;6062.211912451397;6278.49772018242;6293.874122517524;6314.17915670969;6332.430081292659;4414.337849322627;4420.690551661417;4428.623566996777;4460.933086003713;4473.060657261946;4507.5267096955;4510.894830766483;4514.119746649372;4535.365048893158;4539.977300113478;5091.676164197335;5102.413222479388;5150.175971844487;5162.380514338229;5198.532132108128;6055.879662262496;6114.908276375858;6119.112728654321;6139.355367686418;6145.385461453819;1557.3848329909622;1574.2522301906504;1576.3064251729202;1578.9052656840627;1582.8258891521923;978.5596481583174;987.7086259553449;998.6554638649654;1003.172382784206;1003.9698809035741;5201.53186213235;5208.687478751287;5214.400343960418;5222.746540830173;5277.683338999673;5416.593755468356;5440.591955603346;5470.584121719469;5495.835124946258;5597.684544132126;4897.608191344684;5148.995945790535;5201.947980520222;5210.505002024802;5282.4717528246865;2945.8642484198785;2951.4244722279377;2957.2015555799812;2966.821990680566;2980.64232292122;5578.721063946787;5585.1901474286005;5586.636868603528;5676.744546495418;5687.232223649837;5927.569696424445;6394.520410969196;6463.48292136628;6476.643784591798;6488.480921526267;6465.967670161619;6510.446612037935;6537.738490460329;6550.181227346582;6566.343365663395;6079.483243924316;6308.179936608395;6334.90497642545;6364;6366.236051673829;6219.782307619212;6230.878441880505;6241.095041219089;6244.875922333842;6252.5935814171935;6198.101275315144;6341.651209183539;6440.871182576416;6475.352464753487;6516.706748196438;4501.369808226786;4571.177188106173;4571.748553829439;4571.954280457153;4593.2191527439745;6109.69451527413;6251.343608920998;6271.278802937538;6273.592216505913;6288.874222515616;6120.265568131853;6121.887948657706;6126.540509461719;6129.111278864629;6141.7543298267565;5899.764009439746;6085.695715214133;6101.206843110367;6109.083637454418;6114.38856114385;6004.909926351021;6019.518438524995;6024.668643224665;6055.273367195965;6059.424354686298;6109.297430795337;6120.479759220516;6139;6153.323134455296;6153.707721378561;5733.652591640877;5937.524998000236;5971.313298970674;5972.820815375546;5975.774966131846 04:54:05 INFO - PROCESS | 18966 | |5;yui.html;827.4993628854543;831.2975535672358;883.9425437346572;915.6886658536097;940.619049285039;16197;17853.821461785377;17926.641467170648;17968.101594920234;18044.90977545112;15590.06459612424;15705.685886282296;15744.212789360543;15826.28781704823;15847.3661053558;871.2246100970142;908;914.0174312613933;916.9633214671405;918.1874041473311;919.0946917286467;920.07992007992;923.6582464488115;926.4626516620344;926.9675561355353;962.6582563190071;968.3657204531044;974.025974025974;975.1759763000289;977.4672803322206;964.0696727657809;969.6121551379434;970.8203982263304;972.2562239886493;973.4013581647307;711.8042538301956;712.3090602115939;713.0124777183586;713.8750718624271;716.2479396633514;15720.842791572166;16089.356425742957;16183.190840458048;16303.918480407521;17027.318907243694;16518.6696266074;17457.301707931667;17470.912645436692;17543.298268069262;17643.38248161321;13177.096832074001;13478.989075819352;13657.317134143253;13681.110727802661;13805.792913106312;4151.7924103794685;4183.058811767359;4191.580841915815;4267.850625228133;4277.6791740619265;59052.11421828633;74446.71629181178;76011.61994190048;79090.20909790944;86352.56823715904;12475.438605262785;12734.235945843278;12781.61655150347;12799.29603871796;12869.742605147845;22982.195623153108;23055.769442305696;23082.422939426648;23093.653595196087;23700;9125.954370228106;9349.298802589832;9358.15776580111;9386.624535018524;9451.196648284973;5178.249153872667;5329.987302412529;5340.519353258225;5388.326459192601;5536.7231638418725;3992.680585553149;4120.711550191458;4121.793910304473;4123.97938010308;4160.417541544186;730.7040648537351;739.1795107430747;748.0611832150724;762.954222746637;783.3576467296875;690.5865533497896;823.3783493462397;825.7976795684975;845.4377838737171;854.7008547008497;10086.445245511568;10281.202079142757;10389.636362727268;10880.020798128206;11440.942795286137;767.3592550220628;791.3589992106412;799.7560743973144;824.7773101262626;838.0362583029565;5270.841874743764;5302.973485132627;5344.35867695879;5472.425395333512;5549.445055494418;91909;136325;136791;137517;141239.29380353238;111640;113436;113473.43263283631;113508;113871;96409.51795240979;101721.49139254256;105560;106528.99999999844;106533;9879.802403952024;10041.096301332915;10347.741306467398;10367.32612380193;10370.637027703995;60614;60830.08754868769;61462;62122.37877621166;62740;77580.61209693915;89985;90833.54583227042;91208.54395727979;92116.53941730248;13252.734945300846;13319.533816316383;13345.866541334462;13516.729665406834;13541.932290338485;15002.124734408198;15015.849841501446;15025;15295.541133766004;15346.616334591725;14173.503927362493;14321.85425166005;14542.85457145415;14598.416063357347;14883.404663813326;13529.661758455724;13645.931770341085;13654.180749155083;14204.289785510477;14415.207163605683;13276.601701948957;13375.598732038054;13497.257650829299;14031.859681403055;14070;10797.838032429363;11421.771564568497;11423.657290281304;11592.884071159518;12056.698582535506;11877.465514051715;12055.21641093326;12151.210171338835;12195.451204695633;12279.877201227873 04:54:05 INFO - PROCESS | 18966 | __end_tp_report 04:54:05 INFO - PROCESS | 18966 | __start_cc_report 04:54:05 INFO - PROCESS | 18966 | _x_x_mozilla_cycle_collect,347 04:54:05 INFO - PROCESS | 18966 | __end_cc_report 04:54:05 INFO - PROCESS | 18966 | __startTimestamp1472385245064__endTimestamp 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | ------- Summary: start ------- 04:54:05 INFO - PROCESS | 18966 | Number of tests: 6 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | [#0] dojo.html Cycles:165 Average:5844.47 Median:6108.00 stddev:681.02 (11.1%) stddev-sans-first:653.89 04:54:05 INFO - PROCESS | 18966 | Values: 3329.1 3336.4 3345.0 3352.2 3370.1 5849.1 5891.2 5913.5 5923.6 5933.1 5905.7 5971.9 5974.4 5976.7 5984.8 5332.3 5354.4 5408.3 5410.4 5456.2 5262.0 5266.7 5317.3 5341.1 5407.3 5353.1 5360.8 5375.2 5392.9 5475.7 5359.9 5416.1 5419.9 5423.3 5424.1 5124.5 5249.6 5305.7 5364.1 5402.3 5692.0 5721.3 5735.2 5806.9 5858.6 6183.9 6254.8 6258.4 6259.4 6266.8 6096.3 6310.0 6343.7 6344.3 6358.6 5776.7 5785.7 5809.1 5820.5 5895.0 6349.3 6355.6 6388.9 6394.7 6409.6 6049.5 6121.6 6122.9 6160.4 6167.0 6167.4 6202.9 6240.2 6327.3 6340.1 6204.4 6243.1 6270.4 6295.8 6303.8 6130.4 6184.9 6238.8 6258.8 6266.2 4755.6 4764.5 4778.1 4795.9 4825.9 4201.8 4233.8 4250.1 4264.3 4285.6 5843.7 6052.1 6083.1 6107.8 6139.9 6223.5 6230.9 6231.0 6361.3 6362.0 6050.2 6073.5 6079.2 6095.5 6108.0 5116.2 5298.4 5304.6 5309.8 5326.2 6447.7 6457.0 6486.6 6606.3 6616.8 6336.1 6353.5 6390.6 6400.3 6404.7 6273.1 6573.4 6621.3 6629.9 6638.9 6111.9 6122.2 6178.2 6246.6 6246.8 6372.8 6379.2 6383.2 6386.3 6387.7 6006.5 6251.4 6256.3 6274.2 6292.8 6108.0 6124.4 6124.8 6196.0 6199.7 6105.3 6119.1 6147.8 6151.9 6170.5 6020.8 6183.9 6269.2 6272.9 6301.1 6005.9 6026.9 6042.9 6109.3 6141.2 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | [#1] ext.html Cycles:180 Average:69553.37 Median:46213.54 stddev:140854.22 (304.8%) stddev-sans-first:141154.18 04:54:05 INFO - PROCESS | 18966 | Values: 588.6 643.7 667.7 673.2 709.8 41891.0 46978.0 47046.3 47069.5 47229.8 45438.8 45787.8 46092.5 46229.5 46320.0 9224.0 9268.9 9350.1 9384.2 9399.7 9247.0 9329.4 9333.9 9359.1 9374.0 9441.5 9494.8 9495.9 9503.4 9522.6 9390.1 9396.6 9398.2 9425.3 9438.4 9290.1 9333.5 9338.2 9340.6 9371.1 44231.0 44287.0 44398.0 44433.3 44751.0 3842.8 4021.3 4150.1 4195.8 4601.1 34979.5 35036.8 35273.8 35684.1 36595.5 4751.2 4760.5 4779.9 4785.1 4816.7 393149.0 394135.0 397488.0 399653.0 401112.0 65279.3 65394.0 65402.3 65520.7 65535.3 40415.2 40858.2 41245.0 42860.4 42873.0 19773.1 19854.7 19867.2 19877.1 19886.0 15227.9 15376.9 15377.8 15383.0 15383.2 21338.9 21403.9 21430.8 21452.6 21610.1 7545.7 7607.2 7852.5 7865.4 7876.0 1002.4 1049.5 1095.1 1109.0 1167.8 33706.8 33918.3 33990.8 34122.1 34226.8 1189.6 1190.4 1217.6 1244.6 1272.7 17820.7 18055.2 18145.4 18225.5 18454.4 588981.0 590623.0 592305.0 594815.0 595134.0 65267.0 65435.3 65607.0 65627.3 65724.3 1437.1 1464.4 1468.2 1470.8 1487.6 32725.5 33786.5 34126.5 34237.3 34334.8 62772.7 64992.4 65092.7 69907.3 70122.6 575686.0 576998.0 578035.0 579714.0 582996.0 49169.0 49289.3 49595.0 50115.2 50442.0 54255.0 54575.7 54730.5 54742.7 55204.7 46493.8 46691.5 46843.3 48007.3 48079.3 45700.0 46183.8 46759.8 47250.3 47686.3 39587.8 44664.8 44995.8 45619.0 46197.5 39240.6 39414.4 40582.6 41808.0 41989.4 30397.0 30583.7 30822.8 31077.2 31131.0 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | [#2] jquery.html Cycles:180 Average:29947.71 Median:25015.56 stddev:84245.80 (336.8%) stddev-sans-first:84452.97 04:54:05 INFO - PROCESS | 18966 | Values: 422.9 424.1 434.8 437.5 441.6 19137.2 21052.9 21322.8 21589.5 22295.3 20164.4 20962.8 21145.5 21172.8 21202.5 5966.7 6117.9 6198.9 6216.2 6230.9 6077.1 6100.3 6131.4 6155.4 6156.1 6026.1 6047.9 6053.6 6097.0 6108.9 6014.9 6042.8 6053.6 6088.2 6129.2 5432.2 5489.0 5512.4 5512.8 5517.8 24773.1 24788.5 24992.1 25039.0 25749.7 2607.0 2740.0 2832.9 3168.4 3200.9 15798.5 16051.8 16161.4 16389.4 16786.7 1966.4 1976.9 2035.1 2095.9 2132.1 80363.2 81501.6 81883.0 83030.0 83295.0 10035.5 10095.1 11163.7 11932.2 11969.3 16514.9 16577.3 16593.2 16638.7 16704.6 9186.8 9194.1 9209.8 9309.0 9495.1 9202.7 9206.2 9265.3 9399.2 9489.3 7077.3 7094.8 7236.8 7269.6 7328.5 2084.6 2101.6 2106.5 2164.6 2191.3 1037.7 1082.6 1144.9 1168.0 1228.2 21107.4 21201.7 21325.7 21507.2 21549.5 1114.4 1158.2 1167.7 1170.3 1217.7 11958.3 12184.7 12206.3 12209.9 12296.0 495336.0 496542.0 505921.0 512130.0 557137.0 71354.0 76299.6 81399.2 82277.2 83405.0 1073.8 1094.7 1120.1 1124.4 1142.3 19156.5 19212.0 19587.7 19661.7 19803.1 40728.8 42490.4 42641.6 42747.0 42758.8 54849.7 55013.0 55239.4 55973.7 56413.7 8819.2 8827.9 8883.7 8945.5 9000.5 7280.8 10418.8 12601.5 12925.2 13282.9 11900.9 12114.7 12225.7 12249.6 12266.5 11479.6 11574.5 11742.5 11798.5 11869.1 11488.7 11516.4 11726.2 11802.2 12330.3 7814.5 8180.6 8362.0 8767.3 9075.7 9016.7 11281.9 11470.7 11953.6 12043.8 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | [#3] mootools.html Cycles:180 Average:6509.44 Median:4621.12 stddev:3777.37 (81.7%) stddev-sans-first:3769.90 04:54:05 INFO - PROCESS | 18966 | Values: 1593.0 1600.2 1799.1 1862.8 1911.7 8844.2 9299.7 9441.9 10252.1 10257.0 9360.2 9553.9 9848.3 9850.6 9851.7 2473.1 2545.6 2549.6 2559.2 2561.2 2401.4 2535.5 2553.1 2553.7 2557.1 2540.3 2548.3 2599.6 2602.1 2602.1 2466.8 2485.7 2487.7 2528.7 2530.3 2463.2 2463.4 2464.8 2473.4 2491.5 9799.2 9927.7 9934.2 9939.2 9942.5 5821.5 5935.3 5964.7 5973.1 5980.0 3491.8 3609.6 3650.4 3656.5 3665.9 1201.7 1269.4 1271.2 1282.0 1286.8 13463.5 13630.3 13739.4 13788.0 13859.9 4954.6 5355.2 5391.1 5434.2 5434.2 11926.3 11968.1 12040.0 12055.6 12062.8 6051.7 6079.7 6105.2 6105.6 6117.6 5381.4 5512.3 5544.4 5578.1 5608.2 4350.2 4430.8 4496.6 4523.8 4686.0 1359.5 1411.7 1419.1 1428.4 1436.0 1055.7 1059.6 1060.9 1068.4 1089.1 6457.6 6569.5 6586.9 6683.1 6886.9 502.8 509.1 513.9 517.9 518.1 4422.2 4448.2 4463.7 4491.9 4556.3 12170.2 12703.5 12726.0 12774.7 12798.4 11605.8 12668.6 12673.8 12695.9 12769.6 8777.6 9071.8 9083.8 9121.0 9133.6 6336.8 6463.4 6496.8 6504.7 6693.7 10954.3 11329.6 11399.8 11411.2 11616.2 10594.4 11311.8 11627.5 11723.7 11748.9 8670.5 8977.5 9030.8 9052.0 9127.9 9573.5 9683.0 9700.9 9761.6 9801.8 8648.2 8668.5 8742.6 8763.9 8860.7 8623.1 8647.8 8664.0 8680.6 8805.5 7734.8 7765.1 7798.6 7805.2 7856.5 5557.9 5676.1 5740.5 5750.2 5759.5 5612.4 5669.9 5743.3 5798.4 5801.8 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | [#4] prototype.html Cycles:180 Average:5034.79 Median:5595.44 stddev:1488.65 (26.6%) stddev-sans-first:1450.80 04:54:05 INFO - PROCESS | 18966 | Values: 355.1 356.6 358.1 360.1 364.9 5757.8 5782.0 5797.2 5799.3 5826.9 5657.5 5694.0 5714.7 5741.8 5792.9 4431.0 4483.9 4484.6 4507.6 4529.4 4502.6 4512.8 4518.3 4536.2 4565.4 4125.2 4291.3 4521.1 4548.8 4589.6 4416.4 4423.2 4423.6 4424.0 4455.7 3970.1 3987.7 3988.1 4015.8 4029.1 5503.5 5593.2 5632.2 5632.6 5656.2 5101.0 5142.9 5149.9 5165.4 5173.5 5970.7 5971.2 6004.9 6016.8 6023.8 4349.8 4402.8 4413.7 4458.1 4465.6 6062.2 6278.5 6293.9 6314.2 6332.4 4414.3 4420.7 4428.6 4460.9 4473.1 4507.5 4510.9 4514.1 4535.4 4540.0 5091.7 5102.4 5150.2 5162.4 5198.5 6055.9 6114.9 6119.1 6139.4 6145.4 1557.4 1574.3 1576.3 1578.9 1582.8 978.6 987.7 998.7 1003.2 1004.0 5201.5 5208.7 5214.4 5222.7 5277.7 5416.6 5440.6 5470.6 5495.8 5597.7 4897.6 5149.0 5201.9 5210.5 5282.5 2945.9 2951.4 2957.2 2966.8 2980.6 5578.7 5585.2 5586.6 5676.7 5687.2 5927.6 6394.5 6463.5 6476.6 6488.5 6466.0 6510.4 6537.7 6550.2 6566.3 6079.5 6308.2 6334.9 6364.0 6366.2 6219.8 6230.9 6241.1 6244.9 6252.6 6198.1 6341.7 6440.9 6475.4 6516.7 4501.4 4571.2 4571.7 4572.0 4593.2 6109.7 6251.3 6271.3 6273.6 6288.9 6120.3 6121.9 6126.5 6129.1 6141.8 5899.8 6085.7 6101.2 6109.1 6114.4 6004.9 6019.5 6024.7 6055.3 6059.4 6109.3 6120.5 6139.0 6153.3 6153.7 5733.7 5937.5 5971.3 5972.8 5975.8 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - PROCESS | 18966 | [#5] yui.html Cycles:180 Average:23268.81 Median:23396.83 stddev:34231.88 (146.3%) stddev-sans-first:34286.44 04:54:05 INFO - PROCESS | 18966 | Values: 827.5 831.3 883.9 915.7 940.6 16197.0 17853.8 17926.6 17968.1 18044.9 15590.1 15705.7 15744.2 15826.3 15847.4 871.2 908.0 914.0 917.0 918.2 919.1 920.1 923.7 926.5 927.0 962.7 968.4 974.0 975.2 977.5 964.1 969.6 970.8 972.3 973.4 711.8 712.3 713.0 713.9 716.2 15720.8 16089.4 16183.2 16303.9 17027.3 16518.7 17457.3 17470.9 17543.3 17643.4 13177.1 13479.0 13657.3 13681.1 13805.8 4151.8 4183.1 4191.6 4267.9 4277.7 59052.1 74446.7 76011.6 79090.2 86352.6 12475.4 12734.2 12781.6 12799.3 12869.7 22982.2 23055.8 23082.4 23093.7 23700.0 9126.0 9349.3 9358.2 9386.6 9451.2 5178.2 5330.0 5340.5 5388.3 5536.7 3992.7 4120.7 4121.8 4124.0 4160.4 730.7 739.2 748.1 763.0 783.4 690.6 823.4 825.8 845.4 854.7 10086.4 10281.2 10389.6 10880.0 11440.9 767.4 791.4 799.8 824.8 838.0 5270.8 5303.0 5344.4 5472.4 5549.4 91909.0 136325.0 136791.0 137517.0 141239.3 111640.0 113436.0 113473.4 113508.0 113871.0 96409.5 101721.5 105560.0 106529.0 106533.0 9879.8 10041.1 10347.7 10367.3 10370.6 60614.0 60830.1 61462.0 62122.4 62740.0 77580.6 89985.0 90833.5 91208.5 92116.5 13252.7 13319.5 13345.9 13516.7 13541.9 15002.1 15015.8 15025.0 15295.5 15346.6 14173.5 14321.9 14542.9 14598.4 14883.4 13529.7 13645.9 13654.2 14204.3 14415.2 13276.6 13375.6 13497.3 14031.9 14070.0 10797.8 11421.8 11423.7 11592.9 12056.7 11877.5 12055.2 12151.2 12195.5 12279.9 04:54:05 INFO - PROCESS | 18966 | -------- Summary: end -------- 04:54:05 INFO - PROCESS | 18966 | 04:54:05 INFO - TEST-INFO | 18966: exit 0 04:54:05 INFO - TEST-OK | dromaeo_css | took 1110852ms 04:54:05 INFO - TEST-START | kraken 04:54:05 INFO - operating with platform_type : linux_ 04:54:05 INFO - Initialising browser for kraken test... 04:54:05 INFO - TEST-INFO | started process 19233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJrLNI/profile http://localhost:37897/getInfo.html) 04:54:10 INFO - PROCESS | 19233 | __metrics Screen width/height:1600/1200 04:54:10 INFO - PROCESS | 19233 | colorDepth:24 04:54:10 INFO - PROCESS | 19233 | Browser inner width/height: 1024/697 04:54:10 INFO - PROCESS | 19233 | __metrics 04:54:10 ERROR - PROCESS | 19233 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:54:11 INFO - TEST-INFO | 19233: exit 0 04:54:11 INFO - Browser initialized. 04:54:11 INFO - Running cycle 1/1 for kraken test... 04:54:11 INFO - TEST-INFO | started process 19359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJrLNI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:23 INFO - PROCESS | 19359 | RSS: Main: 152027136 04:54:23 INFO - PROCESS | 19359 | 04:54:25 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37897/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:26 INFO - PROCESS | 19359 | RSS: Main: 157642752 04:54:26 INFO - PROCESS | 19359 | 04:54:29 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37897/tests/kraken/driver.html?testName=audio-dft) 04:54:29 INFO - PROCESS | 19359 | RSS: Main: 156119040 04:54:29 INFO - PROCESS | 19359 | 04:54:32 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37897/tests/kraken/driver.html?testName=audio-fft) 04:54:33 INFO - PROCESS | 19359 | RSS: Main: 156790784 04:54:33 INFO - PROCESS | 19359 | 04:54:35 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37897/tests/kraken/driver.html?testName=audio-oscillator) 04:54:36 INFO - PROCESS | 19359 | RSS: Main: 156504064 04:54:36 INFO - PROCESS | 19359 | 04:54:38 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37897/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:38 INFO - PROCESS | 19359 | RSS: Main: 157024256 04:54:38 INFO - PROCESS | 19359 | 04:54:41 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37897/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:42 INFO - PROCESS | 19359 | RSS: Main: 156217344 04:54:42 INFO - PROCESS | 19359 | 04:54:46 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37897/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:46 INFO - PROCESS | 19359 | RSS: Main: 156872704 04:54:46 INFO - PROCESS | 19359 | 04:54:49 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37897/tests/kraken/driver.html?testName=json-parse-financial) 04:54:50 INFO - PROCESS | 19359 | RSS: Main: 157683712 04:54:50 INFO - PROCESS | 19359 | 04:54:51 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37897/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:52 INFO - PROCESS | 19359 | RSS: Main: 157192192 04:54:52 INFO - PROCESS | 19359 | 04:54:54 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:54 INFO - PROCESS | 19359 | RSS: Main: 157175808 04:54:54 INFO - PROCESS | 19359 | 04:54:56 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:57 INFO - PROCESS | 19359 | RSS: Main: 157159424 04:54:57 INFO - PROCESS | 19359 | 04:54:59 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:00 INFO - PROCESS | 19359 | RSS: Main: 157876224 04:55:00 INFO - PROCESS | 19359 | 04:55:03 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:03 INFO - PROCESS | 19359 | RSS: Main: 158117888 04:55:03 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | Cycle 1(1): loaded http://localhost:37897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37897/tests/kraken/driver.html?testName=ai-astar) 04:55:05 INFO - PROCESS | 19359 | RSS: Main: 159281152 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | __start_tp_report 04:55:05 INFO - PROCESS | 19359 | _x_x_mozilla_page_load 04:55:05 INFO - PROCESS | 19359 | _x_x_mozilla_page_load_details 04:55:05 INFO - PROCESS | 19359 | |i|pagename|runs| 04:55:05 INFO - PROCESS | 19359 | |0;ai-astar;102;110;105;111;111;112;111;110;110;110 04:55:05 INFO - PROCESS | 19359 | |1;audio-beat-detection;141;120;141;169;118;146;150;124;169;120 04:55:05 INFO - PROCESS | 19359 | |2;audio-dft;165;163;163;163;164;161;162;162;167;162 04:55:05 INFO - PROCESS | 19359 | |3;audio-fft;75;76;77;172;76;76;74;75;172;75 04:55:05 INFO - PROCESS | 19359 | |4;audio-oscillator;84;84;144;84;83;85;146;83;82;141 04:55:05 INFO - PROCESS | 19359 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;118;117 04:55:05 INFO - PROCESS | 19359 | |6;imaging-darkroom;147;146;146;147;146;146;146;148;147;146 04:55:05 INFO - PROCESS | 19359 | |7;imaging-desaturate;97;95;97;95;95;95;95;95;95;95 04:55:05 INFO - PROCESS | 19359 | |8;json-parse-financial;51;51;52;50;50;49;50;50;50;50 04:55:05 INFO - PROCESS | 19359 | |9;json-stringify-tinderbox;63;59;60;59;60;59;59;59;60;60 04:55:05 INFO - PROCESS | 19359 | |10;stanford-crypto-aes;82;75;72;78;72;71;73;73;82;77 04:55:05 INFO - PROCESS | 19359 | |11;stanford-crypto-ccm;133;118;117;116;117;123;134;116;161;138 04:55:05 INFO - PROCESS | 19359 | |12;stanford-crypto-pbkdf2;154;150;155;155;156;154;152;153;155;152 04:55:05 INFO - PROCESS | 19359 | |13;stanford-crypto-sha256-iterative;62;63;63;62;62;62;61;62;61;61 04:55:05 INFO - PROCESS | 19359 | __end_tp_report 04:55:05 INFO - PROCESS | 19359 | __start_cc_report 04:55:05 INFO - PROCESS | 19359 | _x_x_mozilla_cycle_collect,889 04:55:05 INFO - PROCESS | 19359 | __end_cc_report 04:55:05 INFO - PROCESS | 19359 | __startTimestamp1472385305704__endTimestamp 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | ------- Summary: start ------- 04:55:05 INFO - PROCESS | 19359 | Number of tests: 14 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.16 (2.9%) stddev-sans-first:2.00 04:55:05 INFO - PROCESS | 19359 | Values: 102.0 110.0 105.0 111.0 111.0 112.0 111.0 110.0 110.0 110.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:143.50 stddev:19.32 (13.5%) stddev-sans-first:20.49 04:55:05 INFO - PROCESS | 19359 | Values: 141.0 120.0 141.0 169.0 118.0 146.0 150.0 124.0 169.0 120.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.75 (1.1%) stddev-sans-first:1.73 04:55:05 INFO - PROCESS | 19359 | Values: 165.0 163.0 163.0 163.0 164.0 161.0 162.0 162.0 167.0 162.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.50 stddev:40.70 (53.9%) stddev-sans-first:42.53 04:55:05 INFO - PROCESS | 19359 | Values: 75.0 76.0 77.0 172.0 76.0 76.0 74.0 75.0 172.0 75.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:83.50 stddev:29.06 (34.8%) stddev-sans-first:30.12 04:55:05 INFO - PROCESS | 19359 | Values: 84.0 84.0 144.0 84.0 83.0 85.0 146.0 83.0 82.0 141.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:55:05 INFO - PROCESS | 19359 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:55:05 INFO - PROCESS | 19359 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 147.0 146.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.84 (0.9%) stddev-sans-first:0.67 04:55:05 INFO - PROCESS | 19359 | Values: 97.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 04:55:05 INFO - PROCESS | 19359 | Values: 51.0 51.0 52.0 50.0 50.0 49.0 50.0 50.0 50.0 50.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:1.23 (2.0%) stddev-sans-first:0.53 04:55:05 INFO - PROCESS | 19359 | Values: 63.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 60.0 60.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:4.09 (5.4%) stddev-sans-first:3.60 04:55:05 INFO - PROCESS | 19359 | Values: 82.0 75.0 72.0 78.0 72.0 71.0 73.0 73.0 82.0 77.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.00 stddev:14.53 (11.4%) stddev-sans-first:15.26 04:55:05 INFO - PROCESS | 19359 | Values: 133.0 118.0 117.0 116.0 117.0 123.0 134.0 116.0 161.0 138.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.50 stddev:1.84 (1.2%) stddev-sans-first:1.94 04:55:05 INFO - PROCESS | 19359 | Values: 154.0 150.0 155.0 155.0 156.0 154.0 152.0 153.0 155.0 152.0 04:55:05 INFO - PROCESS | 19359 | 04:55:05 INFO - PROCESS | 19359 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 04:55:05 INFO - PROCESS | 19359 | Values: 62.0 63.0 63.0 62.0 62.0 62.0 61.0 62.0 61.0 61.0 04:55:05 INFO - PROCESS | 19359 | -------- Summary: end -------- 04:55:05 INFO - PROCESS | 19359 | 04:55:06 INFO - TEST-INFO | 19359: exit 0 04:55:06 INFO - TEST-OK | kraken | took 60954ms 04:55:06 INFO - SUITE-END | took 1171s 04:55:06 INFO - Completed test suite (00:19:31) 04:55:06 INFO - javascript benchmark 04:55:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7938.06632542456, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.051220402185, 3336.416127177744, 3345.046661701414, 3352.1619595101224, 3370.073229861789, 5849.064149736043, 5891.204687367204, 5913.526917846572, 5923.555733319997, 5933.1396947442645, 5905.734241959111, 5971.880562388749, 5974.402559744023, 5976.6712830794395, 5984.790532331369, 5332.33345831772, 5354.437784032679, 5408.2698835657075, 5410.377806552257, 5456.154296084113, 5261.973690131544, 5266.736663166846, 5317.255584218213, 5341.145416733323, 5407.324084489419, 5353.08997470429, 5360.785568577252, 5375.166849138371, 5392.946070539284, 5475.698836563987, 5359.919601205966, 5416.1063424534905, 5419.945800542003, 5423.2949716537, 5424.1321388578035, 5124.5131712487255, 5249.606279529051, 5305.73471326436, 5364.061289274361, 5402.297701298806, 5692.0, 5721.256236689245, 5735.2257445245195, 5806.854828629276, 5858.56060795442, 6183.876322473526, 6254.781082662131, 6258.405451482102, 6259.405356491126, 6266.780662676784, 6096.329403765582, 6310.0, 6343.746250149989, 6344.302126766052, 6358.618482890995, 5776.682282474462, 5785.71071446426, 5809.070548712186, 5820.505257053155, 5894.970525147347, 6349.301576826545, 6355.555111142268, 6388.872222555523, 6394.680265986682, 6409.615423074631, 6049.516038716892, 6121.571489995747, 6122.938770612326, 6160.414760597826, 6167.044108163242, 6167.444929956326, 6202.906956395657, 6240.157578726814, 6327.335629758901, 6340.080688300171, 6204.441600255998, 6243.125962365272, 6270.372962703693, 6295.811125666238, 6303.842403939847, 6130.448259656563, 6184.8763024739255, 6238.750449982041, 6258.780942666985, 6266.216722909637, 4755.619550435957, 4764.475907650156, 4778.068276686013, 4795.856124316276, 4825.855224343275, 4201.768902710381, 4233.809478573472, 4250.128723611652, 4264.317709166518, 4285.635720963753, 5843.737031833492, 6052.12244224585, 6083.13417122791, 6107.816765497042, 6139.907901381483, 6223.471004964538, 6230.937690623126, 6230.968845155836, 6361.332060133712, 6362.0, 6050.2437195350585, 6073.51411887048, 6079.240094988127, 6095.512359011268, 6107.969460152671, 5116.181410974226, 5298.390685071189, 5304.602154838402, 5309.840704778863, 5326.227696983916, 6447.709853056624, 6457.0, 6486.643234622141, 6606.339366063451, 6616.8345791355605, 6336.112944187726, 6353.491720662243, 6390.648514331757, 6400.327965563642, 6404.743810247538, 6273.121762953099, 6573.408393244631, 6621.3047629998155, 6629.867402651824, 6638.900416493853, 6111.86523267538, 6122.245686735438, 6178.165947597017, 6246.562740608114, 6246.843828904313, 6372.808815735535, 6379.234491861006, 6383.170187875547, 6386.329435409215, 6387.744490220339, 6006.489448396936, 6251.437370636482, 6256.280527739368, 6274.247090349188, 6292.842678933063, 6108.0, 6124.3809352984035, 6124.846878828065, 6196.0, 6199.659018754011, 6105.262111899988, 6119.082137679384, 6147.754089836535, 6151.9384806151365, 6170.50635949132, 6020.789272375446, 6183.886900357978, 6269.216347956505, 6272.937270627235, 6301.054841773587, 6005.87988240224, 6026.939730602638, 6042.879142417215, 6109.34393638171, 6141.240538582456], "value": 5797.007222565486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.576225117915, 643.6749441532027, 667.7462564225593, 673.1988933169528, 709.7898083767177, 41891.0, 46978.0, 47046.29430558544, 47069.529304706986, 47229.76385118078, 45438.772806136, 45787.771061144646, 46092.539074609245, 46229.53770462294, 46320.0, 9223.953880230589, 9268.860967085498, 9350.111739384747, 9384.24926005918, 9399.671011514598, 9246.953765231165, 9329.440233586007, 9333.859992100124, 9359.064093590654, 9374.0, 9441.480718560477, 9494.810103797954, 9495.857562136538, 9503.429794212334, 9522.57148428319, 9390.060993900624, 9396.577154028051, 9398.201152902011, 9425.34022618417, 9438.433693978315, 9290.070992900723, 9333.533323333873, 9338.206252468548, 9340.579673914623, 9371.109744574254, 44231.0, 44287.0, 44398.0, 44433.33349999753, 44751.0, 3842.769433833979, 4021.2761702893467, 4150.107726838744, 4195.769232692201, 4601.102784956935, 34979.4753078704, 35036.824815875756, 35273.82363088194, 35684.107897302776, 36595.451068234, 4751.1922973094315, 4760.523947605247, 4779.928301075487, 4785.138675038492, 4816.7350795706225, 393149.0, 394135.0, 397488.01255993824, 399653.0, 401112.0, 65279.34720652732, 65394.0, 65402.345976539626, 65520.67239663866, 65535.34464655293, 40415.191696165915, 40858.1828363437, 41245.0, 42860.35709464361, 42873.0, 19773.110210040584, 19854.70217946732, 19867.205311787366, 19877.105530251174, 19886.0, 15227.923860380848, 15376.923115384576, 15377.769333460006, 15383.0, 15383.230838458032, 21338.893305533373, 21403.892980534998, 21430.78569214288, 21452.570948580942, 21610.135594576357, 7545.7358992435, 7607.16321204667, 7852.450328476952, 7865.449418540762, 7876.0, 1002.4085789384299, 1049.5067318360511, 1095.1293721491434, 1109.046220250584, 1167.7664467106442, 33706.831465843, 33918.321633567684, 33990.830045849616, 34122.14694632654, 34226.82886585551, 1189.6312143235625, 1190.4107466803814, 1217.5555922088552, 1244.6390546741343, 1272.6754677557165, 17820.732689009674, 18055.187516561786, 18145.364912228273, 18225.544361391072, 18454.35409760652, 588981.0, 590623.0, 592305.0, 594815.0, 595134.0, 65267.0, 65435.345646542926, 65607.0, 65627.34372656212, 65724.34275657278, 1437.116173553257, 1464.414234306286, 1468.2218424235386, 1470.7720303352996, 1487.5834766265464, 32725.509117363734, 33786.49320260149, 34126.48810267897, 34237.315253695284, 34334.82832585821, 62772.686136570854, 64992.35007650052, 65092.67453662701, 69907.30092699008, 70122.64938675275, 575686.0, 576998.0, 578035.0, 579714.0, 582996.0, 49169.0, 49289.26066108939, 49595.0, 50115.24827127669, 50442.0, 54255.0, 54575.72712136573, 54730.45269547254, 54742.72628636831, 55204.723976379864, 46493.76753116213, 46691.533084670074, 46843.29735054045, 48007.27989080236, 48079.278810817166, 45700.0, 46183.76908115438, 46759.76620117014, 47250.29124563066, 47686.28470573013, 39587.80206099066, 44664.77667611641, 44995.77502112468, 45619.0, 46197.53802462067, 39240.60759392484, 39414.40878386769, 40582.59417405788, 41808.0, 41989.37015944702, 30397.0, 30583.694163058975, 30822.845885771323, 31077.205973709355, 31131.0], "value": 22308.10079210146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.8799281683411, 424.14958009191565, 434.8456298014205, 437.4619218361415, 441.6025576980717, 19137.234510619575, 21052.89473552632, 21322.786772132273, 21589.46026349342, 22295.331140065784, 20164.39506814798, 20962.790372096275, 21145.47136321589, 21172.788272117275, 21202.46993825155, 5966.701664916748, 6117.877642447148, 6198.907016394735, 6216.1918950536365, 6230.875382492348, 6077.1491991121275, 6100.298465676437, 6131.448169664729, 6155.353687862777, 6156.076588511737, 6026.0659597762415, 6047.939520604804, 6053.606515576495, 6096.96951515244, 6108.877822443548, 6014.909776353336, 6042.848928776772, 6053.606515576495, 6088.178095957033, 6129.1725617041575, 5432.239486471897, 5488.9725551371985, 5512.366077901052, 5512.779488820443, 5517.834464966058, 24773.132940347, 24788.5042299153, 24992.125275615446, 25039.0, 25749.74250257511, 2606.973930260711, 2739.9726002739917, 2832.929176770597, 3168.429682657121, 3200.943688582762, 15798.526044218577, 16051.839481605151, 16161.4343497977, 16389.42637007699, 16786.74819877703, 1966.429735376739, 1976.901154942247, 2035.0943829995658, 2095.863768855035, 2132.0618927671776, 80363.19636803615, 81501.59249203716, 81883.0, 83029.99999999939, 83295.0, 10035.548400322003, 10095.141912937483, 11163.665090047312, 11932.164748467523, 11969.281843089442, 16514.917425412797, 16577.254023568967, 16593.170341482877, 16638.667226655398, 16704.582385440463, 9186.816263674822, 9194.12655797698, 9209.76975575616, 9308.95345523268, 9495.14543691071, 9202.723918282461, 9206.217471514863, 9265.25877929764, 9399.154076133182, 9489.288303377274, 7077.256888026786, 7094.822629434306, 7236.819079523054, 7269.563826170447, 7328.487005909642, 2084.6143463459307, 2101.590189912983, 2106.5155014346788, 2164.577907308091, 2191.2878314547515, 1037.6523864505325, 1082.5615625671617, 1144.8837383551138, 1167.9605151415246, 1228.2446295528187, 21107.366778996653, 21201.681974770392, 21325.68011479829, 21507.247246346615, 21549.46126346854, 1114.437209209344, 1158.2355645274079, 1167.7229402664668, 1170.268582136165, 1217.6893795962371, 11958.282503049844, 12184.695382615506, 12206.267623942415, 12209.877901221053, 12296.0, 495336.0, 496542.0, 505921.0, 512130.0, 557137.0, 71354.0, 76299.61850190714, 81399.18600814034, 82277.17722822815, 83405.0, 1073.7530368015557, 1094.6825420628088, 1120.0647459371353, 1124.3815901254277, 1142.2974870454777, 19156.521086972938, 19212.0, 19587.70618440696, 19661.705074424182, 19803.10886010162, 40728.79635601803, 42490.36264455974, 42641.573584265, 42747.0, 42758.78620606877, 54849.725751370985, 55013.0, 55239.44760552343, 55973.72013139908, 56413.71793141008, 8819.162179592928, 8827.867581986404, 8883.73348799537, 8945.507997059964, 9000.50497222659, 7280.817979550554, 10418.791624167627, 12601.495940162291, 12925.224486530838, 13282.86717132855, 11900.940495297815, 12114.697132571757, 12225.699061253234, 12249.571265005681, 12266.509339626315, 11479.598214062467, 11574.537018519164, 11742.471588778355, 11798.528058877891, 11869.10981676395, 11488.655340339803, 11516.366599837089, 11726.179167458537, 11802.173847830913, 12330.260184388966, 7814.53112813233, 8180.590970451334, 8361.99656041279, 8767.342449316198, 9075.727728167902, 9016.684416045407, 11281.887181128084, 11470.655880323604, 11953.581624643095, 12043.75912481728], "value": 9932.835804666875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1593.0441734959022, 1600.2478834947574, 1799.1364145210298, 1862.8137186281383, 1911.7419148414967, 8844.204021638052, 9299.72100836976, 9441.858372124423, 10252.077313041826, 10257.0, 9360.204382627468, 9553.856692149624, 9848.310618256724, 9850.60597576096, 9851.65519206828, 2473.0973194783955, 2545.618157276405, 2549.579319412304, 2559.1810620601414, 2561.2316305108484, 2401.3756423329974, 2535.5055764126005, 2553.0681301325067, 2553.668023156987, 2557.0794513974956, 2540.27602133392, 2548.3119557719406, 2599.6490473785984, 2602.0762629266624, 2602.1152808045263, 2466.790322822553, 2485.7389974052735, 2487.7139129000216, 2528.7344828792898, 2530.253575195322, 2463.2487091437106, 2463.4210960424284, 2464.7658472445087, 2473.418746594549, 2491.526609944123, 9799.16707079899, 9927.702168934944, 9934.205263578897, 9939.155171810406, 9942.5028748563, 5821.50517206038, 5935.258092738408, 5964.7315870785915, 5973.1040343948325, 5979.983402821531, 3491.7904925704283, 3609.5848977367677, 3650.379435495972, 3656.524651795276, 3665.8533658653623, 1201.6635342104225, 1269.4033804112053, 1271.161033717742, 1281.980770288437, 1286.7876800327936, 13463.461461541527, 13630.250336231504, 13739.381727822272, 13788.0, 13859.861401385857, 4954.5540901319055, 5355.196720491879, 5391.110466773017, 5434.184872269191, 5434.212039254286, 11926.284422934652, 11968.10239232061, 12040.036797056215, 12055.638330850088, 12062.758744825054, 6051.667158306247, 6079.726412311368, 6105.206323177958, 6105.633661980207, 6117.632942023492, 5381.408045115034, 5512.310961129859, 5544.417836127149, 5578.135389014709, 5608.186812912187, 4350.151720414488, 4430.82276708928, 4496.64026877849, 4523.773811309421, 4685.976570117127, 1359.4698067753584, 1411.6682579593787, 1419.09887221615, 1428.350100704177, 1435.9928200358931, 1055.6885718712997, 1059.5814653212092, 1060.9045185933303, 1068.4070340960686, 1089.096050278267, 6457.580257283262, 6569.507286953498, 6586.901196482057, 6683.131192944886, 6886.931130688729, 502.78882869195024, 509.1420955689601, 513.8766695992935, 517.9326687530597, 518.132128684452, 4422.181896349186, 4448.1770872388715, 4463.652196349127, 4491.88770280739, 4556.270996640522, 12170.208936419105, 12703.491860325668, 12726.045546584044, 12774.744505109846, 12798.360081995863, 11605.825912611317, 12668.619941401772, 12673.809892851614, 12695.87304126947, 12769.553065642658, 8777.561121943878, 9071.81856362869, 9083.81832363349, 9121.0, 9133.588988495401, 6336.809895703136, 6463.418292353711, 6496.805095847132, 6504.73981040772, 6693.694729527695, 10954.342739435659, 11329.603463878724, 11399.829002565135, 11411.201215914807, 11616.244944078608, 10594.364338139429, 11311.773764524827, 11627.53489860396, 11723.706907327385, 11748.882511175121, 8670.479771213748, 8977.506237156758, 9030.774230644023, 9051.954740226256, 9127.863082053642, 9573.473458959825, 9682.951585242028, 9700.85448718284, 9761.60953561878, 9801.754956126153, 8648.221660050374, 8668.523231222343, 8742.56287185651, 8763.868541971748, 8860.734177974671, 8623.137686231326, 8647.827043459221, 8664.046954834837, 8680.565971701264, 8805.471671699719, 7734.806629834299, 7765.145833958373, 7798.610069496616, 7805.2194780521495, 7856.528608283521, 5557.916206339725, 5676.091825307931, 5740.514440702221, 5750.166225897138, 5759.51044161251, 5612.354579223442, 5669.858253543694, 5743.282089738783, 5798.362180160095, 5801.796937107181], "value": 5088.338174114204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.06971734056776, 356.6059504247806, 358.0922361812805, 360.13208168314367, 364.8868850656298, 5757.827265182046, 5782.045962416201, 5797.1883936248905, 5799.304083509975, 5826.883462330751, 5657.547396208303, 5694.0, 5714.71426428679, 5741.770329186827, 5792.884142317151, 4430.977845110786, 4483.910321793563, 4484.618807401359, 4507.571780680846, 4529.411176547044, 4502.594766471017, 4512.811286526032, 4518.322251662261, 4536.183486972343, 4565.360849481075, 4125.236831186226, 4291.270484017725, 4521.118381915528, 4548.795304211302, 4589.5869371756535, 4416.425864637608, 4423.225935461313, 4423.611249925037, 4423.969580837121, 4455.732656040615, 3970.1265721541213, 3987.7208595398333, 3988.102676897675, 4015.759054456742, 4029.133736246721, 5503.523414463508, 5593.188987596816, 5632.155176723524, 5632.633878797865, 5656.1798539211995, 5100.974495127501, 5142.871428214287, 5149.897002059975, 5165.405978312505, 5173.508516690908, 5970.731317090741, 5971.193888824996, 6004.949133901549, 6016.759329626853, 6023.789167379165, 4349.782061022887, 4402.80187391565, 4413.6910416270875, 4458.108378324316, 4465.642748580106, 6062.211912451397, 6278.49772018242, 6293.874122517524, 6314.17915670969, 6332.430081292659, 4414.337849322627, 4420.690551661417, 4428.623566996777, 4460.933086003713, 4473.060657261946, 4507.5267096955, 4510.894830766483, 4514.119746649372, 4535.365048893158, 4539.977300113478, 5091.676164197335, 5102.413222479388, 5150.175971844487, 5162.380514338229, 5198.532132108128, 6055.879662262496, 6114.908276375858, 6119.112728654321, 6139.355367686418, 6145.385461453819, 1557.3848329909622, 1574.2522301906504, 1576.3064251729202, 1578.9052656840627, 1582.8258891521923, 978.5596481583174, 987.7086259553449, 998.6554638649654, 1003.172382784206, 1003.9698809035741, 5201.53186213235, 5208.687478751287, 5214.400343960418, 5222.746540830173, 5277.683338999673, 5416.593755468356, 5440.591955603346, 5470.584121719469, 5495.835124946258, 5597.684544132126, 4897.608191344684, 5148.995945790535, 5201.947980520222, 5210.505002024802, 5282.4717528246865, 2945.8642484198785, 2951.4244722279377, 2957.2015555799812, 2966.821990680566, 2980.64232292122, 5578.721063946787, 5585.1901474286005, 5586.636868603528, 5676.744546495418, 5687.232223649837, 5927.569696424445, 6394.520410969196, 6463.48292136628, 6476.643784591798, 6488.480921526267, 6465.967670161619, 6510.446612037935, 6537.738490460329, 6550.181227346582, 6566.343365663395, 6079.483243924316, 6308.179936608395, 6334.90497642545, 6364.0, 6366.236051673829, 6219.782307619212, 6230.878441880505, 6241.095041219089, 6244.875922333842, 6252.5935814171935, 6198.101275315144, 6341.651209183539, 6440.871182576416, 6475.352464753487, 6516.706748196438, 4501.369808226786, 4571.177188106173, 4571.748553829439, 4571.954280457153, 4593.2191527439745, 6109.69451527413, 6251.343608920998, 6271.278802937538, 6273.592216505913, 6288.874222515616, 6120.265568131853, 6121.887948657706, 6126.540509461719, 6129.111278864629, 6141.7543298267565, 5899.764009439746, 6085.695715214133, 6101.206843110367, 6109.083637454418, 6114.38856114385, 6004.909926351021, 6019.518438524995, 6024.668643224665, 6055.273367195965, 6059.424354686298, 6109.297430795337, 6120.479759220516, 6139.0, 6153.323134455296, 6153.707721378561, 5733.652591640877, 5937.524998000236, 5971.313298970674, 5972.820815375546, 5975.774966131846], "value": 4560.198785214265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.4993628854543, 831.2975535672358, 883.9425437346572, 915.6886658536097, 940.619049285039, 16197.0, 17853.821461785377, 17926.641467170648, 17968.101594920234, 18044.90977545112, 15590.06459612424, 15705.685886282296, 15744.212789360543, 15826.28781704823, 15847.3661053558, 871.2246100970142, 908.0, 914.0174312613933, 916.9633214671405, 918.1874041473311, 919.0946917286467, 920.07992007992, 923.6582464488115, 926.4626516620344, 926.9675561355353, 962.6582563190071, 968.3657204531044, 974.025974025974, 975.1759763000289, 977.4672803322206, 964.0696727657809, 969.6121551379434, 970.8203982263304, 972.2562239886493, 973.4013581647307, 711.8042538301956, 712.3090602115939, 713.0124777183586, 713.8750718624271, 716.2479396633514, 15720.842791572166, 16089.356425742957, 16183.190840458048, 16303.918480407521, 17027.318907243694, 16518.6696266074, 17457.301707931667, 17470.912645436692, 17543.298268069262, 17643.38248161321, 13177.096832074001, 13478.989075819352, 13657.317134143253, 13681.110727802661, 13805.792913106312, 4151.7924103794685, 4183.058811767359, 4191.580841915815, 4267.850625228133, 4277.6791740619265, 59052.11421828633, 74446.71629181178, 76011.61994190048, 79090.20909790944, 86352.56823715904, 12475.438605262785, 12734.235945843278, 12781.61655150347, 12799.29603871796, 12869.742605147845, 22982.195623153108, 23055.769442305696, 23082.422939426648, 23093.653595196087, 23700.0, 9125.954370228106, 9349.298802589832, 9358.15776580111, 9386.624535018524, 9451.196648284973, 5178.249153872667, 5329.987302412529, 5340.519353258225, 5388.326459192601, 5536.7231638418725, 3992.680585553149, 4120.711550191458, 4121.793910304473, 4123.97938010308, 4160.417541544186, 730.7040648537351, 739.1795107430747, 748.0611832150724, 762.954222746637, 783.3576467296875, 690.5865533497896, 823.3783493462397, 825.7976795684975, 845.4377838737171, 854.7008547008497, 10086.445245511568, 10281.202079142757, 10389.636362727268, 10880.020798128206, 11440.942795286137, 767.3592550220628, 791.3589992106412, 799.7560743973144, 824.7773101262626, 838.0362583029565, 5270.841874743764, 5302.973485132627, 5344.35867695879, 5472.425395333512, 5549.445055494418, 91909.0, 136325.0, 136791.0, 137517.0, 141239.29380353238, 111640.0, 113436.0, 113473.43263283631, 113508.0, 113871.0, 96409.51795240979, 101721.49139254256, 105560.0, 106528.99999999844, 106533.0, 9879.802403952024, 10041.096301332915, 10347.741306467398, 10367.32612380193, 10370.637027703995, 60614.0, 60830.08754868769, 61462.0, 62122.37877621166, 62740.0, 77580.61209693915, 89985.0, 90833.54583227042, 91208.54395727979, 92116.53941730248, 13252.734945300846, 13319.533816316383, 13345.866541334462, 13516.729665406834, 13541.932290338485, 15002.124734408198, 15015.849841501446, 15025.0, 15295.541133766004, 15346.616334591725, 14173.503927362493, 14321.85425166005, 14542.85457145415, 14598.416063357347, 14883.404663813326, 13529.661758455724, 13645.931770341085, 13654.180749155083, 14204.289785510477, 14415.207163605683, 13276.601701948957, 13375.598732038054, 13497.257650829299, 14031.859681403055, 14070.0, 10797.838032429363, 11421.771564568497, 11423.657290281304, 11592.884071159518, 12056.698582535506, 11877.465514051715, 12055.21641093326, 12151.210171338835, 12195.451204695633, 12279.877201227873], "value": 8393.570418244244, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 105.0, 111.0, 111.0, 112.0, 111.0, 110.0, 110.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 120.0, 141.0, 169.0, 118.0, 146.0, 150.0, 124.0, 169.0, 120.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 163.0, 164.0, 161.0, 162.0, 162.0, 167.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 172.0, 76.0, 76.0, 74.0, 75.0, 172.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 144.0, 84.0, 83.0, 85.0, 146.0, 83.0, 82.0, 141.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 50.0, 50.0, 49.0, 50.0, 50.0, 50.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 72.0, 78.0, 72.0, 71.0, 73.0, 73.0, 82.0, 77.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 118.0, 117.0, 116.0, 117.0, 123.0, 134.0, 116.0, 161.0, 138.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 155.0, 155.0, 156.0, 154.0, 152.0, 153.0, 155.0, 152.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0], "value": 61.9, "unit": "score"}]}]} 04:55:06 INFO - Return code: 0 04:55:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:07 ERROR - # TBPL SUCCESS # 04:55:07 INFO - Running post-action listener: _resource_record_post_action 04:55:07 INFO - [mozharness: 2016-08-28 11:55:07.005313Z] Finished run-tests step (success) 04:55:07 INFO - Running post-run listener: _resource_record_post_run 04:55:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 327725056; Read time: 32; Write time: 240552 04:55:07 INFO - TinderboxPrint: CPU usage
13.2% 04:55:07 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 04:55:07 INFO - TinderboxPrint: I/O write bytes / time
327,725,056 / 240,552 04:55:07 INFO - TinderboxPrint: CPU idle
8,228.6 (86.7%) 04:55:07 INFO - TinderboxPrint: CPU user
1,200.6 (12.7%) 04:55:07 INFO - TinderboxPrint: Swap in / out
0 / 0 04:55:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78237696; Read time: 0; Write time: 51940 04:55:07 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249196544; Read time: 32; Write time: 188592 04:55:07 INFO - Running post-run listener: _upload_blobber_files 04:55:07 INFO - Blob upload gear active. 04:55:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:07 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 04:55:07 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'] 04:55:07 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 04:55:08 INFO - Traceback (most recent call last): 04:55:08 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 04:55:08 INFO - main() 04:55:08 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 04:55:08 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 04:55:08 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 04:55:08 INFO - return set(response.json().get('whitelist', [])) 04:55:08 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 04:55:08 INFO - return json.loads(self.text or self.content, **kwargs) 04:55:08 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 04:55:08 INFO - return _default_decoder.decode(s) 04:55:08 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 04:55:08 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 04:55:08 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 04:55:08 INFO - raise ValueError("No JSON object could be decoded") 04:55:08 INFO - ValueError: No JSON object could be decoded 04:55:08 ERROR - Return code: 1 04:55:08 INFO - Setting buildbot property blobber_files to {} 04:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:55:08 INFO - Contents: 04:55:08 INFO - blobber_files:{} 04:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:55:08 INFO - Copying logs to upload dir... 04:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1671.578096 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-08-28 04:55:07.724212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:55:07.728096) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/DceP3cLkSRyynuNxN1DWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:55:07.780741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:55:07.781105) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472383635.15162-856076022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:55:07.831242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:55:07.831604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:55:07.831912) ========= ========= Total master_lag: 0.17 =========