builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1475538952.3 results: success (0) buildid: 20161003151358 builduid: 153073c21b2d4f6f8e31ab7826804dee revision: 5247dff49fb71083d1f2e4f13f5edacb6f0fd2c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.296870) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.297283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.297595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.381301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.381618) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 16:55:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.1M=0s 2016-10-03 16:55:55 (96.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.288884 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.687998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.688367) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017619 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.741577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:52.745007) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5247dff49fb71083d1f2e4f13f5edacb6f0fd2c1 --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-beta --rev 5247dff49fb71083d1f2e4f13f5edacb6f0fd2c1 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 16:55:55,143 truncating revision to first 12 chars 2016-10-03 16:55:55,144 Setting DEBUG logging. 2016-10-03 16:55:55,144 attempt 1/10 2016-10-03 16:55:55,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5247dff49fb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 16:55:55,456 unpacking tar archive at: mozilla-beta-5247dff49fb7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:53.414964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:53.415710) ========= script_repo_revision: 5247dff49fb71083d1f2e4f13f5edacb6f0fd2c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:53.416632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:53.417342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 16:55:53.429404) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-03 16:55:53.429667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:55:55 INFO - MultiFileLogger online at 20161003 16:55:55 in /builds/slave/test 16:55:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:55:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:55:55 INFO - {'append_to_log': False, 16:55:55 INFO - 'base_work_dir': '/builds/slave/test', 16:55:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:55:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:55:55 INFO - 'branch': 'Mozilla-Beta', 16:55:55 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:55 INFO - 'config_files': ('talos/linux_config.py',), 16:55:55 INFO - 'default_actions': ('clobber', 16:55:55 INFO - 'read-buildbot-config', 16:55:55 INFO - 'download-and-extract', 16:55:55 INFO - 'populate-webroot', 16:55:55 INFO - 'create-virtualenv', 16:55:55 INFO - 'install', 16:55:55 INFO - 'run-tests'), 16:55:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:55 INFO - 'download_minidump_stackwalk': True, 16:55:55 INFO - 'download_symbols': 'ondemand', 16:55:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:55:55 INFO - 'tooltool.py': '/tools/tooltool.py', 16:55:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:55:55 INFO - '/tools/misc-python/virtualenv.py')}, 16:55:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:55 INFO - 'installer_path': 'installer.exe', 16:55:55 INFO - 'log_level': 'info', 16:55:55 INFO - 'log_name': 'talos', 16:55:55 INFO - 'log_to_console': True, 16:55:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:55:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:55:55 INFO - 'opt_config_files': (), 16:55:55 INFO - 'pip_index': False, 16:55:55 INFO - 'sps_profile': False, 16:55:55 INFO - 'sps_profile_interval': 0, 16:55:55 INFO - 'suite': 'dromaeojs-e10s', 16:55:55 INFO - 'system_bits': '32', 16:55:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:55 INFO - 'title': 'talos-linux64-ix-069', 16:55:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:55 INFO - 'use_talos_json': True, 16:55:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:55:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:55 INFO - 'work_dir': 'build'} 16:55:55 INFO - [mozharness: 2016-10-03 23:55:55.915870Z] Running clobber step. 16:55:55 INFO - Running pre-action listener: _resource_record_pre_action 16:55:55 INFO - Running main action method: clobber 16:55:55 INFO - rmtree: /builds/slave/test/build 16:55:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:55:56 INFO - Running post-action listener: _resource_record_post_action 16:55:56 INFO - [mozharness: 2016-10-03 23:55:56.374083Z] Finished clobber step (success) 16:55:56 INFO - [mozharness: 2016-10-03 23:55:56.374186Z] Running read-buildbot-config step. 16:55:56 INFO - Running pre-action listener: _resource_record_pre_action 16:55:56 INFO - Running main action method: read_buildbot_config 16:55:56 INFO - Using buildbot properties: 16:55:56 INFO - { 16:55:56 INFO - "project": "", 16:55:56 INFO - "product": "firefox", 16:55:56 INFO - "script_repo_revision": "production", 16:55:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:55:56 INFO - "repository": "", 16:55:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:55:56 INFO - "buildid": "20161003151358", 16:55:56 INFO - "pgo_build": "True", 16:55:56 INFO - "basedir": "/builds/slave/test", 16:55:56 INFO - "buildnumber": 137, 16:55:56 INFO - "slavename": "talos-linux64-ix-069", 16:55:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:55:56 INFO - "platform": "ubuntu64_hw", 16:55:56 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:55:56 INFO - "branch": "mozilla-beta", 16:55:56 INFO - "repo_path": "releases/mozilla-beta", 16:55:56 INFO - "revision": "5247dff49fb71083d1f2e4f13f5edacb6f0fd2c1", 16:55:56 INFO - "stage_platform": "linux64-pgo", 16:55:56 INFO - "builduid": "153073c21b2d4f6f8e31ab7826804dee", 16:55:56 INFO - "slavebuilddir": "test" 16:55:56 INFO - } 16:55:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 16:55:56 INFO - Running post-action listener: _resource_record_post_action 16:55:56 INFO - [mozharness: 2016-10-03 23:55:56.376651Z] Finished read-buildbot-config step (success) 16:55:56 INFO - [mozharness: 2016-10-03 23:55:56.376741Z] Running download-and-extract step. 16:55:56 INFO - Running pre-action listener: _resource_record_pre_action 16:55:56 INFO - Running main action method: download_and_extract 16:55:56 INFO - mkdir: /builds/slave/test/build/tests 16:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:56 INFO - https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:55:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:55:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:55:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:55:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:55:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:55:56 INFO - retry: Failed, sleeping 30 seconds before retrying 16:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 16:56:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:56:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:56:26 INFO - retry: Failed, sleeping 60 seconds before retrying 16:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 16:57:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:57:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:57:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 16:57:26 INFO - Caught exception: HTTP Error 404: Not Found 16:57:26 INFO - Caught exception: HTTP Error 404: Not Found 16:57:26 INFO - Caught exception: HTTP Error 404: Not Found 16:57:26 INFO - trying https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:57:26 INFO - Downloading https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:57:27 INFO - Downloaded 1327 bytes. 16:57:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:57:27 INFO - Using the following test package requirements: 16:57:27 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 16:57:27 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:57:27 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 16:57:27 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'jsshell-linux-x86_64.zip'], 16:57:27 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:57:27 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 16:57:27 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 16:57:27 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 16:57:27 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:57:27 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:57:27 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:57:27 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:57:27 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')]} 16:57:27 INFO - https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:57:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:57:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:57:27 INFO - retry: Failed, sleeping 30 seconds before retrying 16:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 16:57:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:57:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:57:57 INFO - retry: Failed, sleeping 60 seconds before retrying 16:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 16:58:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:58:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:58:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 16:58:57 INFO - Caught exception: HTTP Error 404: Not Found 16:58:57 INFO - Caught exception: HTTP Error 404: Not Found 16:58:57 INFO - Caught exception: HTTP Error 404: Not Found 16:58:57 INFO - trying https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:58 INFO - Downloaded 21841875 bytes. 16:58:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:58:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:58:59 INFO - Return code: 0 16:58:59 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:58:59 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')]} 16:58:59 INFO - https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:58:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:58:59 INFO - retry: Failed, sleeping 30 seconds before retrying 16:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 16:59:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:59:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:59:29 INFO - retry: Failed, sleeping 60 seconds before retrying 17:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 17:00:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:00:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:00:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 17:00:29 INFO - Caught exception: HTTP Error 404: Not Found 17:00:29 INFO - Caught exception: HTTP Error 404: Not Found 17:00:29 INFO - Caught exception: HTTP Error 404: Not Found 17:00:29 INFO - trying https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:00:29 INFO - Downloading https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:00:30 INFO - Downloaded 21841875 bytes. 17:00:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:00:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:00:31 INFO - Return code: 0 17:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:31 INFO - https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:00:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:00:31 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:00:31 INFO - retry: Failed, sleeping 30 seconds before retrying 17:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 17:01:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:01:01 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:01:01 INFO - retry: Failed, sleeping 60 seconds before retrying 17:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 17:02:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:02:01 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:02:01 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 17:02:01 INFO - Caught exception: HTTP Error 404: Not Found 17:02:01 INFO - Caught exception: HTTP Error 404: Not Found 17:02:01 INFO - Caught exception: HTTP Error 404: Not Found 17:02:01 INFO - trying https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:02:01 INFO - Downloading https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:02:04 INFO - Downloaded 14413740 bytes. 17:02:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:02:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:02:04 INFO - Return code: 0 17:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:04 INFO - https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:02:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:02:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:02:04 INFO - retry: Failed, sleeping 30 seconds before retrying 17:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 17:02:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:02:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:02:34 INFO - retry: Failed, sleeping 60 seconds before retrying 17:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 17:03:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:03:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:03:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 17:03:34 INFO - Caught exception: HTTP Error 404: Not Found 17:03:34 INFO - Caught exception: HTTP Error 404: Not Found 17:03:34 INFO - Caught exception: HTTP Error 404: Not Found 17:03:34 INFO - trying https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:03:34 INFO - Downloading https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:03:35 INFO - Downloaded 56793654 bytes. 17:03:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:03:35 INFO - mkdir: /builds/slave/test/properties 17:03:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:03:35 INFO - Writing to file /builds/slave/test/properties/build_url 17:03:35 INFO - Contents: 17:03:35 INFO - build_url:https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:03:36 INFO - Running post-action listener: _resource_record_post_action 17:03:36 INFO - Running post-action listener: set_extra_try_arguments 17:03:36 INFO - [mozharness: 2016-10-04 00:03:36.196984Z] Finished download-and-extract step (success) 17:03:36 INFO - [mozharness: 2016-10-04 00:03:36.197218Z] Running populate-webroot step. 17:03:36 INFO - Running pre-action listener: _resource_record_pre_action 17:03:36 INFO - Running main action method: populate_webroot 17:03:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:03:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:03:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:03:36 INFO - '--tppagecycles', 17:03:36 INFO - '7'], 17:03:36 INFO - 'tests': ['tsvgm']}}, 17:03:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:03:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:03:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:03:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:03:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['damp', 'tps']}, 17:03:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'tests': ['damp', 'tps']}, 17:03:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['dromaeo_dom']}, 17:03:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:03:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['basic_compositor_video']}, 17:03:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:03:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['a11yr', 17:03:36 INFO - 'ts_paint', 17:03:36 INFO - 'tpaint', 17:03:36 INFO - 'sessionrestore', 17:03:36 INFO - 'sessionrestore_no_auto_restore', 17:03:36 INFO - 'tabpaint']}, 17:03:36 INFO - 'other-e10s': {'tests': ['a11yr', 17:03:36 INFO - 'ts_paint', 17:03:36 INFO - 'tpaint', 17:03:36 INFO - 'sessionrestore', 17:03:36 INFO - 'sessionrestore_no_auto_restore', 17:03:36 INFO - 'tabpaint']}, 17:03:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:03:36 INFO - 'ts_paint', 17:03:36 INFO - 'tpaint', 17:03:36 INFO - 'sessionrestore', 17:03:36 INFO - 'sessionrestore_no_auto_restore', 17:03:36 INFO - 'tabpaint']}, 17:03:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:03:36 INFO - 'ts_paint', 17:03:36 INFO - 'tpaint', 17:03:36 INFO - 'sessionrestore', 17:03:36 INFO - 'sessionrestore_no_auto_restore', 17:03:36 INFO - 'tabpaint']}, 17:03:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['a11yr', 17:03:36 INFO - 'ts_paint', 17:03:36 INFO - 'tpaint', 17:03:36 INFO - 'sessionrestore', 17:03:36 INFO - 'sessionrestore_no_auto_restore', 17:03:36 INFO - 'tabpaint']}, 17:03:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['a11yr', 17:03:36 INFO - 'ts_paint', 17:03:36 INFO - 'tpaint', 17:03:36 INFO - 'sessionrestore', 17:03:36 INFO - 'sessionrestore_no_auto_restore', 17:03:36 INFO - 'tabpaint']}, 17:03:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['tsvgx', 17:03:36 INFO - 'tsvgr_opacity', 17:03:36 INFO - 'tart', 17:03:36 INFO - 'tscrollx', 17:03:36 INFO - 'cart']}, 17:03:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:03:36 INFO - 'tsvgr_opacity', 17:03:36 INFO - 'tart', 17:03:36 INFO - 'tscrollx', 17:03:36 INFO - 'cart']}, 17:03:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'talos_options': ['--disable-e10s'], 17:03:36 INFO - 'tests': ['tp5o']}, 17:03:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'tests': ['tp5o']}, 17:03:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'talos_options': ['--disable-e10s', 17:03:36 INFO - '--xperf_path', 17:03:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:36 INFO - 'tests': ['tp5n']}, 17:03:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:36 INFO - 'talos_options': ['--xperf_path', 17:03:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:36 INFO - 'tests': ['tp5n']}}, 17:03:36 INFO - 'talos.zip': {'path': '', 17:03:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:03:36 INFO - Running post-action listener: _resource_record_post_action 17:03:36 INFO - [mozharness: 2016-10-04 00:03:36.218922Z] Finished populate-webroot step (success) 17:03:36 INFO - [mozharness: 2016-10-04 00:03:36.219011Z] Running create-virtualenv step. 17:03:36 INFO - Running pre-action listener: _resource_record_pre_action 17:03:36 INFO - Running main action method: create_virtualenv 17:03:36 INFO - Creating virtualenv /builds/slave/test/build/venv 17:03:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:03:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:03:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:03:36 INFO - Using real prefix '/usr' 17:03:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:03:36 INFO - Installing distribute.............................................................................................................................................................................................done. 17:03:38 INFO - Installing pip.................done. 17:03:38 INFO - Return code: 0 17:03:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:03:38 INFO - Using env: {'DISPLAY': ':0', 17:03:38 INFO - 'HOME': '/home/cltbld', 17:03:38 INFO - 'LANG': 'en_US.UTF-8', 17:03:38 INFO - 'LANGUAGE': 'en_US:en', 17:03:38 INFO - 'LOGNAME': 'cltbld', 17:03:38 INFO - 'MAIL': '/var/mail/cltbld', 17:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:38 INFO - 'MOZ_NO_REMOTE': '1', 17:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:38 INFO - 'NO_EM_RESTART': '1', 17:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:38 INFO - 'PWD': '/builds/slave/test', 17:03:38 INFO - 'SHELL': '/bin/bash', 17:03:38 INFO - 'SHLVL': '1', 17:03:38 INFO - 'TERM': 'linux', 17:03:38 INFO - 'TMOUT': '86400', 17:03:38 INFO - 'USER': 'cltbld', 17:03:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:38 INFO - '_': '/tools/buildbot/bin/python'} 17:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:03:38 INFO - Cleaning up... 17:03:39 INFO - Return code: 0 17:03:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:39 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:03:39 INFO - Using env: {'DISPLAY': ':0', 17:03:39 INFO - 'HOME': '/home/cltbld', 17:03:39 INFO - 'LANG': 'en_US.UTF-8', 17:03:39 INFO - 'LANGUAGE': 'en_US:en', 17:03:39 INFO - 'LOGNAME': 'cltbld', 17:03:39 INFO - 'MAIL': '/var/mail/cltbld', 17:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:39 INFO - 'MOZ_NO_REMOTE': '1', 17:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:39 INFO - 'NO_EM_RESTART': '1', 17:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:39 INFO - 'PWD': '/builds/slave/test', 17:03:39 INFO - 'SHELL': '/bin/bash', 17:03:39 INFO - 'SHLVL': '1', 17:03:39 INFO - 'TERM': 'linux', 17:03:39 INFO - 'TMOUT': '86400', 17:03:39 INFO - 'USER': 'cltbld', 17:03:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:39 INFO - '_': '/tools/buildbot/bin/python'} 17:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:39 INFO - Downloading/unpacking psutil>=3.1.1 17:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:42 INFO - Installing collected packages: psutil 17:03:42 INFO - Running setup.py install for psutil 17:03:42 INFO - building 'psutil._psutil_linux' extension 17:03:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:03:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:03:42 INFO - building 'psutil._psutil_posix' extension 17:03:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:03:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:42 INFO - Successfully installed psutil 17:03:42 INFO - Cleaning up... 17:03:42 INFO - Return code: 0 17:03:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:42 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:03:42 INFO - Using env: {'DISPLAY': ':0', 17:03:42 INFO - 'HOME': '/home/cltbld', 17:03:42 INFO - 'LANG': 'en_US.UTF-8', 17:03:42 INFO - 'LANGUAGE': 'en_US:en', 17:03:42 INFO - 'LOGNAME': 'cltbld', 17:03:42 INFO - 'MAIL': '/var/mail/cltbld', 17:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:42 INFO - 'MOZ_NO_REMOTE': '1', 17:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:42 INFO - 'NO_EM_RESTART': '1', 17:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:42 INFO - 'PWD': '/builds/slave/test', 17:03:42 INFO - 'SHELL': '/bin/bash', 17:03:42 INFO - 'SHLVL': '1', 17:03:42 INFO - 'TERM': 'linux', 17:03:42 INFO - 'TMOUT': '86400', 17:03:42 INFO - 'USER': 'cltbld', 17:03:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:42 INFO - '_': '/tools/buildbot/bin/python'} 17:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:03:44 INFO - Installing collected packages: mozsystemmonitor 17:03:44 INFO - Running setup.py install for mozsystemmonitor 17:03:45 INFO - Successfully installed mozsystemmonitor 17:03:45 INFO - Cleaning up... 17:03:45 INFO - Return code: 0 17:03:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:45 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:03:45 INFO - Using env: {'DISPLAY': ':0', 17:03:45 INFO - 'HOME': '/home/cltbld', 17:03:45 INFO - 'LANG': 'en_US.UTF-8', 17:03:45 INFO - 'LANGUAGE': 'en_US:en', 17:03:45 INFO - 'LOGNAME': 'cltbld', 17:03:45 INFO - 'MAIL': '/var/mail/cltbld', 17:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:45 INFO - 'MOZ_NO_REMOTE': '1', 17:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:45 INFO - 'NO_EM_RESTART': '1', 17:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:45 INFO - 'PWD': '/builds/slave/test', 17:03:45 INFO - 'SHELL': '/bin/bash', 17:03:45 INFO - 'SHLVL': '1', 17:03:45 INFO - 'TERM': 'linux', 17:03:45 INFO - 'TMOUT': '86400', 17:03:45 INFO - 'USER': 'cltbld', 17:03:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:45 INFO - '_': '/tools/buildbot/bin/python'} 17:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:45 INFO - Downloading/unpacking jsonschema==2.5.1 17:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:47 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:47 INFO - warning: no files found matching '*.txt' 17:03:47 INFO - no previously-included directories found matching 'build' 17:03:47 INFO - no previously-included directories found matching 'dist' 17:03:47 INFO - no previously-included directories found matching '.git*' 17:03:47 INFO - Installing collected packages: jsonschema, functools32 17:03:47 INFO - Running setup.py install for functools32 17:03:47 INFO - warning: no files found matching '*.txt' 17:03:47 INFO - no previously-included directories found matching 'build' 17:03:47 INFO - no previously-included directories found matching 'dist' 17:03:47 INFO - no previously-included directories found matching '.git*' 17:03:47 INFO - Successfully installed jsonschema functools32 17:03:47 INFO - Cleaning up... 17:03:47 INFO - Return code: 0 17:03:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:03:47 INFO - Using env: {'DISPLAY': ':0', 17:03:47 INFO - 'HOME': '/home/cltbld', 17:03:47 INFO - 'LANG': 'en_US.UTF-8', 17:03:47 INFO - 'LANGUAGE': 'en_US:en', 17:03:47 INFO - 'LOGNAME': 'cltbld', 17:03:47 INFO - 'MAIL': '/var/mail/cltbld', 17:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:47 INFO - 'MOZ_NO_REMOTE': '1', 17:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:47 INFO - 'NO_EM_RESTART': '1', 17:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:47 INFO - 'PWD': '/builds/slave/test', 17:03:47 INFO - 'SHELL': '/bin/bash', 17:03:47 INFO - 'SHLVL': '1', 17:03:47 INFO - 'TERM': 'linux', 17:03:47 INFO - 'TMOUT': '86400', 17:03:47 INFO - 'USER': 'cltbld', 17:03:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:47 INFO - '_': '/tools/buildbot/bin/python'} 17:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:03:47 INFO - Cleaning up... 17:03:47 INFO - Return code: 0 17:03:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:03:47 INFO - Using env: {'DISPLAY': ':0', 17:03:47 INFO - 'HOME': '/home/cltbld', 17:03:47 INFO - 'LANG': 'en_US.UTF-8', 17:03:47 INFO - 'LANGUAGE': 'en_US:en', 17:03:47 INFO - 'LOGNAME': 'cltbld', 17:03:47 INFO - 'MAIL': '/var/mail/cltbld', 17:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:47 INFO - 'MOZ_NO_REMOTE': '1', 17:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:47 INFO - 'NO_EM_RESTART': '1', 17:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:47 INFO - 'PWD': '/builds/slave/test', 17:03:47 INFO - 'SHELL': '/bin/bash', 17:03:47 INFO - 'SHLVL': '1', 17:03:47 INFO - 'TERM': 'linux', 17:03:47 INFO - 'TMOUT': '86400', 17:03:47 INFO - 'USER': 'cltbld', 17:03:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:47 INFO - '_': '/tools/buildbot/bin/python'} 17:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:50 INFO - Downloading docopt-0.6.1.tar.gz 17:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:03:50 INFO - Installing collected packages: blobuploader, requests, docopt 17:03:50 INFO - Running setup.py install for blobuploader 17:03:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:03:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:03:51 INFO - Running setup.py install for requests 17:03:51 INFO - Running setup.py install for docopt 17:03:51 INFO - Successfully installed blobuploader requests docopt 17:03:51 INFO - Cleaning up... 17:03:51 INFO - Return code: 0 17:03:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:51 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:03:51 INFO - Using env: {'DISPLAY': ':0', 17:03:51 INFO - 'HOME': '/home/cltbld', 17:03:51 INFO - 'LANG': 'en_US.UTF-8', 17:03:51 INFO - 'LANGUAGE': 'en_US:en', 17:03:51 INFO - 'LOGNAME': 'cltbld', 17:03:51 INFO - 'MAIL': '/var/mail/cltbld', 17:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:51 INFO - 'MOZ_NO_REMOTE': '1', 17:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:51 INFO - 'NO_EM_RESTART': '1', 17:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:51 INFO - 'PWD': '/builds/slave/test', 17:03:51 INFO - 'SHELL': '/bin/bash', 17:03:51 INFO - 'SHLVL': '1', 17:03:51 INFO - 'TERM': 'linux', 17:03:51 INFO - 'TMOUT': '86400', 17:03:51 INFO - 'USER': 'cltbld', 17:03:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:51 INFO - '_': '/tools/buildbot/bin/python'} 17:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:51 INFO - Running setup.py (path:/tmp/pip-foD6HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:51 INFO - Running setup.py (path:/tmp/pip-heG7au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:51 INFO - Running setup.py (path:/tmp/pip-9NPoR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:52 INFO - Running setup.py (path:/tmp/pip-O5dsBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:52 INFO - Running setup.py (path:/tmp/pip-uzvVoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:52 INFO - Running setup.py (path:/tmp/pip-agqvY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:52 INFO - Running setup.py (path:/tmp/pip-qiS5Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:52 INFO - Running setup.py (path:/tmp/pip-ysFS7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:52 INFO - Running setup.py (path:/tmp/pip-K8pCBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:52 INFO - Running setup.py (path:/tmp/pip-a6SKUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:52 INFO - Running setup.py (path:/tmp/pip-vmmZhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:52 INFO - Running setup.py (path:/tmp/pip-j7TqkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:52 INFO - Running setup.py (path:/tmp/pip-tKkSRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:52 INFO - Running setup.py (path:/tmp/pip-718R6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:52 INFO - Running setup.py (path:/tmp/pip-IQlxCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:52 INFO - Running setup.py (path:/tmp/pip-4g5cxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:52 INFO - Running setup.py (path:/tmp/pip-emJruI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:03:53 INFO - Running setup.py install for manifestparser 17:03:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Running setup.py install for mozcrash 17:03:53 INFO - Running setup.py install for mozdebug 17:03:53 INFO - Running setup.py install for mozdevice 17:03:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Running setup.py install for mozfile 17:03:53 INFO - Running setup.py install for mozhttpd 17:03:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Running setup.py install for mozinfo 17:03:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Running setup.py install for mozInstall 17:03:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:03:53 INFO - Running setup.py install for mozleak 17:03:53 INFO - Running setup.py install for mozlog 17:03:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:03:54 INFO - Running setup.py install for moznetwork 17:03:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:03:54 INFO - Running setup.py install for mozprocess 17:03:54 INFO - Running setup.py install for mozprofile 17:03:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:03:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:03:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:03:54 INFO - Running setup.py install for mozrunner 17:03:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:03:54 INFO - Running setup.py install for mozscreenshot 17:03:54 INFO - Running setup.py install for moztest 17:03:54 INFO - Running setup.py install for mozversion 17:03:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:03:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:03:54 INFO - Cleaning up... 17:03:54 INFO - Return code: 0 17:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:54 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:03:54 INFO - Using env: {'DISPLAY': ':0', 17:03:54 INFO - 'HOME': '/home/cltbld', 17:03:54 INFO - 'LANG': 'en_US.UTF-8', 17:03:54 INFO - 'LANGUAGE': 'en_US:en', 17:03:54 INFO - 'LOGNAME': 'cltbld', 17:03:54 INFO - 'MAIL': '/var/mail/cltbld', 17:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:54 INFO - 'MOZ_NO_REMOTE': '1', 17:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:54 INFO - 'NO_EM_RESTART': '1', 17:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:54 INFO - 'PWD': '/builds/slave/test', 17:03:54 INFO - 'SHELL': '/bin/bash', 17:03:54 INFO - 'SHLVL': '1', 17:03:54 INFO - 'TERM': 'linux', 17:03:54 INFO - 'TMOUT': '86400', 17:03:54 INFO - 'USER': 'cltbld', 17:03:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:54 INFO - '_': '/tools/buildbot/bin/python'} 17:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:55 INFO - Running setup.py (path:/tmp/pip-IVwf5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:55 INFO - Running setup.py (path:/tmp/pip-MxrvwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:55 INFO - Running setup.py (path:/tmp/pip-MFKyri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:55 INFO - Running setup.py (path:/tmp/pip-AYWyNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:55 INFO - Running setup.py (path:/tmp/pip-a2O1l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:55 INFO - Running setup.py (path:/tmp/pip-PC5isH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:55 INFO - Running setup.py (path:/tmp/pip-abCQxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:55 INFO - Running setup.py (path:/tmp/pip-HWuBEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:55 INFO - Running setup.py (path:/tmp/pip-gVSDkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:55 INFO - Running setup.py (path:/tmp/pip-UlZTaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:55 INFO - Running setup.py (path:/tmp/pip-EFYIHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:55 INFO - Running setup.py (path:/tmp/pip-aKoZys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:55 INFO - Running setup.py (path:/tmp/pip-XuTvxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:56 INFO - Running setup.py (path:/tmp/pip-VNbPNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:56 INFO - Running setup.py (path:/tmp/pip-jHCnux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:56 INFO - Running setup.py (path:/tmp/pip-i51lBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:56 INFO - Running setup.py (path:/tmp/pip-7G_VKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:58 INFO - Downloading blessings-1.6.tar.gz 17:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:03:58 INFO - Installing collected packages: blessings 17:03:58 INFO - Running setup.py install for blessings 17:03:58 INFO - Successfully installed blessings 17:03:58 INFO - Cleaning up... 17:03:58 INFO - Return code: 0 17:03:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:58 INFO - Reading from file tmpfile_stdout 17:03:58 INFO - Current package versions: 17:03:58 INFO - argparse == 1.2.1 17:03:58 INFO - blessings == 1.6 17:03:58 INFO - blobuploader == 1.2.4 17:03:58 INFO - docopt == 0.6.1 17:03:58 INFO - functools32 == 3.2.3-2 17:03:58 INFO - jsonschema == 2.5.1 17:03:58 INFO - manifestparser == 1.1 17:03:58 INFO - mozInstall == 1.12 17:03:58 INFO - mozcrash == 0.17 17:03:58 INFO - mozdebug == 0.1 17:03:58 INFO - mozdevice == 0.48 17:03:58 INFO - mozfile == 1.2 17:03:58 INFO - mozhttpd == 0.7 17:03:58 INFO - mozinfo == 0.9 17:03:58 INFO - mozleak == 0.1 17:03:58 INFO - mozlog == 3.3 17:03:58 INFO - moznetwork == 0.27 17:03:58 INFO - mozprocess == 0.23 17:03:58 INFO - mozprofile == 0.28 17:03:58 INFO - mozrunner == 6.12 17:03:58 INFO - mozscreenshot == 0.1 17:03:58 INFO - mozsystemmonitor == 0.3 17:03:58 INFO - moztest == 0.7 17:03:58 INFO - mozversion == 1.4 17:03:58 INFO - psutil == 3.1.1 17:03:58 INFO - requests == 1.2.3 17:03:58 INFO - wsgiref == 0.1.2 17:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 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 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:03:58 INFO - Using env: {'DISPLAY': ':0', 17:03:58 INFO - 'HOME': '/home/cltbld', 17:03:58 INFO - 'LANG': 'en_US.UTF-8', 17:03:58 INFO - 'LANGUAGE': 'en_US:en', 17:03:58 INFO - 'LOGNAME': 'cltbld', 17:03:58 INFO - 'MAIL': '/var/mail/cltbld', 17:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:58 INFO - 'MOZ_NO_REMOTE': '1', 17:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:58 INFO - 'NO_EM_RESTART': '1', 17:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:58 INFO - 'PWD': '/builds/slave/test', 17:03:58 INFO - 'SHELL': '/bin/bash', 17:03:58 INFO - 'SHLVL': '1', 17:03:58 INFO - 'TERM': 'linux', 17:03:58 INFO - 'TMOUT': '86400', 17:03:58 INFO - 'USER': 'cltbld', 17:03:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:58 INFO - '_': '/tools/buildbot/bin/python'} 17:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:03:58 INFO - Cleaning up... 17:03:58 INFO - Return code: 0 17:03:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc6b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:03:58 INFO - Using env: {'DISPLAY': ':0', 17:03:58 INFO - 'HOME': '/home/cltbld', 17:03:58 INFO - 'LANG': 'en_US.UTF-8', 17:03:58 INFO - 'LANGUAGE': 'en_US:en', 17:03:58 INFO - 'LOGNAME': 'cltbld', 17:03:58 INFO - 'MAIL': '/var/mail/cltbld', 17:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:58 INFO - 'MOZ_NO_REMOTE': '1', 17:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:58 INFO - 'NO_EM_RESTART': '1', 17:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:58 INFO - 'PWD': '/builds/slave/test', 17:03:58 INFO - 'SHELL': '/bin/bash', 17:03:58 INFO - 'SHLVL': '1', 17:03:58 INFO - 'TERM': 'linux', 17:03:58 INFO - 'TMOUT': '86400', 17:03:58 INFO - 'USER': 'cltbld', 17:03:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:58 INFO - '_': '/tools/buildbot/bin/python'} 17:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:03:59 INFO - Cleaning up... 17:03:59 INFO - Return code: 0 17:03:59 INFO - Running post-action listener: _resource_record_post_action 17:03:59 INFO - Running post-action listener: _start_resource_monitoring 17:03:59 INFO - Starting resource monitoring. 17:03:59 INFO - [mozharness: 2016-10-04 00:03:59.086614Z] Finished create-virtualenv step (success) 17:03:59 INFO - [mozharness: 2016-10-04 00:03:59.087079Z] Running install step. 17:03:59 INFO - Running pre-action listener: _resource_record_pre_action 17:03:59 INFO - Running main action method: install 17:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:59 INFO - Reading from file tmpfile_stdout 17:03:59 INFO - Detecting whether we're running mozinstall >=1.0... 17:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:03:59 INFO - Reading from file tmpfile_stdout 17:03:59 INFO - Output received: 17:03:59 INFO - Usage: mozinstall [options] installer 17:03:59 INFO - Options: 17:03:59 INFO - -h, --help show this help message and exit 17:03:59 INFO - -d DEST, --destination=DEST 17:03:59 INFO - Directory to install application into. [default: 17:03:59 INFO - "/builds/slave/test"] 17:03:59 INFO - --app=APP Application being installed. [default: firefox] 17:03:59 INFO - mkdir: /builds/slave/test/build/application 17:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:04:13 INFO - Reading from file tmpfile_stdout 17:04:13 INFO - Output received: 17:04:13 INFO - /builds/slave/test/build/application/firefox/firefox 17:04:13 INFO - Running post-action listener: _resource_record_post_action 17:04:13 INFO - [mozharness: 2016-10-04 00:04:13.438848Z] Finished install step (success) 17:04:13 INFO - [mozharness: 2016-10-04 00:04:13.439128Z] Running run-tests step. 17:04:13 INFO - Running pre-action listener: _resource_record_pre_action 17:04:13 INFO - Running main action method: run_tests 17:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:04:13 INFO - Python 2.7.3 17:04:13 INFO - Return code: 0 17:04:13 INFO - grabbing minidump binary from tooltool 17:04: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')]} 17:04:13 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 0xf29570>, '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 0xf2a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:04:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:04:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:04:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:04:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:13 INFO - Return code: 0 17:04:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:04:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:04:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:04:13 INFO - Using env: {'DISPLAY': ':0', 17:04:13 INFO - 'HOME': '/home/cltbld', 17:04:13 INFO - 'LANG': 'en_US.UTF-8', 17:04:13 INFO - 'LANGUAGE': 'en_US:en', 17:04:13 INFO - 'LOGNAME': 'cltbld', 17:04:13 INFO - 'MAIL': '/var/mail/cltbld', 17:04:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:13 INFO - 'MOZ_NO_REMOTE': '1', 17:04:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:13 INFO - 'NO_EM_RESTART': '1', 17:04:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:13 INFO - 'PWD': '/builds/slave/test', 17:04:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:13 INFO - 'SHELL': '/bin/bash', 17:04:13 INFO - 'SHLVL': '1', 17:04:13 INFO - 'TERM': 'linux', 17:04:13 INFO - 'TMOUT': '86400', 17:04:13 INFO - 'USER': 'cltbld', 17:04:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195', 17:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:13 INFO - '_': '/tools/buildbot/bin/python'} 17:04:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:04:13 INFO - mozversion application_buildid: 20161003151358 17:04:13 INFO - mozversion application_changeset: 5247dff49fb71083d1f2e4f13f5edacb6f0fd2c1 17:04:13 INFO - mozversion application_display_name: Firefox 17:04:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:13 INFO - mozversion application_name: Firefox 17:04:13 INFO - mozversion application_remotingname: firefox 17:04:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:04:13 INFO - mozversion application_vendor: Mozilla 17:04:13 INFO - mozversion application_version: 50.0 17:04:13 INFO - mozversion platform_buildid: 20161003151358 17:04:13 INFO - mozversion platform_changeset: 5247dff49fb71083d1f2e4f13f5edacb6f0fd2c1 17:04:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:04:13 INFO - mozversion platform_version: 50.0 17:04:13 INFO - using testdate: 1475539453 17:04:13 INFO - actual date: 1475539453 17:04:13 INFO - starting webserver on 'localhost:47003' 17:04:13 INFO - SUITE-START | Running 2 tests 17:04:13 INFO - TEST-START | dromaeo_css 17:04:13 INFO - operating with platform_type : linux_ 17:04:13 INFO - Initialising browser for dromaeo_css test... 17:04:13 INFO - TEST-INFO | started process 7539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjezuGy/profile http://localhost:47003/getInfo.html) 17:04:17 INFO - PROCESS | 7539 | __metrics Screen width/height:1600/1200 17:04:17 INFO - PROCESS | 7539 | colorDepth:24 17:04:17 INFO - PROCESS | 7539 | Browser inner width/height: 1024/697 17:04:17 INFO - PROCESS | 7539 | __metrics 17:04:18 ERROR - PROCESS | 7539 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:04:19 INFO - TEST-INFO | 7539: exit 0 17:04:19 INFO - Browser initialized. 17:04:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:19 INFO - TEST-INFO | started process 7666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjezuGy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:31 INFO - PROCESS | 7666 | RSS: Main: 150159360 17:04:31 INFO - PROCESS | 7666 | 17:05:20 INFO - PROCESS | 7666 | 1475539520717 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:07:29 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:47003/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47003/tests/dromaeo/cssquery-ext.html) 17:07:30 INFO - PROCESS | 7666 | RSS: Main: 157425664 17:07:30 INFO - PROCESS | 7666 | 17:10:32 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:47003/tests/dromaeo/cssquery-ext.html (next: http://localhost:47003/tests/dromaeo/cssquery-jquery.html) 17:10:32 INFO - PROCESS | 7666 | RSS: Main: 155734016 17:10:32 INFO - PROCESS | 7666 | 17:13:34 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:47003/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47003/tests/dromaeo/cssquery-mootools.html) 17:13:35 INFO - PROCESS | 7666 | RSS: Main: 155217920 17:13:35 INFO - PROCESS | 7666 | 17:16:36 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:47003/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47003/tests/dromaeo/cssquery-prototype.html) 17:16:37 INFO - PROCESS | 7666 | RSS: Main: 156848128 17:16:37 INFO - PROCESS | 7666 | 17:19:39 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:47003/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47003/tests/dromaeo/cssquery-yui.html) 17:19:40 INFO - PROCESS | 7666 | RSS: Main: 157929472 17:19:40 INFO - PROCESS | 7666 | 17:22:42 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:47003/tests/dromaeo/cssquery-yui.html (next: http://localhost:47003/tests/dromaeo/cssquery-dojo.html) 17:22:43 INFO - PROCESS | 7666 | RSS: Main: 157167616 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | __start_tp_report 17:22:43 INFO - PROCESS | 7666 | _x_x_mozilla_page_load 17:22:43 INFO - PROCESS | 7666 | _x_x_mozilla_page_load_details 17:22:43 INFO - PROCESS | 7666 | |i|pagename|runs| 17:22:43 INFO - PROCESS | 7666 | |0;dojo.html;3240.2871368298975;3271.4111459937208;3277.8688852445916;3297.4394352959994;3303.487959366299;5692.231548740919;5717.914231286529;5730.627509211909;5765.7117144142785;5769.3076830780265;5665.065264231397;5744.368119506861;5758.971205143979;5771.134329850524;5772.365039845614;5175.456577059411;5193.844184674447;5215.530602245816;5238.607104467161;5275.894482110355;5251.737413129347;5254.159334506479;5270.947290527103;5280.260763493114;5287.682739035651;5119.360079990001;5146.125158723007;5236.083685355066;5246.580273578104;5283.920741188886;5125.359330083758;5210.817621383271;5231.816886408977;5250.789968401259;5339.279197308352;5176.0683077046115;5254.65844720092;5268.736563171826;5269.86825329366;5282.81510147143;5740.512056475204;5741.167530708066;5794.7392367343145;5833.7374818133285;5878.706064696748;5845.941540584582;5962.940370596325;5980.940190598082;5981.162637230791;6115.541334399938;6112.63324200545;6115.48018418435;6119.479844213247;6122.816315510498;6126.479249263818;5679.233303504016;5685.573581981368;5688.772449102031;5690.146478028288;5692.003899317603;6083.513318934474;6126.181801870944;6151.507879369639;6168.938310616836;6299.716512756937;5983.910241346383;6004.42957918997;6019.759209631653;6024;6051.909221361683;6052.243469566304;6104.786332478342;6122.969385153046;6125.387461253839;6138.14066030756;5944.138099975479;6021.849453763691;6054.06162044875;6074.54440916933;6127.556056270658;6067.9684453642985;6068.787592434243;6098.024316109401;6127.34224287047;6127.601705889103;4678.461976872703;4686.929696054562;4688.695234809727;4694.88262793426;4708.411448568929;4054.2904991626347;4091.5499295077516;4109.815058322323;4158.397032430341;4216.093539888939;5824.126381042793;5883.441073098049;5885;5889.0283103287475;5893.5579831512805;6111.327753947062;6166.105914642441;6169.290531588835;6172.197614310111;6180.381961803873;5711.057675483498;5721.5136713379;5802.274715660543;5810.302763668386;5871.031279838779;5288.206768984606;5295.285136506523;5298.417174110845;5299.364076310867;5300.44345343741;6226.128342032119;6297.055441683784;6301.96849015752;6370.522210834113;6373.968130159412;6094.9085763714465;6116.305337586134;6124.5406594506485;6194.628322300677;6201.937980620317;6318.336574659595;6320.462760665395;6321.304656487875;6324.146240257506;6330.01884707871;5875.089361149029;6066.666333351708;6074.331823499323;6074.36219196978;6085.847853803513;6072.787452439144;6075.939240607714;6098.9390106100145;6143.508519318354;6167.105769663284;5980.102984552178;5991.520678345809;5997.100434934795;6003.669798161143;6036.909446358396;5891.293044834647;5960;5985;5992.8801423972145;5994.400559943971;5787.218725472176;5825.097109947965;5854.531637468907;5879.323877754113;5943.375945525658;5909.3795151508475;5979.850503737267;5996.790112346047;6005.6396616203165;6019.849503762441;5758.62568933018;5838.912416313844;5862.384449632727;5867.20792692981;5867.647941123546 17:22:43 INFO - PROCESS | 7666 | |1;ext.html;592.4253474130095;622.4771192198554;650.9186351706034;652.892272774992;699.9370056694896;41980.79009604952;45371.77314113425;45929.31106033404;45966.77016614917;46085.847853803716;46030.309545356846;47054.76472617641;47069;47099.764501177444;47110.29334559984;9079.137481939206;9137.360384773068;9186.770330741718;9235.630574777;9239.076092390775;9101.180893719564;9167.083291670813;9198.310126740487;9214.216791572724;9214.907850921505;9271.95364023179;9344.579493922756;9347.345685801996;9350.532473376337;9360.953195234048;9150.359474836763;9158.404703694305;9187.356885018018;9253.72238832836;9257.861132083024;9079.909200907972;9176.174144327042;9210.585523651453;9218.216451601622;9223.492707901063;43424.348634770504;43879.561204387865;43933.78033109814;43995;43997;3877.689784817208;3935.685145188378;4025.63769260765;4118.5263694675195;4625.421822272216;34046.6595334046;34077;34408;34442.138946526284;35660.643393565995;4820.4456487503685;4825.445073816521;4836.782344794493;4857.368542089541;4918;395262;397574;398070;398654;400145;61523.6923815378;61865.690671546356;61916.69041654853;61934.38065619286;62134.37865621376;40817.387739183934;41554.37668434976;41651;43245.78377108157;65338;16971.490855274362;16971.575710607332;16985.830141698672;17124.14379281031;17153.399631012853;12590.43343049565;12594.055445841599;12601.117921745574;12642.683932901751;12647.114701970773;21146.15415383398;21174.682379764316;21266.78733212648;21415.357539273846;21451.78548214498;7638.469712010838;7744.845103097907;7776.611169441505;7799.49303295284;7816.41376896735;1032.6695457453543;1065.5311662868469;1106.004595863729;1107.8725946516254;1149.5114576305036;33734.325313493595;33832.83083584616;34432.45783301165;35042.29915401729;35253.417055782586;1173.143605168232;1173.1904985559936;1191.124523475245;1234.4321612058554;1251.6870782304425;17526.21132049061;17624.383146589807;17630.647387052442;17660.470185894443;17817.46547603574;631538;634121;637639;640059;640680;61255.693721532;61991;62100.68949655223;62204.377956220764;62211;1440.9135451872921;1442.8124343835234;1457.8760805331453;1471.3158381352937;1472.4919902633574;31212.219694507818;32944.67055329512;33086.50370244496;33143.66856331406;33741.83129084339;54920.176197356275;55641.44358556525;55716;55855;56087.43912560985;526936;528190;529170;530628;535779;29960.101196964126;30308.242293941945;30347.39305213839;30444.391112178077;30637;49995;50355.74822125866;51017.74491127521;53098;53875.191872122734;44901.55098448974;45404.44921465469;47016;47739.28391074067;47912.7604361976;47205;47252.763736182475;47888;48256.7587162062;48276.758616206695;44732.32901506415;45567.31649025334;46478;46519.30221046755;46756.766216168704;40636.59363406328;40758.59241407548;41118.79440602778;41141.58858411378;41189;30952.380952381278;31070.22324441907;31105.53341699831;31158.997381219604;31581.684183157875 17:22:43 INFO - PROCESS | 7666 | |2;jquery.html;403.33047141744726;406.6015305001097;419.119848318531;422.4740198452927;437.3199674506142;19146.521336966565;19943.1025603848;20735.896320518394;20829.479263018395;21069.99999999996;20195.697064544045;20258.49353766153;20425.38723838287;20857.26999555016;20918;5813.563982701293;6048.425399587032;6052.364501727321;6062.9090563641585;6065.666388348639;5832.825015249549;5929.347771745104;5929.377415371388;5971.193888825018;6006.579539432241;5914.378990206031;5919.408059194089;5925.585209035369;5926.229590153295;5953.464188223059;5855.502282305988;5879.706014699269;5914.940850591482;5926.140709597106;5939.109133629947;5116.104681680691;5259.947400525984;5263.526282634582;5264.684118952875;5274.7626356814035;24133.637995430083;24562.508749825083;24714.011439542395;24754.628680569807;24965;2533.923982280516;2554.5018721349343;2567;2628.5531459651716;3082.475979083561;15739.921300393426;15879.761803572956;15992.600184995352;15996.200189990454;16044.679106417807;2017.5258814178655;2040.6122836660986;2050.3848845346483;2071.2854065347433;2087.321620473352;83548.58225708893;84502.15497845004;84510;84629;85606.57196713977;10693.304935179189;10910.498959982848;10978.505967231495;11052.502637381338;11086.611968581223;15234;15243.923780381027;15253.542393728207;15272;15326.923365383325;8279.710210142737;8405.327573794082;8577.699780507652;8579.571021448903;8701.608427620773;8231.835363292701;8322.833543329221;8341.499510029418;8401.285890699237;8448.577571121543;6759.5606285591275;6760.594364338155;6789.966050169717;6795.490338224653;6904.067950826675;1791.5073354827528;1951.8243358097839;2016.747906511686;2051.302557130553;2088.5196404826975;1009.9848502272472;1039.6744151207272;1070.7430216747925;1116.330201878866;1147.0937959012454;21277.78722212758;21278.78721212799;21406.78593214048;21508.677369839465;21772;1054.9683509494728;1068.9732756681144;1071.6677829872765;1074.5272080284649;1101.64196636092;11670.474828632561;11752.471138798775;12095.697607559881;12127.636170914886;12199.69500762488;431272;436556;439351;458608;476287;81603;83361.58319208486;84653.57673211595;86111;86146.56926715451;1125.6172901213627;1130.0451118804597;1133.699569614053;1150.4017910686396;1162.5059349776311;17984.280628775225;18463.90768046151;18595.16321765551;18802.905985469984;19153.712694309874;40083.79958100308;40836.38745418881;40917;42608.360874587524;43037.3544396828;54541.45458545364;55633;56010.439895602154;56174.43825561692;56859.43140568707;8279.172082791914;8466.195711407407;8585.227329540372;8612.138786121588;8724.389292749447;11534.884651153718;11555.711107222387;11646.417679116179;11918.344491053076;12235.388230588613;9642.132208101304;9994.10053095225;11078.279911805706;11344.829827552428;11377.886221138015;10342.896571034495;10390.584376625153;10419.791604167722;10443.216758743276;10474.528646210787;10937.289076210021;11154.107671386431;11290.7741845161;11346.205765596329;11429;8184.959075204824;8213.712520061768;8266.090730019572;8469.957650211956;8508.702195423131;11172.385518796544;11712.648620541397;12244;12493.75012499763;12772.87227127754 17:22:43 INFO - PROCESS | 7666 | |3;mootools.html;1336.2984532844023;1420.2614640386998;1488.203810961136;1776.1918327161143;1798.6132981409003;8353.289970352513;8910.242629376502;8991.145841145097;9606.855897161548;9609.903900960997;9174.220191283748;9394.765130871714;9416.105469980357;9445.244380449565;9473.147416732492;2449.5223431430877;2470.6170543565777;2487.6517287579754;2498.250524842549;2504.0734928076636;2398.8560686358787;2530.101813856082;2533.5439620868237;2547.0703193334393;2550.8469491830456;2457.3979375053136;2467.5311690778785;2531.367377926963;2532.645429639843;2535.3408113890428;2394.92228497177;2394.988025059872;2402.8318017738766;2456.8648724320155;2457.938551536208;2383.2969274064194;2396.6884305040408;2397.8681172535503;2397.9880100599385;2409.6867407237123;9380.437173769596;9516.762080947963;9531.332806703533;9544.284178686627;9549.28380371468;5389.353277606673;5522.889542209174;5526.640768350045;5528.9723551381985;5533;3352.530645709578;3386.6444023377435;3445.87939422119;3463.480477928306;3484.1115515543374;1055.8944105589455;1071.7320669832543;1102.2449622008949;1105.2429086075983;1123.2025262063944;12738.235705857678;12763.87236127636;12778.169418987736;12783.041271904644;12808.295543745091;4524.25349817283;4636.698614590041;4774;4806.303086052503;4808.182608956416;10787.406692631823;10809.729756756144;10877;10881.673549793519;10893.564257429773;5549.889002219933;5563.721813909288;5572.693501857356;5581.972090139523;5591.720413979366;4551.726896386162;4990.176620857518;5101.387833459934;5107.821226257138;5113.258577506241;4254.276772948606;4308.526062133163;4333.804978775963;4374.059577190856;4394.626456751148;1354.0995238166508;1373.2927542315715;1388.167099740148;1398.293861599906;1403.2422491854284;900.2348004196512;947.6920000999703;950.5769932380025;979.2019504104132;1052.1687866585464;6147.66187859672;6341.334159913143;6444.097826304321;6495.382938620824;6528.804135875836;999.4752754803786;1000.8698869146964;1010.3836659637615;1038.7558923652934;1069.9732506687394;4445.26653102241;4587.08258348325;4612;4622.052479241815;4661.160991021581;11355.54577816878;11385;11611.709707257387;11671.299722016705;11687.766244675058;11439.199256052163;11553.480093395649;11567.537298508134;11569.958703716706;11586.304821710724;8029.156938521488;8340.165983401612;8377.45546539473;8551.700690475804;8615.827683446296;6550.639714815731;6682.599044057372;6766.120404347404;6770.695318710768;6837.213720422215;10647.254692171473;10774.353538787698;10836.837447438136;11002.669919902415;11041.558337666725;10860.185486088732;10869.402182879701;10949.671509854717;11026.44867756625;11061.944690276498;7508.549487030577;7779.688812447439;7935.0874649416055;8317.500949943023;8464.957675211585;8551.828963420821;8569.614367353359;8572.185642363966;8582.270507006975;8597.570121494025;7274.781756547312;7386.630668466662;7401.1488678802625;7531.661075251736;7641.197674244347;7385.852282954418;7602.543847369176;7708.075030996316;7730.149683534919;7754.108277548155;6933.687984040629;6979.581225126509;7040.823979400351;7054.153501579844;7068.858622827617;5287.365516137934;5313.203019547099;5314.654547454403;5315.707636079898;5457.563394928476;5437.885233527197;5441.2654291670115;5500.202470641814;5518.475744804237;5555.86104848497 17:22:43 INFO - PROCESS | 7666 | |4;prototype.html;338.45846645367413;354.9609542950276;355.76875031229713;356.02804344140503;359.17569178734817;5666.025336698235;5749.856253593663;5856.648601083938;5915.9999999999945;5935.169076329317;5746;5783.6529808211535;5784.942150578493;5785.27684039495;5793.5365170786345;4537.682362234645;4544.500104988449;4548.476260452752;4564.97717511412;4584.633229341644;4445.977770111145;4517.209488339544;4525.728456292616;4552.203364411232;4554.931676024862;4496.572825581565;4503.707259028169;4503.729776213438;4514.8194072237075;4515.577593058176;4524.864254072383;4527.886802829923;4534.569215924482;4548.5906268436;4565.671507531183;3856.8650097246464;3973.304671682444;4015.7188996770237;4019.839206431739;4030.717849750519;5667;5677.587025514181;5678.545716342683;5710.428957104298;5713.74288157034;5199.792008319662;5204.854931914972;5215.869603259949;5216.843494695166;5219.556337711299;5862.267216597926;6039.969800151015;6080.817575472743;6089.756409743605;6115.602485838451;4404.823807047715;4412.514623391425;4412.742368424983;4414.329330754879;4423.5797599228345;6183.1961844960315;6345.777897773602;6349.269833969107;6356.745730170787;6360.204974378203;4435.379046933432;4483.30508771141;4493.685442019093;4527.47933987589;4533.954660453419;4530.88672783183;4546.931796023062;4561.931571026437;4567.954320456819;4587.197240482902;5176.7152806596;5187.19598462239;5197.220416937414;5205.817796377184;5209.218617207373;5835.679037652885;5885.882282354414;6077;6100.431247720045;6116.143739876421;1517.4233791159509;1546.4896584127212;1548.6980038892534;1551.5733173377187;1551.736204845179;932.2495391210006;961.5961296255449;969.8157350103457;980.7106903463496;981.347403976362;5164.25118357836;5170.224466330005;5201.895962080737;5204.245384419238;5207.817726379559;5477.424870388551;5495.450454954473;5495.835124946258;5508.3114610673665;5532.336119665585;5015.949840501621;5186.625544230782;5193.246979187997;5214.3071235888;5248.7900483980975;2933.2813460702264;2935.66239882412;2936.985315073411;2942.3232656489126;2945.8527073646233;5654.6146194181865;5655.660660360391;5661.858453538612;5699.544036477072;5721.342045664802;5269.4730526947;5546.308375945376;5550.47270509301;5555.194561767442;5585.525230355384;5601.551875849922;5644.971775141098;5659.915101273484;5662.631928924607;5669.242534814139;5286.577073834161;5445.346558413015;5463.289772329572;5465.672059676433;5470.085470085597;5442.482964118402;5450.264214331015;5454.618176727591;5458.91811622818;5459.771551400903;5672.574556908331;5684.886302274014;5686.715664216856;5703.600747947604;5714.857128571819;3972.801359931934;3979.144483935968;4073.857414990461;4401.163778882003;4438.822447102209;6188.44304012641;6245.594741183198;6275.5920865145445;6284.214473190851;6298.149749783904;6119.9596068669325;6146.754129834935;6152.600485810448;6155.569110162246;6163.660998645118;6027.909581356371;6071.969640151948;6123.775244950939;6155.753769849156;6183.536234782319;5975.223220981418;6018.638881667114;6063.787767428119;6064.48451881595;6124.816255512342;6115.266168059683;6152.200213972155;6162.476189523762;6186.659733714689;6188.628682279078;5886.882262354643;5996.730147143477;5999.1901093351835;6036.366181550874;6043.697815109315 17:22:43 INFO - PROCESS | 7666 | |5;yui.html;830.8451252758666;830.8629076202427;889.7731078574964;902.1294450854924;903.3134817538669;16961.575960600992;17531.82468175318;17789.37737179199;17890.37383691571;17922.551936201602;16186.109763962977;16345.18274086294;16378.26297816601;16417.67164656706;16445.588860278498;734.1337222077946;872.3762509805488;894.1594900793234;897.7935074932769;900.4732231644496;876.51791514667;888.9733308000771;894.2398960883262;896.4218079338823;898.9460632362046;946.4179529589287;954.3033585482567;954.9809003819919;955.961761529538;957.3729207369184;941.4868896451451;945.9858102128474;948.9430634161938;949.0793929887998;951.0584521323909;696.3176087434292;697.469922858626;699.4020112803581;701.0570782297801;702.0907924238124;15930.442434514736;16232.513024609281;16319.347226110942;16325.918370408192;16372.508824735278;14202.289885505683;14602.12387256768;14791.852081479155;14957.252137393087;15096.849031509653;13912.37394317258;14033.1580105194;14062.306622244481;14088.506902258474;14324.856751432457;4885.633577481668;4970.975145124287;4977.676451030671;4982.327385802906;5004.499550045003;83399.16600834035;85520.57239713761;86178;87846.56076719704;89173.55413222892;12022.819657705142;12351.38243087842;12609.054320925967;12633.305168215653;12777.16948398351;21765.673514897288;22502.21242256513;22633.660495092587;22636;22666.43333916665;9390.577424015935;9727.173190278905;9861.704148875546;9868.062534059252;9960.501974901372;5349.090654588651;5362.088444964287;5395.514403703685;5414.3232095988005;5442.482964118402;3977.244323578511;4097.672186225154;4112.09533902541;4123.9381409278885;4138.399932009842;662.8972509261072;668.9331066893271;673.1081317254657;680.3944489404435;692.6952141057918;678.9015592739025;791.6041979010495;810.7324582887633;817.6974519427849;823.5347028928755;10825.296355736851;11182.217244792786;11308.604198853001;11676.124290678234;11825.940870295766;748.4835463530147;823.8393513264856;831.3432388413207;849.7280870121501;855.8673405622138;5043.52086551777;5269.288646032813;5281.735913204325;5291.603129765283;5354.946450535523;77828;78391.21608783954;79254.60372698099;85958;108214;63458.36541634617;65165.67417162884;65895;94541.5272923631;100751.49624251979;89442.55278723694;90053;92535.61196582057;94309;99577.50211248898;10503.47482625881;10507.211959102944;10574.8413773795;10839.837402438812;11468.197226194086;51092.74453627708;52501.47498524966;54515;54607.453925460235;57226.7138664304;69970;70377;78208;82104;82176;14202.28988550589;14313.92645551567;14458.855411445751;14503.419863205776;14729.26353682333;15961.361545538048;16140.031598104151;16282.348706051625;16780.832191677928;17464.73802892932;15632.140232287333;15663.843361566238;15798.7630185545;16059.919700401424;16137.112458814878;15018.549443516711;15291.311890964711;15710.528684139494;15949.282282297092;16761.832381676028;14361.21013344276;14599.197044162673;14850.331735071732;15152.848471515585;15472.226388680296;12337.568185113478;12461.75076498483;13006.089573729749;13165.53920612774;13462.865371346554;11459.942700286445;11720.648380548597;12576.11358296263;12695.619131426072;12937.935310323388 17:22:43 INFO - PROCESS | 7666 | __end_tp_report 17:22:43 INFO - PROCESS | 7666 | __start_cc_report 17:22:43 INFO - PROCESS | 7666 | _x_x_mozilla_cycle_collect,359 17:22:43 INFO - PROCESS | 7666 | __end_cc_report 17:22:43 INFO - PROCESS | 7666 | __startTimestamp1475540563116__endTimestamp 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | ------- Summary: start ------- 17:22:43 INFO - PROCESS | 7666 | Number of tests: 6 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | [#0] dojo.html Cycles:165 Average:5680.49 Median:5883.44 stddev:640.69 (10.9%) stddev-sans-first:613.39 17:22:43 INFO - PROCESS | 7666 | Values: 3240.3 3271.4 3277.9 3297.4 3303.5 5692.2 5717.9 5730.6 5765.7 5769.3 5665.1 5744.4 5759.0 5771.1 5772.4 5175.5 5193.8 5215.5 5238.6 5275.9 5251.7 5254.2 5270.9 5280.3 5287.7 5119.4 5146.1 5236.1 5246.6 5283.9 5125.4 5210.8 5231.8 5250.8 5339.3 5176.1 5254.7 5268.7 5269.9 5282.8 5740.5 5741.2 5794.7 5833.7 5878.7 5845.9 5962.9 5980.9 5981.2 6115.5 6112.6 6115.5 6119.5 6122.8 6126.5 5679.2 5685.6 5688.8 5690.1 5692.0 6083.5 6126.2 6151.5 6168.9 6299.7 5983.9 6004.4 6019.8 6024.0 6051.9 6052.2 6104.8 6123.0 6125.4 6138.1 5944.1 6021.8 6054.1 6074.5 6127.6 6068.0 6068.8 6098.0 6127.3 6127.6 4678.5 4686.9 4688.7 4694.9 4708.4 4054.3 4091.5 4109.8 4158.4 4216.1 5824.1 5883.4 5885.0 5889.0 5893.6 6111.3 6166.1 6169.3 6172.2 6180.4 5711.1 5721.5 5802.3 5810.3 5871.0 5288.2 5295.3 5298.4 5299.4 5300.4 6226.1 6297.1 6302.0 6370.5 6374.0 6094.9 6116.3 6124.5 6194.6 6201.9 6318.3 6320.5 6321.3 6324.1 6330.0 5875.1 6066.7 6074.3 6074.4 6085.8 6072.8 6075.9 6098.9 6143.5 6167.1 5980.1 5991.5 5997.1 6003.7 6036.9 5891.3 5960.0 5985.0 5992.9 5994.4 5787.2 5825.1 5854.5 5879.3 5943.4 5909.4 5979.9 5996.8 6005.6 6019.8 5758.6 5838.9 5862.4 5867.2 5867.6 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | [#1] ext.html Cycles:180 Average:68300.12 Median:45998.54 stddev:141244.11 (307.1%) stddev-sans-first:141548.85 17:22:43 INFO - PROCESS | 7666 | Values: 592.4 622.5 650.9 652.9 699.9 41980.8 45371.8 45929.3 45966.8 46085.8 46030.3 47054.8 47069.0 47099.8 47110.3 9079.1 9137.4 9186.8 9235.6 9239.1 9101.2 9167.1 9198.3 9214.2 9214.9 9272.0 9344.6 9347.3 9350.5 9361.0 9150.4 9158.4 9187.4 9253.7 9257.9 9079.9 9176.2 9210.6 9218.2 9223.5 43424.3 43879.6 43933.8 43995.0 43997.0 3877.7 3935.7 4025.6 4118.5 4625.4 34046.7 34077.0 34408.0 34442.1 35660.6 4820.4 4825.4 4836.8 4857.4 4918.0 395262.0 397574.0 398070.0 398654.0 400145.0 61523.7 61865.7 61916.7 61934.4 62134.4 40817.4 41554.4 41651.0 43245.8 65338.0 16971.5 16971.6 16985.8 17124.1 17153.4 12590.4 12594.1 12601.1 12642.7 12647.1 21146.2 21174.7 21266.8 21415.4 21451.8 7638.5 7744.8 7776.6 7799.5 7816.4 1032.7 1065.5 1106.0 1107.9 1149.5 33734.3 33832.8 34432.5 35042.3 35253.4 1173.1 1173.2 1191.1 1234.4 1251.7 17526.2 17624.4 17630.6 17660.5 17817.5 631538.0 634121.0 637639.0 640059.0 640680.0 61255.7 61991.0 62100.7 62204.4 62211.0 1440.9 1442.8 1457.9 1471.3 1472.5 31212.2 32944.7 33086.5 33143.7 33741.8 54920.2 55641.4 55716.0 55855.0 56087.4 526936.0 528190.0 529170.0 530628.0 535779.0 29960.1 30308.2 30347.4 30444.4 30637.0 49995.0 50355.7 51017.7 53098.0 53875.2 44901.6 45404.4 47016.0 47739.3 47912.8 47205.0 47252.8 47888.0 48256.8 48276.8 44732.3 45567.3 46478.0 46519.3 46756.8 40636.6 40758.6 41118.8 41141.6 41189.0 30952.4 31070.2 31105.5 31159.0 31581.7 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | [#2] jquery.html Cycles:180 Average:28069.11 Median:24734.32 stddev:74041.10 (299.3%) stddev-sans-first:74219.66 17:22:43 INFO - PROCESS | 7666 | Values: 403.3 406.6 419.1 422.5 437.3 19146.5 19943.1 20735.9 20829.5 21070.0 20195.7 20258.5 20425.4 20857.3 20918.0 5813.6 6048.4 6052.4 6062.9 6065.7 5832.8 5929.3 5929.4 5971.2 6006.6 5914.4 5919.4 5925.6 5926.2 5953.5 5855.5 5879.7 5914.9 5926.1 5939.1 5116.1 5259.9 5263.5 5264.7 5274.8 24133.6 24562.5 24714.0 24754.6 24965.0 2533.9 2554.5 2567.0 2628.6 3082.5 15739.9 15879.8 15992.6 15996.2 16044.7 2017.5 2040.6 2050.4 2071.3 2087.3 83548.6 84502.2 84510.0 84629.0 85606.6 10693.3 10910.5 10978.5 11052.5 11086.6 15234.0 15243.9 15253.5 15272.0 15326.9 8279.7 8405.3 8577.7 8579.6 8701.6 8231.8 8322.8 8341.5 8401.3 8448.6 6759.6 6760.6 6790.0 6795.5 6904.1 1791.5 1951.8 2016.7 2051.3 2088.5 1010.0 1039.7 1070.7 1116.3 1147.1 21277.8 21278.8 21406.8 21508.7 21772.0 1055.0 1069.0 1071.7 1074.5 1101.6 11670.5 11752.5 12095.7 12127.6 12199.7 431272.0 436556.0 439351.0 458608.0 476287.0 81603.0 83361.6 84653.6 86111.0 86146.6 1125.6 1130.0 1133.7 1150.4 1162.5 17984.3 18463.9 18595.2 18802.9 19153.7 40083.8 40836.4 40917.0 42608.4 43037.4 54541.5 55633.0 56010.4 56174.4 56859.4 8279.2 8466.2 8585.2 8612.1 8724.4 11534.9 11555.7 11646.4 11918.3 12235.4 9642.1 9994.1 11078.3 11344.8 11377.9 10342.9 10390.6 10419.8 10443.2 10474.5 10937.3 11154.1 11290.8 11346.2 11429.0 8185.0 8213.7 8266.1 8470.0 8508.7 11172.4 11712.6 12244.0 12493.8 12772.9 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | [#3] mootools.html Cycles:180 Average:6081.90 Median:4629.38 stddev:3459.59 (74.7%) stddev-sans-first:3450.91 17:22:43 INFO - PROCESS | 7666 | Values: 1336.3 1420.3 1488.2 1776.2 1798.6 8353.3 8910.2 8991.1 9606.9 9609.9 9174.2 9394.8 9416.1 9445.2 9473.1 2449.5 2470.6 2487.7 2498.3 2504.1 2398.9 2530.1 2533.5 2547.1 2550.8 2457.4 2467.5 2531.4 2532.6 2535.3 2394.9 2395.0 2402.8 2456.9 2457.9 2383.3 2396.7 2397.9 2398.0 2409.7 9380.4 9516.8 9531.3 9544.3 9549.3 5389.4 5522.9 5526.6 5529.0 5533.0 3352.5 3386.6 3445.9 3463.5 3484.1 1055.9 1071.7 1102.2 1105.2 1123.2 12738.2 12763.9 12778.2 12783.0 12808.3 4524.3 4636.7 4774.0 4806.3 4808.2 10787.4 10809.7 10877.0 10881.7 10893.6 5549.9 5563.7 5572.7 5582.0 5591.7 4551.7 4990.2 5101.4 5107.8 5113.3 4254.3 4308.5 4333.8 4374.1 4394.6 1354.1 1373.3 1388.2 1398.3 1403.2 900.2 947.7 950.6 979.2 1052.2 6147.7 6341.3 6444.1 6495.4 6528.8 999.5 1000.9 1010.4 1038.8 1070.0 4445.3 4587.1 4612.0 4622.1 4661.2 11355.5 11385.0 11611.7 11671.3 11687.8 11439.2 11553.5 11567.5 11570.0 11586.3 8029.2 8340.2 8377.5 8551.7 8615.8 6550.6 6682.6 6766.1 6770.7 6837.2 10647.3 10774.4 10836.8 11002.7 11041.6 10860.2 10869.4 10949.7 11026.4 11061.9 7508.5 7779.7 7935.1 8317.5 8465.0 8551.8 8569.6 8572.2 8582.3 8597.6 7274.8 7386.6 7401.1 7531.7 7641.2 7385.9 7602.5 7708.1 7730.1 7754.1 6933.7 6979.6 7040.8 7054.2 7068.9 5287.4 5313.2 5314.7 5315.7 5457.6 5437.9 5441.3 5500.2 5518.5 5555.9 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | [#4] prototype.html Cycles:180 Average:4932.95 Median:5473.76 stddev:1427.94 (26.1%) stddev-sans-first:1389.69 17:22:43 INFO - PROCESS | 7666 | Values: 338.5 355.0 355.8 356.0 359.2 5666.0 5749.9 5856.6 5916.0 5935.2 5746.0 5783.7 5784.9 5785.3 5793.5 4537.7 4544.5 4548.5 4565.0 4584.6 4446.0 4517.2 4525.7 4552.2 4554.9 4496.6 4503.7 4503.7 4514.8 4515.6 4524.9 4527.9 4534.6 4548.6 4565.7 3856.9 3973.3 4015.7 4019.8 4030.7 5667.0 5677.6 5678.5 5710.4 5713.7 5199.8 5204.9 5215.9 5216.8 5219.6 5862.3 6040.0 6080.8 6089.8 6115.6 4404.8 4412.5 4412.7 4414.3 4423.6 6183.2 6345.8 6349.3 6356.7 6360.2 4435.4 4483.3 4493.7 4527.5 4534.0 4530.9 4546.9 4561.9 4568.0 4587.2 5176.7 5187.2 5197.2 5205.8 5209.2 5835.7 5885.9 6077.0 6100.4 6116.1 1517.4 1546.5 1548.7 1551.6 1551.7 932.2 961.6 969.8 980.7 981.3 5164.3 5170.2 5201.9 5204.2 5207.8 5477.4 5495.5 5495.8 5508.3 5532.3 5015.9 5186.6 5193.2 5214.3 5248.8 2933.3 2935.7 2937.0 2942.3 2945.9 5654.6 5655.7 5661.9 5699.5 5721.3 5269.5 5546.3 5550.5 5555.2 5585.5 5601.6 5645.0 5659.9 5662.6 5669.2 5286.6 5445.3 5463.3 5465.7 5470.1 5442.5 5450.3 5454.6 5458.9 5459.8 5672.6 5684.9 5686.7 5703.6 5714.9 3972.8 3979.1 4073.9 4401.2 4438.8 6188.4 6245.6 6275.6 6284.2 6298.1 6120.0 6146.8 6152.6 6155.6 6163.7 6027.9 6072.0 6123.8 6155.8 6183.5 5975.2 6018.6 6063.8 6064.5 6124.8 6115.3 6152.2 6162.5 6186.7 6188.6 5886.9 5996.7 5999.2 6036.4 6043.7 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - PROCESS | 7666 | [#5] yui.html Cycles:180 Average:20825.71 Median:4993.41 stddev:27516.93 (551.1%) stddev-sans-first:27553.16 17:22:43 INFO - PROCESS | 7666 | Values: 830.8 830.9 889.8 902.1 903.3 16961.6 17531.8 17789.4 17890.4 17922.6 16186.1 16345.2 16378.3 16417.7 16445.6 734.1 872.4 894.2 897.8 900.5 876.5 889.0 894.2 896.4 898.9 946.4 954.3 955.0 956.0 957.4 941.5 946.0 948.9 949.1 951.1 696.3 697.5 699.4 701.1 702.1 15930.4 16232.5 16319.3 16325.9 16372.5 14202.3 14602.1 14791.9 14957.3 15096.8 13912.4 14033.2 14062.3 14088.5 14324.9 4885.6 4971.0 4977.7 4982.3 5004.5 83399.2 85520.6 86178.0 87846.6 89173.6 12022.8 12351.4 12609.1 12633.3 12777.2 21765.7 22502.2 22633.7 22636.0 22666.4 9390.6 9727.2 9861.7 9868.1 9960.5 5349.1 5362.1 5395.5 5414.3 5442.5 3977.2 4097.7 4112.1 4123.9 4138.4 662.9 668.9 673.1 680.4 692.7 678.9 791.6 810.7 817.7 823.5 10825.3 11182.2 11308.6 11676.1 11825.9 748.5 823.8 831.3 849.7 855.9 5043.5 5269.3 5281.7 5291.6 5354.9 77828.0 78391.2 79254.6 85958.0 108214.0 63458.4 65165.7 65895.0 94541.5 100751.5 89442.6 90053.0 92535.6 94309.0 99577.5 10503.5 10507.2 10574.8 10839.8 11468.2 51092.7 52501.5 54515.0 54607.5 57226.7 69970.0 70377.0 78208.0 82104.0 82176.0 14202.3 14313.9 14458.9 14503.4 14729.3 15961.4 16140.0 16282.3 16780.8 17464.7 15632.1 15663.8 15798.8 16059.9 16137.1 15018.5 15291.3 15710.5 15949.3 16761.8 14361.2 14599.2 14850.3 15152.8 15472.2 12337.6 12461.8 13006.1 13165.5 13462.9 11459.9 11720.6 12576.1 12695.6 12937.9 17:22:43 INFO - PROCESS | 7666 | -------- Summary: end -------- 17:22:43 INFO - PROCESS | 7666 | 17:22:43 INFO - TEST-INFO | 7666: exit 0 17:22:43 INFO - TEST-OK | dromaeo_css | took 1110040ms 17:22:43 INFO - TEST-START | kraken 17:22:43 INFO - operating with platform_type : linux_ 17:22:43 INFO - Initialising browser for kraken test... 17:22:43 INFO - TEST-INFO | started process 7907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIkdGae/profile http://localhost:47003/getInfo.html) 17:22:47 INFO - PROCESS | 7907 | __metrics Screen width/height:1600/1200 17:22:47 INFO - PROCESS | 7907 | colorDepth:24 17:22:47 INFO - PROCESS | 7907 | Browser inner width/height: 1024/697 17:22:47 INFO - PROCESS | 7907 | __metrics 17:22:48 ERROR - PROCESS | 7907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:22:49 INFO - TEST-INFO | 7907: exit 0 17:22:49 INFO - Browser initialized. 17:22:49 INFO - Running cycle 1/1 for kraken test... 17:22:49 INFO - TEST-INFO | started process 8032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIkdGae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:01 INFO - PROCESS | 8032 | RSS: Main: 149602304 17:23:01 INFO - PROCESS | 8032 | 17:23:03 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47003/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:04 INFO - PROCESS | 8032 | RSS: Main: 156692480 17:23:04 INFO - PROCESS | 8032 | 17:23:07 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47003/tests/kraken/driver.html?testName=audio-dft) 17:23:07 INFO - PROCESS | 8032 | RSS: Main: 154832896 17:23:07 INFO - PROCESS | 8032 | 17:23:10 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47003/tests/kraken/driver.html?testName=audio-fft) 17:23:11 INFO - PROCESS | 8032 | RSS: Main: 156012544 17:23:11 INFO - PROCESS | 8032 | 17:23:13 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47003/tests/kraken/driver.html?testName=audio-oscillator) 17:23:13 INFO - PROCESS | 8032 | RSS: Main: 155828224 17:23:13 INFO - PROCESS | 8032 | 17:23:16 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47003/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:16 INFO - PROCESS | 8032 | RSS: Main: 155295744 17:23:16 INFO - PROCESS | 8032 | 17:23:19 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47003/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:20 INFO - PROCESS | 8032 | RSS: Main: 155480064 17:23:20 INFO - PROCESS | 8032 | 17:23:23 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47003/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:24 INFO - PROCESS | 8032 | RSS: Main: 156499968 17:23:24 INFO - PROCESS | 8032 | 17:23:27 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47003/tests/kraken/driver.html?testName=json-parse-financial) 17:23:27 INFO - PROCESS | 8032 | RSS: Main: 156037120 17:23:27 INFO - PROCESS | 8032 | 17:23:29 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47003/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:23:29 INFO - PROCESS | 8032 | RSS: Main: 155049984 17:23:29 INFO - PROCESS | 8032 | 17:23:31 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:23:32 INFO - PROCESS | 8032 | RSS: Main: 154836992 17:23:32 INFO - PROCESS | 8032 | 17:23:34 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:23:34 INFO - PROCESS | 8032 | RSS: Main: 155045888 17:23:34 INFO - PROCESS | 8032 | 17:23:37 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:23:38 INFO - PROCESS | 8032 | RSS: Main: 155590656 17:23:38 INFO - PROCESS | 8032 | 17:23:40 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:23:41 INFO - PROCESS | 8032 | RSS: Main: 155963392 17:23:41 INFO - PROCESS | 8032 | 17:23:42 INFO - PROCESS | 8032 | Cycle 1(1): loaded http://localhost:47003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47003/tests/kraken/driver.html?testName=ai-astar) 17:23:43 INFO - PROCESS | 8032 | RSS: Main: 158482432 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | __start_tp_report 17:23:43 INFO - PROCESS | 8032 | _x_x_mozilla_page_load 17:23:43 INFO - PROCESS | 8032 | _x_x_mozilla_page_load_details 17:23:43 INFO - PROCESS | 8032 | |i|pagename|runs| 17:23:43 INFO - PROCESS | 8032 | |0;ai-astar;101;112;107;112;113;112;110;111;110;110 17:23:43 INFO - PROCESS | 8032 | |1;audio-beat-detection;140;116;150;168;117;150;141;116;178;116 17:23:43 INFO - PROCESS | 8032 | |2;audio-dft;163;161;165;163;163;161;163;161;164;162 17:23:43 INFO - PROCESS | 8032 | |3;audio-fft;75;77;76;176;77;74;75;79;165;75 17:23:43 INFO - PROCESS | 8032 | |4;audio-oscillator;83;82;153;87;83;84;140;83;83;142 17:23:43 INFO - PROCESS | 8032 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;118;117;118 17:23:43 INFO - PROCESS | 8032 | |6;imaging-darkroom;146;147;149;146;147;146;148;146;148;147 17:23:43 INFO - PROCESS | 8032 | |7;imaging-desaturate;96;95;94;98;94;95;95;95;95;95 17:23:43 INFO - PROCESS | 8032 | |8;json-parse-financial;51;51;50;51;52;51;54;52;51;52 17:23:43 INFO - PROCESS | 8032 | |9;json-stringify-tinderbox;59;64;60;61;60;59;59;60;60;60 17:23:43 INFO - PROCESS | 8032 | |10;stanford-crypto-aes;73;72;73;77;71;72;72;73;77;82 17:23:43 INFO - PROCESS | 8032 | |11;stanford-crypto-ccm;128;131;115;128;127;119;118;128;161;119 17:23:43 INFO - PROCESS | 8032 | |12;stanford-crypto-pbkdf2;150;149;153;150;151;152;150;147;154;149 17:23:43 INFO - PROCESS | 8032 | |13;stanford-crypto-sha256-iterative;68;63;65;61;60;60;61;61;60;59 17:23:43 INFO - PROCESS | 8032 | __end_tp_report 17:23:43 INFO - PROCESS | 8032 | __start_cc_report 17:23:43 INFO - PROCESS | 8032 | _x_x_mozilla_cycle_collect,873 17:23:43 INFO - PROCESS | 8032 | __end_cc_report 17:23:43 INFO - PROCESS | 8032 | __startTimestamp1475540623208__endTimestamp 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | ------- Summary: start ------- 17:23:43 INFO - PROCESS | 8032 | Number of tests: 14 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:3.52 (3.2%) stddev-sans-first:1.79 17:23:43 INFO - PROCESS | 8032 | Values: 101.0 112.0 107.0 112.0 113.0 112.0 110.0 111.0 110.0 110.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:145.50 stddev:22.80 (15.7%) stddev-sans-first:24.18 17:23:43 INFO - PROCESS | 8032 | Values: 140.0 116.0 150.0 168.0 117.0 150.0 141.0 116.0 178.0 116.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 17:23:43 INFO - PROCESS | 8032 | Values: 163.0 161.0 165.0 163.0 163.0 161.0 163.0 161.0 164.0 162.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:39.95 (52.9%) stddev-sans-first:41.72 17:23:43 INFO - PROCESS | 8032 | Values: 75.0 77.0 76.0 176.0 77.0 74.0 75.0 79.0 165.0 75.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.00 stddev:29.88 (36.0%) stddev-sans-first:30.90 17:23:43 INFO - PROCESS | 8032 | Values: 83.0 82.0 153.0 87.0 83.0 84.0 140.0 83.0 83.0 142.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:23:43 INFO - PROCESS | 8032 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 17:23:43 INFO - PROCESS | 8032 | Values: 146.0 147.0 149.0 146.0 147.0 146.0 148.0 146.0 148.0 147.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.14 (1.2%) stddev-sans-first:1.17 17:23:43 INFO - PROCESS | 8032 | Values: 96.0 95.0 94.0 98.0 94.0 95.0 95.0 95.0 95.0 95.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.08 (2.1%) stddev-sans-first:1.13 17:23:43 INFO - PROCESS | 8032 | Values: 51.0 51.0 50.0 51.0 52.0 51.0 54.0 52.0 51.0 52.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.48 (2.5%) stddev-sans-first:1.50 17:23:43 INFO - PROCESS | 8032 | Values: 59.0 64.0 60.0 61.0 60.0 59.0 59.0 60.0 60.0 60.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:73.00 stddev:3.43 (4.7%) stddev-sans-first:3.61 17:23:43 INFO - PROCESS | 8032 | Values: 73.0 72.0 73.0 77.0 71.0 72.0 72.0 73.0 77.0 82.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.00 stddev:13.02 (10.2%) stddev-sans-first:13.81 17:23:43 INFO - PROCESS | 8032 | Values: 128.0 131.0 115.0 128.0 127.0 119.0 118.0 128.0 161.0 119.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:150.50 stddev:2.07 (1.4%) stddev-sans-first:2.19 17:23:43 INFO - PROCESS | 8032 | Values: 150.0 149.0 153.0 150.0 151.0 152.0 150.0 147.0 154.0 149.0 17:23:43 INFO - PROCESS | 8032 | 17:23:43 INFO - PROCESS | 8032 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:61.00 stddev:2.78 (4.6%) stddev-sans-first:1.83 17:23:43 INFO - PROCESS | 8032 | Values: 68.0 63.0 65.0 61.0 60.0 60.0 61.0 61.0 60.0 59.0 17:23:43 INFO - PROCESS | 8032 | -------- Summary: end -------- 17:23:43 INFO - PROCESS | 8032 | 17:23:44 INFO - TEST-INFO | 8032: exit 0 17:23:44 INFO - TEST-OK | kraken | took 60374ms 17:23:44 INFO - SUITE-END | took 1170s 17:23:44 INFO - Completed test suite (00:19:30) 17:23:44 INFO - javascript benchmark 17:23:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7710.122021812382, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.2871368298975, 3271.4111459937208, 3277.8688852445916, 3297.4394352959994, 3303.487959366299, 5692.231548740919, 5717.914231286529, 5730.627509211909, 5765.7117144142785, 5769.3076830780265, 5665.065264231397, 5744.368119506861, 5758.971205143979, 5771.134329850524, 5772.365039845614, 5175.456577059411, 5193.844184674447, 5215.530602245816, 5238.607104467161, 5275.894482110355, 5251.737413129347, 5254.159334506479, 5270.947290527103, 5280.260763493114, 5287.682739035651, 5119.360079990001, 5146.125158723007, 5236.083685355066, 5246.580273578104, 5283.920741188886, 5125.359330083758, 5210.817621383271, 5231.816886408977, 5250.789968401259, 5339.279197308352, 5176.0683077046115, 5254.65844720092, 5268.736563171826, 5269.86825329366, 5282.81510147143, 5740.512056475204, 5741.167530708066, 5794.7392367343145, 5833.7374818133285, 5878.706064696748, 5845.941540584582, 5962.940370596325, 5980.940190598082, 5981.162637230791, 6115.541334399938, 6112.63324200545, 6115.48018418435, 6119.479844213247, 6122.816315510498, 6126.479249263818, 5679.233303504016, 5685.573581981368, 5688.772449102031, 5690.146478028288, 5692.003899317603, 6083.513318934474, 6126.181801870944, 6151.507879369639, 6168.938310616836, 6299.716512756937, 5983.910241346383, 6004.42957918997, 6019.759209631653, 6024.0, 6051.909221361683, 6052.243469566304, 6104.786332478342, 6122.969385153046, 6125.387461253839, 6138.14066030756, 5944.138099975479, 6021.849453763691, 6054.06162044875, 6074.54440916933, 6127.556056270658, 6067.9684453642985, 6068.787592434243, 6098.024316109401, 6127.34224287047, 6127.601705889103, 4678.461976872703, 4686.929696054562, 4688.695234809727, 4694.88262793426, 4708.411448568929, 4054.2904991626347, 4091.5499295077516, 4109.815058322323, 4158.397032430341, 4216.093539888939, 5824.126381042793, 5883.441073098049, 5885.0, 5889.0283103287475, 5893.5579831512805, 6111.327753947062, 6166.105914642441, 6169.290531588835, 6172.197614310111, 6180.381961803873, 5711.057675483498, 5721.5136713379, 5802.274715660543, 5810.302763668386, 5871.031279838779, 5288.206768984606, 5295.285136506523, 5298.417174110845, 5299.364076310867, 5300.44345343741, 6226.128342032119, 6297.055441683784, 6301.96849015752, 6370.522210834113, 6373.968130159412, 6094.9085763714465, 6116.305337586134, 6124.5406594506485, 6194.628322300677, 6201.937980620317, 6318.336574659595, 6320.462760665395, 6321.304656487875, 6324.146240257506, 6330.01884707871, 5875.089361149029, 6066.666333351708, 6074.331823499323, 6074.36219196978, 6085.847853803513, 6072.787452439144, 6075.939240607714, 6098.9390106100145, 6143.508519318354, 6167.105769663284, 5980.102984552178, 5991.520678345809, 5997.100434934795, 6003.669798161143, 6036.909446358396, 5891.293044834647, 5960.0, 5985.0, 5992.8801423972145, 5994.400559943971, 5787.218725472176, 5825.097109947965, 5854.531637468907, 5879.323877754113, 5943.375945525658, 5909.3795151508475, 5979.850503737267, 5996.790112346047, 6005.6396616203165, 6019.849503762441, 5758.62568933018, 5838.912416313844, 5862.384449632727, 5867.20792692981, 5867.647941123546], "value": 5636.905689607856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.4253474130095, 622.4771192198554, 650.9186351706034, 652.892272774992, 699.9370056694896, 41980.79009604952, 45371.77314113425, 45929.31106033404, 45966.77016614917, 46085.847853803716, 46030.309545356846, 47054.76472617641, 47069.0, 47099.764501177444, 47110.29334559984, 9079.137481939206, 9137.360384773068, 9186.770330741718, 9235.630574777, 9239.076092390775, 9101.180893719564, 9167.083291670813, 9198.310126740487, 9214.216791572724, 9214.907850921505, 9271.95364023179, 9344.579493922756, 9347.345685801996, 9350.532473376337, 9360.953195234048, 9150.359474836763, 9158.404703694305, 9187.356885018018, 9253.72238832836, 9257.861132083024, 9079.909200907972, 9176.174144327042, 9210.585523651453, 9218.216451601622, 9223.492707901063, 43424.348634770504, 43879.561204387865, 43933.78033109814, 43995.0, 43997.0, 3877.689784817208, 3935.685145188378, 4025.63769260765, 4118.5263694675195, 4625.421822272216, 34046.6595334046, 34077.0, 34408.0, 34442.138946526284, 35660.643393565995, 4820.4456487503685, 4825.445073816521, 4836.782344794493, 4857.368542089541, 4918.0, 395262.0, 397574.0, 398070.0, 398654.0, 400145.0, 61523.6923815378, 61865.690671546356, 61916.69041654853, 61934.38065619286, 62134.37865621376, 40817.387739183934, 41554.37668434976, 41651.0, 43245.78377108157, 65338.0, 16971.490855274362, 16971.575710607332, 16985.830141698672, 17124.14379281031, 17153.399631012853, 12590.43343049565, 12594.055445841599, 12601.117921745574, 12642.683932901751, 12647.114701970773, 21146.15415383398, 21174.682379764316, 21266.78733212648, 21415.357539273846, 21451.78548214498, 7638.469712010838, 7744.845103097907, 7776.611169441505, 7799.49303295284, 7816.41376896735, 1032.6695457453543, 1065.5311662868469, 1106.004595863729, 1107.8725946516254, 1149.5114576305036, 33734.325313493595, 33832.83083584616, 34432.45783301165, 35042.29915401729, 35253.417055782586, 1173.143605168232, 1173.1904985559936, 1191.124523475245, 1234.4321612058554, 1251.6870782304425, 17526.21132049061, 17624.383146589807, 17630.647387052442, 17660.470185894443, 17817.46547603574, 631538.0, 634121.0, 637639.0, 640059.0, 640680.0, 61255.693721532, 61991.0, 62100.68949655223, 62204.377956220764, 62211.0, 1440.9135451872921, 1442.8124343835234, 1457.8760805331453, 1471.3158381352937, 1472.4919902633574, 31212.219694507818, 32944.67055329512, 33086.50370244496, 33143.66856331406, 33741.83129084339, 54920.176197356275, 55641.44358556525, 55716.0, 55855.0, 56087.43912560985, 526936.0, 528190.0, 529170.0, 530628.0, 535779.0, 29960.101196964126, 30308.242293941945, 30347.39305213839, 30444.391112178077, 30637.0, 49995.0, 50355.74822125866, 51017.74491127521, 53098.0, 53875.191872122734, 44901.55098448974, 45404.44921465469, 47016.0, 47739.28391074067, 47912.7604361976, 47205.0, 47252.763736182475, 47888.0, 48256.7587162062, 48276.758616206695, 44732.32901506415, 45567.31649025334, 46478.0, 46519.30221046755, 46756.766216168704, 40636.59363406328, 40758.59241407548, 41118.79440602778, 41141.58858411378, 41189.0, 30952.380952381278, 31070.22324441907, 31105.53341699831, 31158.997381219604, 31581.684183157875], "value": 21555.441831234515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.33047141744726, 406.6015305001097, 419.119848318531, 422.4740198452927, 437.3199674506142, 19146.521336966565, 19943.1025603848, 20735.896320518394, 20829.479263018395, 21069.99999999996, 20195.697064544045, 20258.49353766153, 20425.38723838287, 20857.26999555016, 20918.0, 5813.563982701293, 6048.425399587032, 6052.364501727321, 6062.9090563641585, 6065.666388348639, 5832.825015249549, 5929.347771745104, 5929.377415371388, 5971.193888825018, 6006.579539432241, 5914.378990206031, 5919.408059194089, 5925.585209035369, 5926.229590153295, 5953.464188223059, 5855.502282305988, 5879.706014699269, 5914.940850591482, 5926.140709597106, 5939.109133629947, 5116.104681680691, 5259.947400525984, 5263.526282634582, 5264.684118952875, 5274.7626356814035, 24133.637995430083, 24562.508749825083, 24714.011439542395, 24754.628680569807, 24965.0, 2533.923982280516, 2554.5018721349343, 2567.0, 2628.5531459651716, 3082.475979083561, 15739.921300393426, 15879.761803572956, 15992.600184995352, 15996.200189990454, 16044.679106417807, 2017.5258814178655, 2040.6122836660986, 2050.3848845346483, 2071.2854065347433, 2087.321620473352, 83548.58225708893, 84502.15497845004, 84510.0, 84629.0, 85606.57196713977, 10693.304935179189, 10910.498959982848, 10978.505967231495, 11052.502637381338, 11086.611968581223, 15234.0, 15243.923780381027, 15253.542393728207, 15272.0, 15326.923365383325, 8279.710210142737, 8405.327573794082, 8577.699780507652, 8579.571021448903, 8701.608427620773, 8231.835363292701, 8322.833543329221, 8341.499510029418, 8401.285890699237, 8448.577571121543, 6759.5606285591275, 6760.594364338155, 6789.966050169717, 6795.490338224653, 6904.067950826675, 1791.5073354827528, 1951.8243358097839, 2016.747906511686, 2051.302557130553, 2088.5196404826975, 1009.9848502272472, 1039.6744151207272, 1070.7430216747925, 1116.330201878866, 1147.0937959012454, 21277.78722212758, 21278.78721212799, 21406.78593214048, 21508.677369839465, 21772.0, 1054.9683509494728, 1068.9732756681144, 1071.6677829872765, 1074.5272080284649, 1101.64196636092, 11670.474828632561, 11752.471138798775, 12095.697607559881, 12127.636170914886, 12199.69500762488, 431272.0, 436556.0, 439351.0, 458608.0, 476287.0, 81603.0, 83361.58319208486, 84653.57673211595, 86111.0, 86146.56926715451, 1125.6172901213627, 1130.0451118804597, 1133.699569614053, 1150.4017910686396, 1162.5059349776311, 17984.280628775225, 18463.90768046151, 18595.16321765551, 18802.905985469984, 19153.712694309874, 40083.79958100308, 40836.38745418881, 40917.0, 42608.360874587524, 43037.3544396828, 54541.45458545364, 55633.0, 56010.439895602154, 56174.43825561692, 56859.43140568707, 8279.172082791914, 8466.195711407407, 8585.227329540372, 8612.138786121588, 8724.389292749447, 11534.884651153718, 11555.711107222387, 11646.417679116179, 11918.344491053076, 12235.388230588613, 9642.132208101304, 9994.10053095225, 11078.279911805706, 11344.829827552428, 11377.886221138015, 10342.896571034495, 10390.584376625153, 10419.791604167722, 10443.216758743276, 10474.528646210787, 10937.289076210021, 11154.107671386431, 11290.7741845161, 11346.205765596329, 11429.0, 8184.959075204824, 8213.712520061768, 8266.090730019572, 8469.957650211956, 8508.702195423131, 11172.385518796544, 11712.648620541397, 12244.0, 12493.75012499763, 12772.87227127754], "value": 9603.311962244154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.2984532844023, 1420.2614640386998, 1488.203810961136, 1776.1918327161143, 1798.6132981409003, 8353.289970352513, 8910.242629376502, 8991.145841145097, 9606.855897161548, 9609.903900960997, 9174.220191283748, 9394.765130871714, 9416.105469980357, 9445.244380449565, 9473.147416732492, 2449.5223431430877, 2470.6170543565777, 2487.6517287579754, 2498.250524842549, 2504.0734928076636, 2398.8560686358787, 2530.101813856082, 2533.5439620868237, 2547.0703193334393, 2550.8469491830456, 2457.3979375053136, 2467.5311690778785, 2531.367377926963, 2532.645429639843, 2535.3408113890428, 2394.92228497177, 2394.988025059872, 2402.8318017738766, 2456.8648724320155, 2457.938551536208, 2383.2969274064194, 2396.6884305040408, 2397.8681172535503, 2397.9880100599385, 2409.6867407237123, 9380.437173769596, 9516.762080947963, 9531.332806703533, 9544.284178686627, 9549.28380371468, 5389.353277606673, 5522.889542209174, 5526.640768350045, 5528.9723551381985, 5533.0, 3352.530645709578, 3386.6444023377435, 3445.87939422119, 3463.480477928306, 3484.1115515543374, 1055.8944105589455, 1071.7320669832543, 1102.2449622008949, 1105.2429086075983, 1123.2025262063944, 12738.235705857678, 12763.87236127636, 12778.169418987736, 12783.041271904644, 12808.295543745091, 4524.25349817283, 4636.698614590041, 4774.0, 4806.303086052503, 4808.182608956416, 10787.406692631823, 10809.729756756144, 10877.0, 10881.673549793519, 10893.564257429773, 5549.889002219933, 5563.721813909288, 5572.693501857356, 5581.972090139523, 5591.720413979366, 4551.726896386162, 4990.176620857518, 5101.387833459934, 5107.821226257138, 5113.258577506241, 4254.276772948606, 4308.526062133163, 4333.804978775963, 4374.059577190856, 4394.626456751148, 1354.0995238166508, 1373.2927542315715, 1388.167099740148, 1398.293861599906, 1403.2422491854284, 900.2348004196512, 947.6920000999703, 950.5769932380025, 979.2019504104132, 1052.1687866585464, 6147.66187859672, 6341.334159913143, 6444.097826304321, 6495.382938620824, 6528.804135875836, 999.4752754803786, 1000.8698869146964, 1010.3836659637615, 1038.7558923652934, 1069.9732506687394, 4445.26653102241, 4587.08258348325, 4612.0, 4622.052479241815, 4661.160991021581, 11355.54577816878, 11385.0, 11611.709707257387, 11671.299722016705, 11687.766244675058, 11439.199256052163, 11553.480093395649, 11567.537298508134, 11569.958703716706, 11586.304821710724, 8029.156938521488, 8340.165983401612, 8377.45546539473, 8551.700690475804, 8615.827683446296, 6550.639714815731, 6682.599044057372, 6766.120404347404, 6770.695318710768, 6837.213720422215, 10647.254692171473, 10774.353538787698, 10836.837447438136, 11002.669919902415, 11041.558337666725, 10860.185486088732, 10869.402182879701, 10949.671509854717, 11026.44867756625, 11061.944690276498, 7508.549487030577, 7779.688812447439, 7935.0874649416055, 8317.500949943023, 8464.957675211585, 8551.828963420821, 8569.614367353359, 8572.185642363966, 8582.270507006975, 8597.570121494025, 7274.781756547312, 7386.630668466662, 7401.1488678802625, 7531.661075251736, 7641.197674244347, 7385.852282954418, 7602.543847369176, 7708.075030996316, 7730.149683534919, 7754.108277548155, 6933.687984040629, 6979.581225126509, 7040.823979400351, 7054.153501579844, 7068.858622827617, 5287.365516137934, 5313.203019547099, 5314.654547454403, 5315.707636079898, 5457.563394928476, 5437.885233527197, 5441.2654291670115, 5500.202470641814, 5518.475744804237, 5555.86104848497], "value": 4862.684669037983, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.45846645367413, 354.9609542950276, 355.76875031229713, 356.02804344140503, 359.17569178734817, 5666.025336698235, 5749.856253593663, 5856.648601083938, 5915.9999999999945, 5935.169076329317, 5746.0, 5783.6529808211535, 5784.942150578493, 5785.27684039495, 5793.5365170786345, 4537.682362234645, 4544.500104988449, 4548.476260452752, 4564.97717511412, 4584.633229341644, 4445.977770111145, 4517.209488339544, 4525.728456292616, 4552.203364411232, 4554.931676024862, 4496.572825581565, 4503.707259028169, 4503.729776213438, 4514.8194072237075, 4515.577593058176, 4524.864254072383, 4527.886802829923, 4534.569215924482, 4548.5906268436, 4565.671507531183, 3856.8650097246464, 3973.304671682444, 4015.7188996770237, 4019.839206431739, 4030.717849750519, 5667.0, 5677.587025514181, 5678.545716342683, 5710.428957104298, 5713.74288157034, 5199.792008319662, 5204.854931914972, 5215.869603259949, 5216.843494695166, 5219.556337711299, 5862.267216597926, 6039.969800151015, 6080.817575472743, 6089.756409743605, 6115.602485838451, 4404.823807047715, 4412.514623391425, 4412.742368424983, 4414.329330754879, 4423.5797599228345, 6183.1961844960315, 6345.777897773602, 6349.269833969107, 6356.745730170787, 6360.204974378203, 4435.379046933432, 4483.30508771141, 4493.685442019093, 4527.47933987589, 4533.954660453419, 4530.88672783183, 4546.931796023062, 4561.931571026437, 4567.954320456819, 4587.197240482902, 5176.7152806596, 5187.19598462239, 5197.220416937414, 5205.817796377184, 5209.218617207373, 5835.679037652885, 5885.882282354414, 6077.0, 6100.431247720045, 6116.143739876421, 1517.4233791159509, 1546.4896584127212, 1548.6980038892534, 1551.5733173377187, 1551.736204845179, 932.2495391210006, 961.5961296255449, 969.8157350103457, 980.7106903463496, 981.347403976362, 5164.25118357836, 5170.224466330005, 5201.895962080737, 5204.245384419238, 5207.817726379559, 5477.424870388551, 5495.450454954473, 5495.835124946258, 5508.3114610673665, 5532.336119665585, 5015.949840501621, 5186.625544230782, 5193.246979187997, 5214.3071235888, 5248.7900483980975, 2933.2813460702264, 2935.66239882412, 2936.985315073411, 2942.3232656489126, 2945.8527073646233, 5654.6146194181865, 5655.660660360391, 5661.858453538612, 5699.544036477072, 5721.342045664802, 5269.4730526947, 5546.308375945376, 5550.47270509301, 5555.194561767442, 5585.525230355384, 5601.551875849922, 5644.971775141098, 5659.915101273484, 5662.631928924607, 5669.242534814139, 5286.577073834161, 5445.346558413015, 5463.289772329572, 5465.672059676433, 5470.085470085597, 5442.482964118402, 5450.264214331015, 5454.618176727591, 5458.91811622818, 5459.771551400903, 5672.574556908331, 5684.886302274014, 5686.715664216856, 5703.600747947604, 5714.857128571819, 3972.801359931934, 3979.144483935968, 4073.857414990461, 4401.163778882003, 4438.822447102209, 6188.44304012641, 6245.594741183198, 6275.5920865145445, 6284.214473190851, 6298.149749783904, 6119.9596068669325, 6146.754129834935, 6152.600485810448, 6155.569110162246, 6163.660998645118, 6027.909581356371, 6071.969640151948, 6123.775244950939, 6155.753769849156, 6183.536234782319, 5975.223220981418, 6018.638881667114, 6063.787767428119, 6064.48451881595, 6124.816255512342, 6115.266168059683, 6152.200213972155, 6162.476189523762, 6186.659733714689, 6188.628682279078, 5886.882262354643, 5996.730147143477, 5999.1901093351835, 6036.366181550874, 6043.697815109315], "value": 4475.026492835377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.8451252758666, 830.8629076202427, 889.7731078574964, 902.1294450854924, 903.3134817538669, 16961.575960600992, 17531.82468175318, 17789.37737179199, 17890.37383691571, 17922.551936201602, 16186.109763962977, 16345.18274086294, 16378.26297816601, 16417.67164656706, 16445.588860278498, 734.1337222077946, 872.3762509805488, 894.1594900793234, 897.7935074932769, 900.4732231644496, 876.51791514667, 888.9733308000771, 894.2398960883262, 896.4218079338823, 898.9460632362046, 946.4179529589287, 954.3033585482567, 954.9809003819919, 955.961761529538, 957.3729207369184, 941.4868896451451, 945.9858102128474, 948.9430634161938, 949.0793929887998, 951.0584521323909, 696.3176087434292, 697.469922858626, 699.4020112803581, 701.0570782297801, 702.0907924238124, 15930.442434514736, 16232.513024609281, 16319.347226110942, 16325.918370408192, 16372.508824735278, 14202.289885505683, 14602.12387256768, 14791.852081479155, 14957.252137393087, 15096.849031509653, 13912.37394317258, 14033.1580105194, 14062.306622244481, 14088.506902258474, 14324.856751432457, 4885.633577481668, 4970.975145124287, 4977.676451030671, 4982.327385802906, 5004.499550045003, 83399.16600834035, 85520.57239713761, 86178.0, 87846.56076719704, 89173.55413222892, 12022.819657705142, 12351.38243087842, 12609.054320925967, 12633.305168215653, 12777.16948398351, 21765.673514897288, 22502.21242256513, 22633.660495092587, 22636.0, 22666.43333916665, 9390.577424015935, 9727.173190278905, 9861.704148875546, 9868.062534059252, 9960.501974901372, 5349.090654588651, 5362.088444964287, 5395.514403703685, 5414.3232095988005, 5442.482964118402, 3977.244323578511, 4097.672186225154, 4112.09533902541, 4123.9381409278885, 4138.399932009842, 662.8972509261072, 668.9331066893271, 673.1081317254657, 680.3944489404435, 692.6952141057918, 678.9015592739025, 791.6041979010495, 810.7324582887633, 817.6974519427849, 823.5347028928755, 10825.296355736851, 11182.217244792786, 11308.604198853001, 11676.124290678234, 11825.940870295766, 748.4835463530147, 823.8393513264856, 831.3432388413207, 849.7280870121501, 855.8673405622138, 5043.52086551777, 5269.288646032813, 5281.735913204325, 5291.603129765283, 5354.946450535523, 77828.0, 78391.21608783954, 79254.60372698099, 85958.0, 108214.0, 63458.36541634617, 65165.67417162884, 65895.0, 94541.5272923631, 100751.49624251979, 89442.55278723694, 90053.0, 92535.61196582057, 94309.0, 99577.50211248898, 10503.47482625881, 10507.211959102944, 10574.8413773795, 10839.837402438812, 11468.197226194086, 51092.74453627708, 52501.47498524966, 54515.0, 54607.453925460235, 57226.7138664304, 69970.0, 70377.0, 78208.0, 82104.0, 82176.0, 14202.28988550589, 14313.92645551567, 14458.855411445751, 14503.419863205776, 14729.26353682333, 15961.361545538048, 16140.031598104151, 16282.348706051625, 16780.832191677928, 17464.73802892932, 15632.140232287333, 15663.843361566238, 15798.7630185545, 16059.919700401424, 16137.112458814878, 15018.549443516711, 15291.311890964711, 15710.528684139494, 15949.282282297092, 16761.832381676028, 14361.21013344276, 14599.197044162673, 14850.331735071732, 15152.848471515585, 15472.226388680296, 12337.568185113478, 12461.75076498483, 13006.089573729749, 13165.53920612774, 13462.865371346554, 11459.942700286445, 11720.648380548597, 12576.11358296263, 12695.619131426072, 12937.935310323388], "value": 8272.442502257036, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 107.0, 112.0, 113.0, 112.0, 110.0, 111.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 150.0, 168.0, 117.0, 150.0, 141.0, 116.0, 178.0, 116.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 163.0, 163.0, 161.0, 163.0, 161.0, 164.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 176.0, 77.0, 74.0, 75.0, 79.0, 165.0, 75.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 153.0, 87.0, 83.0, 84.0, 140.0, 83.0, 83.0, 142.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 149.0, 146.0, 147.0, 146.0, 148.0, 146.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 98.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 52.0, 51.0, 54.0, 52.0, 51.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 60.0, 61.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 77.0, 71.0, 72.0, 72.0, 73.0, 77.0, 82.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 115.0, 128.0, 127.0, 119.0, 118.0, 128.0, 161.0, 119.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 153.0, 150.0, 151.0, 152.0, 150.0, 147.0, 154.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 65.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 59.0], "value": 61.8, "unit": "score"}]}]} 17:23:44 INFO - Return code: 0 17:23:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:23:44 ERROR - # TBPL SUCCESS # 17:23:44 INFO - Running post-action listener: _resource_record_post_action 17:23:44 INFO - [mozharness: 2016-10-04 00:23:44.527016Z] Finished run-tests step (success) 17:23:44 INFO - Running post-run listener: _resource_record_post_run 17:23:44 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 290304000; Read time: 0; Write time: 202784 17:23:44 INFO - TinderboxPrint: CPU usage
13.2% 17:23:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:23:44 INFO - TinderboxPrint: I/O write bytes / time
290,304,000 / 202,784 17:23:44 INFO - TinderboxPrint: CPU idle
8,203.1 (86.7%) 17:23:44 INFO - TinderboxPrint: CPU user
1,197.5 (12.7%) 17:23:44 INFO - TinderboxPrint: Swap in / out
0 / 0 17:23:44 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71258112; Read time: 0; Write time: 39292 17:23:44 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 219045888; Read time: 0; Write time: 163492 17:23:45 INFO - Running post-run listener: _upload_blobber_files 17:23:45 INFO - Blob upload gear active. 17:23:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:23:45 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 17:23:45 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:23:45 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:23:45 INFO - (blobuploader) - INFO - Open directory for files ... 17:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:23:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:46 INFO - (blobuploader) - INFO - Done attempting. 17:23:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:23:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:50 INFO - (blobuploader) - INFO - Done attempting. 17:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:51 INFO - (blobuploader) - INFO - Done attempting. 17:23:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:23:51 INFO - Return code: 0 17:23:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:23:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:23:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8595ef2736f7b1ed195d452effd561eef6b4a2cd5f7a44e1be6f9c2ab02efce42af1d88597f5e0ff0e4f50bccbfa395e8265d17240517948cb8c0d8d1160e29d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f64c1625d4cb9528abbd7d401d8307e8a221cbd6b4d108d1772c33715edf8ebd3cdc85432364f5d632ad5ff1210cfda99b5242988984a74c9a5d6a0f8bc55aa7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dad55c2b18aaebd99dde733f895db3c639728fe8505e0fdadbc66b40a9c3e5da63bd9a65f0a22fa6fb6a014b40dd180235fdb68b7d6da787cb1f15c417e9983"} 17:23:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:23:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:23:51 INFO - Contents: 17:23:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8595ef2736f7b1ed195d452effd561eef6b4a2cd5f7a44e1be6f9c2ab02efce42af1d88597f5e0ff0e4f50bccbfa395e8265d17240517948cb8c0d8d1160e29d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f64c1625d4cb9528abbd7d401d8307e8a221cbd6b4d108d1772c33715edf8ebd3cdc85432364f5d632ad5ff1210cfda99b5242988984a74c9a5d6a0f8bc55aa7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dad55c2b18aaebd99dde733f895db3c639728fe8505e0fdadbc66b40a9c3e5da63bd9a65f0a22fa6fb6a014b40dd180235fdb68b7d6da787cb1f15c417e9983"} 17:23:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:23:51 INFO - Copying logs to upload dir... 17:23:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:23:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.328489 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-03 17:23:48.745075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 17:23:48.748139) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8595ef2736f7b1ed195d452effd561eef6b4a2cd5f7a44e1be6f9c2ab02efce42af1d88597f5e0ff0e4f50bccbfa395e8265d17240517948cb8c0d8d1160e29d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f64c1625d4cb9528abbd7d401d8307e8a221cbd6b4d108d1772c33715edf8ebd3cdc85432364f5d632ad5ff1210cfda99b5242988984a74c9a5d6a0f8bc55aa7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dad55c2b18aaebd99dde733f895db3c639728fe8505e0fdadbc66b40a9c3e5da63bd9a65f0a22fa6fb6a014b40dd180235fdb68b7d6da787cb1f15c417e9983"} build_url:https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/bZy6bfPqQtWvFunVk_7cBw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8595ef2736f7b1ed195d452effd561eef6b4a2cd5f7a44e1be6f9c2ab02efce42af1d88597f5e0ff0e4f50bccbfa395e8265d17240517948cb8c0d8d1160e29d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f64c1625d4cb9528abbd7d401d8307e8a221cbd6b4d108d1772c33715edf8ebd3cdc85432364f5d632ad5ff1210cfda99b5242988984a74c9a5d6a0f8bc55aa7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dad55c2b18aaebd99dde733f895db3c639728fe8505e0fdadbc66b40a9c3e5da63bd9a65f0a22fa6fb6a014b40dd180235fdb68b7d6da787cb1f15c417e9983"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 17:23:48.776638) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:23:48.777382) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475537571.462267-1773966195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:23:48.862245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 17:23:48.862996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 17:23:48.863668) ========= ========= Total master_lag: 0.15 =========