builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1474973731.25 results: success (0) buildid: 20160927005849 builduid: a4afe341f3294956a3faacc723f055da revision: 2704e305065955cf0f5e448202fa3df1014c0bae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.254192) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.254667) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.255010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.271082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.271395) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 03:55:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-09-27 03:55:32 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126707 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.414799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.415290) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015219 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.465264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:31.465599) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2704e305065955cf0f5e448202fa3df1014c0bae --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 2704e305065955cf0f5e448202fa3df1014c0bae --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=17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 03:55:32,680 truncating revision to first 12 chars 2016-09-27 03:55:32,680 Setting DEBUG logging. 2016-09-27 03:55:32,680 attempt 1/10 2016-09-27 03:55:32,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2704e3050659?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 03:55:33,227 unpacking tar archive at: mozilla-beta-2704e3050659/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:32.348181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:32.348935) ========= script_repo_revision: 2704e305065955cf0f5e448202fa3df1014c0bae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:32.349929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:32.350611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:55:32.363700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-09-27 03:55:32.364021) ========= /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=17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:55:33 INFO - MultiFileLogger online at 20160927 03:55:33 in /builds/slave/test 03:55:33 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 03:55:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:55:33 INFO - {'append_to_log': False, 03:55:33 INFO - 'base_work_dir': '/builds/slave/test', 03:55:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:55:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:55:33 INFO - 'branch': 'Mozilla-Beta', 03:55:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:33 INFO - 'config_files': ('talos/linux_config.py',), 03:55:33 INFO - 'default_actions': ('clobber', 03:55:33 INFO - 'read-buildbot-config', 03:55:33 INFO - 'download-and-extract', 03:55:33 INFO - 'populate-webroot', 03:55:33 INFO - 'create-virtualenv', 03:55:33 INFO - 'install', 03:55:33 INFO - 'run-tests'), 03:55:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:33 INFO - 'download_minidump_stackwalk': True, 03:55:33 INFO - 'download_symbols': 'ondemand', 03:55:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:55:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:55:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:55:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:55:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:33 INFO - 'installer_path': 'installer.exe', 03:55:33 INFO - 'log_level': 'info', 03:55:33 INFO - 'log_name': 'talos', 03:55:33 INFO - 'log_to_console': True, 03:55:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:55:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:55:33 INFO - 'opt_config_files': (), 03:55:33 INFO - 'pip_index': False, 03:55:33 INFO - 'sps_profile': False, 03:55:33 INFO - 'sps_profile_interval': 0, 03:55:33 INFO - 'suite': 'dromaeojs-e10s', 03:55:33 INFO - 'system_bits': '32', 03:55:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:33 INFO - 'title': 'talos-linux64-ix-009', 03:55:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:33 INFO - 'use_talos_json': True, 03:55:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:55:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:33 INFO - 'work_dir': 'build'} 03:55:33 INFO - [mozharness: 2016-09-27 10:55:33.670214Z] Running clobber step. 03:55:33 INFO - Running pre-action listener: _resource_record_pre_action 03:55:33 INFO - Running main action method: clobber 03:55:33 INFO - rmtree: /builds/slave/test/build 03:55:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:55:34 INFO - Running post-action listener: _resource_record_post_action 03:55:34 INFO - [mozharness: 2016-09-27 10:55:34.137798Z] Finished clobber step (success) 03:55:34 INFO - [mozharness: 2016-09-27 10:55:34.137899Z] Running read-buildbot-config step. 03:55:34 INFO - Running pre-action listener: _resource_record_pre_action 03:55:34 INFO - Running main action method: read_buildbot_config 03:55:34 INFO - Using buildbot properties: 03:55:34 INFO - { 03:55:34 INFO - "project": "", 03:55:34 INFO - "product": "firefox", 03:55:34 INFO - "script_repo_revision": "production", 03:55:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:55:34 INFO - "repository": "", 03:55:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 03:55:34 INFO - "buildid": "20160927005849", 03:55:34 INFO - "pgo_build": "True", 03:55:34 INFO - "basedir": "/builds/slave/test", 03:55:34 INFO - "buildnumber": 262, 03:55:34 INFO - "slavename": "talos-linux64-ix-009", 03:55:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:55:34 INFO - "platform": "ubuntu64_hw", 03:55:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:55:34 INFO - "branch": "mozilla-beta", 03:55:34 INFO - "repo_path": "releases/mozilla-beta", 03:55:34 INFO - "revision": "2704e305065955cf0f5e448202fa3df1014c0bae", 03:55:34 INFO - "stage_platform": "linux64-pgo", 03:55:34 INFO - "builduid": "a4afe341f3294956a3faacc723f055da", 03:55:34 INFO - "slavebuilddir": "test" 03:55:34 INFO - } 03:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 03:55:34 INFO - Running post-action listener: _resource_record_post_action 03:55:34 INFO - [mozharness: 2016-09-27 10:55:34.140355Z] Finished read-buildbot-config step (success) 03:55:34 INFO - [mozharness: 2016-09-27 10:55:34.140445Z] Running download-and-extract step. 03:55:34 INFO - Running pre-action listener: _resource_record_pre_action 03:55:34 INFO - Running main action method: download_and_extract 03:55:34 INFO - mkdir: /builds/slave/test/build/tests 03:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:34 INFO - https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:55:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:55:34 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:55:34 INFO - retry: Failed, sleeping 30 seconds before retrying 03:56:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:56:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:56:04 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:56:04 INFO - retry: Failed, sleeping 60 seconds before retrying 03:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:57:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:57:04 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:57:04 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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! 03:57:04 INFO - Caught exception: HTTP Error 404: Not Found 03:57:04 INFO - Caught exception: HTTP Error 404: Not Found 03:57:04 INFO - Caught exception: HTTP Error 404: Not Found 03:57:04 INFO - trying https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:57:04 INFO - Downloading https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:57:04 INFO - Downloaded 1327 bytes. 03:57:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:57:04 INFO - Using the following test package requirements: 03:57:04 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 03:57:04 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:57:04 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 03:57:04 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'jsshell-linux-x86_64.zip'], 03:57:04 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:57:04 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 03:57:04 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 03:57:04 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 03:57:04 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:57:04 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:57:04 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:57:04 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:57: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')]} 03:57:04 INFO - https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:57:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:57:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:57:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:57:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:57:04 INFO - retry: Failed, sleeping 30 seconds before retrying 03:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:57:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:57:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:57:34 INFO - retry: Failed, sleeping 60 seconds before retrying 03:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:58:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:58:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:58:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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! 03:58:34 INFO - Caught exception: HTTP Error 404: Not Found 03:58:34 INFO - Caught exception: HTTP Error 404: Not Found 03:58:34 INFO - Caught exception: HTTP Error 404: Not Found 03:58:34 INFO - trying https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:58:34 INFO - Downloading https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:58:35 INFO - Downloaded 21772399 bytes. 03:58:35 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'] 03:58:35 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 03:58:36 INFO - Return code: 0 03:58:36 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 03:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:36 INFO - https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:58:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:58:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:58:36 INFO - retry: Failed, sleeping 30 seconds before retrying 03:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 03:59:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:59:07 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:59:07 INFO - retry: Failed, sleeping 60 seconds before retrying 04:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:00:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 04:00:07 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:00:07 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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! 04:00:07 INFO - Caught exception: HTTP Error 404: Not Found 04:00:07 INFO - Caught exception: HTTP Error 404: Not Found 04:00:07 INFO - Caught exception: HTTP Error 404: Not Found 04:00:07 INFO - trying https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 04:00:07 INFO - Downloading https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:00:07 INFO - Downloaded 21772399 bytes. 04:00:07 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'] 04:00:07 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 04:00:09 INFO - Return code: 0 04:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:09 INFO - https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 04:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 04:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:00:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 04:00:09 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:00:09 INFO - retry: Failed, sleeping 30 seconds before retrying 04:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:00:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 04:00:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:00:39 INFO - retry: Failed, sleeping 60 seconds before retrying 04:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:01:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 04:01:39 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:01:39 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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! 04:01:39 INFO - Caught exception: HTTP Error 404: Not Found 04:01:39 INFO - Caught exception: HTTP Error 404: Not Found 04:01:39 INFO - Caught exception: HTTP Error 404: Not Found 04:01:39 INFO - trying https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 04:01:39 INFO - Downloading https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:01:40 INFO - Downloaded 14413740 bytes. 04:01:40 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'] 04:01:40 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 04:01:40 INFO - Return code: 0 04:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:40 INFO - https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:01:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:01:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:01:40 INFO - retry: Failed, sleeping 30 seconds before retrying 04:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:02:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:02:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:02:10 INFO - retry: Failed, sleeping 60 seconds before retrying 04:03:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:03:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:03:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:03:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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! 04:03:10 INFO - Caught exception: HTTP Error 404: Not Found 04:03:10 INFO - Caught exception: HTTP Error 404: Not Found 04:03:10 INFO - Caught exception: HTTP Error 404: Not Found 04:03:10 INFO - trying https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:03:10 INFO - Downloading https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:03:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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 04:03:11 INFO - Downloaded 56786470 bytes. 04:03:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:03:11 INFO - mkdir: /builds/slave/test/properties 04:03:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:03:11 INFO - Writing to file /builds/slave/test/properties/build_url 04:03:11 INFO - Contents: 04:03:11 INFO - build_url:https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 04:03:12 INFO - Running post-action listener: _resource_record_post_action 04:03:12 INFO - Running post-action listener: set_extra_try_arguments 04:03:12 INFO - [mozharness: 2016-09-27 11:03:12.270399Z] Finished download-and-extract step (success) 04:03:12 INFO - [mozharness: 2016-09-27 11:03:12.270632Z] Running populate-webroot step. 04:03:12 INFO - Running pre-action listener: _resource_record_pre_action 04:03:12 INFO - Running main action method: populate_webroot 04:03:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:03:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:03:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:03:12 INFO - '--tppagecycles', 04:03:12 INFO - '7'], 04:03:12 INFO - 'tests': ['tsvgm']}}, 04:03:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:03:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:03:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:03:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:03:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['damp', 'tps']}, 04:03:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'tests': ['damp', 'tps']}, 04:03:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['dromaeo_dom']}, 04:03:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:03:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['basic_compositor_video']}, 04:03:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:03:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['a11yr', 04:03:12 INFO - 'ts_paint', 04:03:12 INFO - 'tpaint', 04:03:12 INFO - 'sessionrestore', 04:03:12 INFO - 'sessionrestore_no_auto_restore', 04:03:12 INFO - 'tabpaint']}, 04:03:12 INFO - 'other-e10s': {'tests': ['a11yr', 04:03:12 INFO - 'ts_paint', 04:03:12 INFO - 'tpaint', 04:03:12 INFO - 'sessionrestore', 04:03:12 INFO - 'sessionrestore_no_auto_restore', 04:03:12 INFO - 'tabpaint']}, 04:03:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:03:12 INFO - 'ts_paint', 04:03:12 INFO - 'tpaint', 04:03:12 INFO - 'sessionrestore', 04:03:12 INFO - 'sessionrestore_no_auto_restore', 04:03:12 INFO - 'tabpaint']}, 04:03:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:03:12 INFO - 'ts_paint', 04:03:12 INFO - 'tpaint', 04:03:12 INFO - 'sessionrestore', 04:03:12 INFO - 'sessionrestore_no_auto_restore', 04:03:12 INFO - 'tabpaint']}, 04:03:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['a11yr', 04:03:12 INFO - 'ts_paint', 04:03:12 INFO - 'tpaint', 04:03:12 INFO - 'sessionrestore', 04:03:12 INFO - 'sessionrestore_no_auto_restore', 04:03:12 INFO - 'tabpaint']}, 04:03:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['a11yr', 04:03:12 INFO - 'ts_paint', 04:03:12 INFO - 'tpaint', 04:03:12 INFO - 'sessionrestore', 04:03:12 INFO - 'sessionrestore_no_auto_restore', 04:03:12 INFO - 'tabpaint']}, 04:03:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['tsvgx', 04:03:12 INFO - 'tsvgr_opacity', 04:03:12 INFO - 'tart', 04:03:12 INFO - 'tscrollx', 04:03:12 INFO - 'cart']}, 04:03:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:03:12 INFO - 'tsvgr_opacity', 04:03:12 INFO - 'tart', 04:03:12 INFO - 'tscrollx', 04:03:12 INFO - 'cart']}, 04:03:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'talos_options': ['--disable-e10s'], 04:03:12 INFO - 'tests': ['tp5o']}, 04:03:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'tests': ['tp5o']}, 04:03:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'talos_options': ['--disable-e10s', 04:03:12 INFO - '--xperf_path', 04:03:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:12 INFO - 'tests': ['tp5n']}, 04:03:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:12 INFO - 'talos_options': ['--xperf_path', 04:03:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:12 INFO - 'tests': ['tp5n']}}, 04:03:12 INFO - 'talos.zip': {'path': '', 04:03:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:03:12 INFO - Running post-action listener: _resource_record_post_action 04:03:12 INFO - [mozharness: 2016-09-27 11:03:12.291326Z] Finished populate-webroot step (success) 04:03:12 INFO - [mozharness: 2016-09-27 11:03:12.291415Z] Running create-virtualenv step. 04:03:12 INFO - Running pre-action listener: _resource_record_pre_action 04:03:12 INFO - Running main action method: create_virtualenv 04:03:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:03:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:03:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:03:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:03:12 INFO - Using real prefix '/usr' 04:03:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:03:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:03:14 INFO - Installing pip.................done. 04:03:14 INFO - Return code: 0 04:03:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:14 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:03:14 INFO - Using env: {'DISPLAY': ':0', 04:03:14 INFO - 'HOME': '/home/cltbld', 04:03:14 INFO - 'LANG': 'en_US.UTF-8', 04:03:14 INFO - 'LANGUAGE': 'en_US:en', 04:03:14 INFO - 'LOGNAME': 'cltbld', 04:03:14 INFO - 'MAIL': '/var/mail/cltbld', 04:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:14 INFO - 'MOZ_NO_REMOTE': '1', 04:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:14 INFO - 'NO_EM_RESTART': '1', 04:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:14 INFO - 'PWD': '/builds/slave/test', 04:03:14 INFO - 'SHELL': '/bin/bash', 04:03:14 INFO - 'SHLVL': '1', 04:03:14 INFO - 'TERM': 'linux', 04:03:14 INFO - 'TMOUT': '86400', 04:03:14 INFO - 'USER': 'cltbld', 04:03:14 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:14 INFO - '_': '/tools/buildbot/bin/python'} 04:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:03:15 INFO - Cleaning up... 04:03:15 INFO - Return code: 0 04:03:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:03:15 INFO - Using env: {'DISPLAY': ':0', 04:03:15 INFO - 'HOME': '/home/cltbld', 04:03:15 INFO - 'LANG': 'en_US.UTF-8', 04:03:15 INFO - 'LANGUAGE': 'en_US:en', 04:03:15 INFO - 'LOGNAME': 'cltbld', 04:03:15 INFO - 'MAIL': '/var/mail/cltbld', 04:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:15 INFO - 'MOZ_NO_REMOTE': '1', 04:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:15 INFO - 'NO_EM_RESTART': '1', 04:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:15 INFO - 'PWD': '/builds/slave/test', 04:03:15 INFO - 'SHELL': '/bin/bash', 04:03:15 INFO - 'SHLVL': '1', 04:03:15 INFO - 'TERM': 'linux', 04:03:15 INFO - 'TMOUT': '86400', 04:03:15 INFO - 'USER': 'cltbld', 04:03:15 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:15 INFO - '_': '/tools/buildbot/bin/python'} 04:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:15 INFO - Downloading/unpacking psutil>=3.1.1 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:03:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:17 INFO - Installing collected packages: psutil 04:03:17 INFO - Running setup.py install for psutil 04:03:17 INFO - building 'psutil._psutil_linux' extension 04:03:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:03:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:03:17 INFO - building 'psutil._psutil_posix' extension 04:03:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:03:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:03:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:17 INFO - Successfully installed psutil 04:03:17 INFO - Cleaning up... 04:03:17 INFO - Return code: 0 04:03:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:03:17 INFO - Using env: {'DISPLAY': ':0', 04:03:17 INFO - 'HOME': '/home/cltbld', 04:03:17 INFO - 'LANG': 'en_US.UTF-8', 04:03:17 INFO - 'LANGUAGE': 'en_US:en', 04:03:17 INFO - 'LOGNAME': 'cltbld', 04:03:17 INFO - 'MAIL': '/var/mail/cltbld', 04:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:17 INFO - 'MOZ_NO_REMOTE': '1', 04:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:17 INFO - 'NO_EM_RESTART': '1', 04:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:17 INFO - 'PWD': '/builds/slave/test', 04:03:17 INFO - 'SHELL': '/bin/bash', 04:03:17 INFO - 'SHLVL': '1', 04:03:17 INFO - 'TERM': 'linux', 04:03:17 INFO - 'TMOUT': '86400', 04:03:17 INFO - 'USER': 'cltbld', 04:03:17 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:17 INFO - '_': '/tools/buildbot/bin/python'} 04:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:03:20 INFO - Installing collected packages: mozsystemmonitor 04:03:20 INFO - Running setup.py install for mozsystemmonitor 04:03:20 INFO - Successfully installed mozsystemmonitor 04:03:20 INFO - Cleaning up... 04:03:20 INFO - Return code: 0 04:03:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:20 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:03:20 INFO - Using env: {'DISPLAY': ':0', 04:03:20 INFO - 'HOME': '/home/cltbld', 04:03:20 INFO - 'LANG': 'en_US.UTF-8', 04:03:20 INFO - 'LANGUAGE': 'en_US:en', 04:03:20 INFO - 'LOGNAME': 'cltbld', 04:03:20 INFO - 'MAIL': '/var/mail/cltbld', 04:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:20 INFO - 'MOZ_NO_REMOTE': '1', 04:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:20 INFO - 'NO_EM_RESTART': '1', 04:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:20 INFO - 'PWD': '/builds/slave/test', 04:03:20 INFO - 'SHELL': '/bin/bash', 04:03:20 INFO - 'SHLVL': '1', 04:03:20 INFO - 'TERM': 'linux', 04:03:20 INFO - 'TMOUT': '86400', 04:03:20 INFO - 'USER': 'cltbld', 04:03:20 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:20 INFO - '_': '/tools/buildbot/bin/python'} 04:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:20 INFO - Downloading/unpacking jsonschema==2.5.1 04:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:03:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:03:22 INFO - warning: no files found matching '*.txt' 04:03:22 INFO - no previously-included directories found matching 'build' 04:03:22 INFO - no previously-included directories found matching 'dist' 04:03:22 INFO - no previously-included directories found matching '.git*' 04:03:22 INFO - Installing collected packages: jsonschema, functools32 04:03:22 INFO - Running setup.py install for functools32 04:03:22 INFO - warning: no files found matching '*.txt' 04:03:22 INFO - no previously-included directories found matching 'build' 04:03:22 INFO - no previously-included directories found matching 'dist' 04:03:22 INFO - no previously-included directories found matching '.git*' 04:03:22 INFO - Successfully installed jsonschema functools32 04:03:22 INFO - Cleaning up... 04:03:22 INFO - Return code: 0 04:03:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:22 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:03:22 INFO - Using env: {'DISPLAY': ':0', 04:03:22 INFO - 'HOME': '/home/cltbld', 04:03:22 INFO - 'LANG': 'en_US.UTF-8', 04:03:22 INFO - 'LANGUAGE': 'en_US:en', 04:03:22 INFO - 'LOGNAME': 'cltbld', 04:03:22 INFO - 'MAIL': '/var/mail/cltbld', 04:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:22 INFO - 'MOZ_NO_REMOTE': '1', 04:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:22 INFO - 'NO_EM_RESTART': '1', 04:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:22 INFO - 'PWD': '/builds/slave/test', 04:03:22 INFO - 'SHELL': '/bin/bash', 04:03:22 INFO - 'SHLVL': '1', 04:03:22 INFO - 'TERM': 'linux', 04:03:22 INFO - 'TMOUT': '86400', 04:03:22 INFO - 'USER': 'cltbld', 04:03:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:22 INFO - '_': '/tools/buildbot/bin/python'} 04:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:03:22 INFO - Cleaning up... 04:03:22 INFO - Return code: 0 04:03:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:22 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:03:22 INFO - Using env: {'DISPLAY': ':0', 04:03:22 INFO - 'HOME': '/home/cltbld', 04:03:22 INFO - 'LANG': 'en_US.UTF-8', 04:03:22 INFO - 'LANGUAGE': 'en_US:en', 04:03:22 INFO - 'LOGNAME': 'cltbld', 04:03:22 INFO - 'MAIL': '/var/mail/cltbld', 04:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:22 INFO - 'MOZ_NO_REMOTE': '1', 04:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:22 INFO - 'NO_EM_RESTART': '1', 04:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:22 INFO - 'PWD': '/builds/slave/test', 04:03:22 INFO - 'SHELL': '/bin/bash', 04:03:22 INFO - 'SHLVL': '1', 04:03:22 INFO - 'TERM': 'linux', 04:03:22 INFO - 'TMOUT': '86400', 04:03:22 INFO - 'USER': 'cltbld', 04:03:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:22 INFO - '_': '/tools/buildbot/bin/python'} 04:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:23 INFO - Downloading/unpacking blobuploader==1.2.4 04:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:03:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:03:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:25 INFO - Downloading docopt-0.6.1.tar.gz 04:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:03:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:03:25 INFO - Running setup.py install for blobuploader 04:03:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:03:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:03:25 INFO - Running setup.py install for requests 04:03:26 INFO - Running setup.py install for docopt 04:03:26 INFO - Successfully installed blobuploader requests docopt 04:03:26 INFO - Cleaning up... 04:03:26 INFO - Return code: 0 04:03:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:26 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:26 INFO - Using env: {'DISPLAY': ':0', 04:03:26 INFO - 'HOME': '/home/cltbld', 04:03:26 INFO - 'LANG': 'en_US.UTF-8', 04:03:26 INFO - 'LANGUAGE': 'en_US:en', 04:03:26 INFO - 'LOGNAME': 'cltbld', 04:03:26 INFO - 'MAIL': '/var/mail/cltbld', 04:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:26 INFO - 'MOZ_NO_REMOTE': '1', 04:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:26 INFO - 'NO_EM_RESTART': '1', 04:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:26 INFO - 'PWD': '/builds/slave/test', 04:03:26 INFO - 'SHELL': '/bin/bash', 04:03:26 INFO - 'SHLVL': '1', 04:03:26 INFO - 'TERM': 'linux', 04:03:26 INFO - 'TMOUT': '86400', 04:03:26 INFO - 'USER': 'cltbld', 04:03:26 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:26 INFO - '_': '/tools/buildbot/bin/python'} 04:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:26 INFO - Running setup.py (path:/tmp/pip-ECg98P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:26 INFO - Running setup.py (path:/tmp/pip-8wzu2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:26 INFO - Running setup.py (path:/tmp/pip-qwEUoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:26 INFO - Running setup.py (path:/tmp/pip-DlQYtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:26 INFO - Running setup.py (path:/tmp/pip-IvVfXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:27 INFO - Running setup.py (path:/tmp/pip-hpLh4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:27 INFO - Running setup.py (path:/tmp/pip-KLXb_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:27 INFO - Running setup.py (path:/tmp/pip-pNUYqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:27 INFO - Running setup.py (path:/tmp/pip-XfJyUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:27 INFO - Running setup.py (path:/tmp/pip-rxCWr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:27 INFO - Running setup.py (path:/tmp/pip-XQwl9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:27 INFO - Running setup.py (path:/tmp/pip-YdmNJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:27 INFO - Running setup.py (path:/tmp/pip-HJEJhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:27 INFO - Running setup.py (path:/tmp/pip-rJLdtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:27 INFO - Running setup.py (path:/tmp/pip-LCmvWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:27 INFO - Running setup.py (path:/tmp/pip-Ybmi26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:27 INFO - Running setup.py (path:/tmp/pip-tzGLtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:03:27 INFO - Running setup.py install for manifestparser 04:03:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Running setup.py install for mozcrash 04:03:28 INFO - Running setup.py install for mozdebug 04:03:28 INFO - Running setup.py install for mozdevice 04:03:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Running setup.py install for mozfile 04:03:28 INFO - Running setup.py install for mozhttpd 04:03:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Running setup.py install for mozinfo 04:03:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Running setup.py install for mozInstall 04:03:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Running setup.py install for mozleak 04:03:28 INFO - Running setup.py install for mozlog 04:03:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:03:28 INFO - Running setup.py install for moznetwork 04:03:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:03:29 INFO - Running setup.py install for mozprocess 04:03:29 INFO - Running setup.py install for mozprofile 04:03:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:03:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:03:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:03:29 INFO - Running setup.py install for mozrunner 04:03:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:03:29 INFO - Running setup.py install for mozscreenshot 04:03:29 INFO - Running setup.py install for moztest 04:03:29 INFO - Running setup.py install for mozversion 04:03:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:03:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:03:29 INFO - Cleaning up... 04:03:29 INFO - Return code: 0 04:03:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:29 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:29 INFO - Using env: {'DISPLAY': ':0', 04:03:29 INFO - 'HOME': '/home/cltbld', 04:03:29 INFO - 'LANG': 'en_US.UTF-8', 04:03:29 INFO - 'LANGUAGE': 'en_US:en', 04:03:29 INFO - 'LOGNAME': 'cltbld', 04:03:29 INFO - 'MAIL': '/var/mail/cltbld', 04:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:29 INFO - 'MOZ_NO_REMOTE': '1', 04:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:29 INFO - 'NO_EM_RESTART': '1', 04:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:29 INFO - 'PWD': '/builds/slave/test', 04:03:29 INFO - 'SHELL': '/bin/bash', 04:03:29 INFO - 'SHLVL': '1', 04:03:29 INFO - 'TERM': 'linux', 04:03:29 INFO - 'TMOUT': '86400', 04:03:29 INFO - 'USER': 'cltbld', 04:03:29 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:29 INFO - '_': '/tools/buildbot/bin/python'} 04:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:29 INFO - Running setup.py (path:/tmp/pip-YQX7M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:29 INFO - Running setup.py (path:/tmp/pip-j5jzuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:30 INFO - Running setup.py (path:/tmp/pip-0pM9u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:30 INFO - Running setup.py (path:/tmp/pip-eUWEHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:30 INFO - Running setup.py (path:/tmp/pip-RUnqUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:30 INFO - Running setup.py (path:/tmp/pip-112R8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:30 INFO - Running setup.py (path:/tmp/pip-GfGWhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:30 INFO - Running setup.py (path:/tmp/pip-pXdhw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:30 INFO - Running setup.py (path:/tmp/pip-kmN29c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:30 INFO - Running setup.py (path:/tmp/pip-P9fSzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:30 INFO - Running setup.py (path:/tmp/pip-dJlWQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:30 INFO - Running setup.py (path:/tmp/pip-xH9Myj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:30 INFO - Running setup.py (path:/tmp/pip-VzZEQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:30 INFO - Running setup.py (path:/tmp/pip-tb6rMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:30 INFO - Running setup.py (path:/tmp/pip-7k6uBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:31 INFO - Running setup.py (path:/tmp/pip-q4axgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:31 INFO - Running setup.py (path:/tmp/pip-Zgj0ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:03:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:33 INFO - Downloading blessings-1.6.tar.gz 04:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:03:33 INFO - Installing collected packages: blessings 04:03:33 INFO - Running setup.py install for blessings 04:03:33 INFO - Successfully installed blessings 04:03:33 INFO - Cleaning up... 04:03:33 INFO - Return code: 0 04:03:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:03:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:33 INFO - Reading from file tmpfile_stdout 04:03:33 INFO - Current package versions: 04:03:33 INFO - argparse == 1.2.1 04:03:33 INFO - blessings == 1.6 04:03:33 INFO - blobuploader == 1.2.4 04:03:33 INFO - docopt == 0.6.1 04:03:33 INFO - functools32 == 3.2.3-2 04:03:33 INFO - jsonschema == 2.5.1 04:03:33 INFO - manifestparser == 1.1 04:03:33 INFO - mozInstall == 1.12 04:03:33 INFO - mozcrash == 0.17 04:03:33 INFO - mozdebug == 0.1 04:03:33 INFO - mozdevice == 0.48 04:03:33 INFO - mozfile == 1.2 04:03:33 INFO - mozhttpd == 0.7 04:03:33 INFO - mozinfo == 0.9 04:03:33 INFO - mozleak == 0.1 04:03:33 INFO - mozlog == 3.3 04:03:33 INFO - moznetwork == 0.27 04:03:33 INFO - mozprocess == 0.23 04:03:33 INFO - mozprofile == 0.28 04:03:33 INFO - mozrunner == 6.12 04:03:33 INFO - mozscreenshot == 0.1 04:03:33 INFO - mozsystemmonitor == 0.3 04:03:33 INFO - moztest == 0.7 04:03:33 INFO - mozversion == 1.4 04:03:33 INFO - psutil == 3.1.1 04:03:33 INFO - requests == 1.2.3 04:03:33 INFO - wsgiref == 0.1.2 04:03:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:33 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:33 INFO - Using env: {'DISPLAY': ':0', 04:03:33 INFO - 'HOME': '/home/cltbld', 04:03:33 INFO - 'LANG': 'en_US.UTF-8', 04:03:33 INFO - 'LANGUAGE': 'en_US:en', 04:03:33 INFO - 'LOGNAME': 'cltbld', 04:03:33 INFO - 'MAIL': '/var/mail/cltbld', 04:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:33 INFO - 'MOZ_NO_REMOTE': '1', 04:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:33 INFO - 'NO_EM_RESTART': '1', 04:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:33 INFO - 'PWD': '/builds/slave/test', 04:03:33 INFO - 'SHELL': '/bin/bash', 04:03:33 INFO - 'SHLVL': '1', 04:03:33 INFO - 'TERM': 'linux', 04:03:33 INFO - 'TMOUT': '86400', 04:03:33 INFO - 'USER': 'cltbld', 04:03:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:33 INFO - '_': '/tools/buildbot/bin/python'} 04:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:03:33 INFO - Cleaning up... 04:03:33 INFO - Return code: 0 04:03:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:33 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, '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': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:03:33 INFO - Using env: {'DISPLAY': ':0', 04:03:33 INFO - 'HOME': '/home/cltbld', 04:03:33 INFO - 'LANG': 'en_US.UTF-8', 04:03:33 INFO - 'LANGUAGE': 'en_US:en', 04:03:33 INFO - 'LOGNAME': 'cltbld', 04:03:33 INFO - 'MAIL': '/var/mail/cltbld', 04:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:33 INFO - 'MOZ_NO_REMOTE': '1', 04:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:33 INFO - 'NO_EM_RESTART': '1', 04:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:33 INFO - 'PWD': '/builds/slave/test', 04:03:33 INFO - 'SHELL': '/bin/bash', 04:03:33 INFO - 'SHLVL': '1', 04:03:33 INFO - 'TERM': 'linux', 04:03:33 INFO - 'TMOUT': '86400', 04:03:33 INFO - 'USER': 'cltbld', 04:03:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:33 INFO - '_': '/tools/buildbot/bin/python'} 04:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:03:33 INFO - Cleaning up... 04:03:33 INFO - Return code: 0 04:03:33 INFO - Running post-action listener: _resource_record_post_action 04:03:33 INFO - Running post-action listener: _start_resource_monitoring 04:03:34 INFO - Starting resource monitoring. 04:03:34 INFO - [mozharness: 2016-09-27 11:03:34.015778Z] Finished create-virtualenv step (success) 04:03:34 INFO - [mozharness: 2016-09-27 11:03:34.016250Z] Running install step. 04:03:34 INFO - Running pre-action listener: _resource_record_pre_action 04:03:34 INFO - Running main action method: install 04:03:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:34 INFO - Reading from file tmpfile_stdout 04:03:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:03:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:03:34 INFO - Reading from file tmpfile_stdout 04:03:34 INFO - Output received: 04:03:34 INFO - Usage: mozinstall [options] installer 04:03:34 INFO - Options: 04:03:34 INFO - -h, --help show this help message and exit 04:03:34 INFO - -d DEST, --destination=DEST 04:03:34 INFO - Directory to install application into. [default: 04:03:34 INFO - "/builds/slave/test"] 04:03:34 INFO - --app=APP Application being installed. [default: firefox] 04:03:34 INFO - mkdir: /builds/slave/test/build/application 04:03:34 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'] 04:03:34 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 04:03:48 INFO - Reading from file tmpfile_stdout 04:03:48 INFO - Output received: 04:03:48 INFO - /builds/slave/test/build/application/firefox/firefox 04:03:48 INFO - Running post-action listener: _resource_record_post_action 04:03:48 INFO - [mozharness: 2016-09-27 11:03:48.443787Z] Finished install step (success) 04:03:48 INFO - [mozharness: 2016-09-27 11:03:48.444066Z] Running run-tests step. 04:03:48 INFO - Running pre-action listener: _resource_record_pre_action 04:03:48 INFO - Running main action method: run_tests 04:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:03:48 INFO - Python 2.7.3 04:03:48 INFO - Return code: 0 04:03:48 INFO - grabbing minidump binary from tooltool 04:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:48 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 0x1e34570>, '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 0x1e35470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e35900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:03:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:03:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:03:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:03:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:03:48 INFO - Return code: 0 04:03:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:03:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:03:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:03:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:03:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:03:48 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/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:03:48 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/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:03:48 INFO - Using env: {'DISPLAY': ':0', 04:03:48 INFO - 'HOME': '/home/cltbld', 04:03:48 INFO - 'LANG': 'en_US.UTF-8', 04:03:48 INFO - 'LANGUAGE': 'en_US:en', 04:03:48 INFO - 'LOGNAME': 'cltbld', 04:03:48 INFO - 'MAIL': '/var/mail/cltbld', 04:03:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:48 INFO - 'MOZ_NO_REMOTE': '1', 04:03:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:48 INFO - 'NO_EM_RESTART': '1', 04:03:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:48 INFO - 'PWD': '/builds/slave/test', 04:03:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:48 INFO - 'SHELL': '/bin/bash', 04:03:48 INFO - 'SHLVL': '1', 04:03:48 INFO - 'TERM': 'linux', 04:03:48 INFO - 'TMOUT': '86400', 04:03:48 INFO - 'USER': 'cltbld', 04:03:48 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615', 04:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:48 INFO - '_': '/tools/buildbot/bin/python'} 04:03:48 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/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:03:48 INFO - mozversion application_buildid: 20160927005849 04:03:48 INFO - mozversion application_changeset: 2704e305065955cf0f5e448202fa3df1014c0bae 04:03:48 INFO - mozversion application_display_name: Firefox 04:03:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:03:48 INFO - mozversion application_name: Firefox 04:03:48 INFO - mozversion application_remotingname: firefox 04:03:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:03:48 INFO - mozversion application_vendor: Mozilla 04:03:48 INFO - mozversion application_version: 50.0 04:03:48 INFO - mozversion platform_buildid: 20160927005849 04:03:48 INFO - mozversion platform_changeset: 2704e305065955cf0f5e448202fa3df1014c0bae 04:03:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:03:48 INFO - mozversion platform_version: 50.0 04:03:48 INFO - using testdate: 1474974228 04:03:48 INFO - actual date: 1474974228 04:03:48 INFO - starting webserver on 'localhost:47457' 04:03:48 INFO - SUITE-START | Running 2 tests 04:03:48 INFO - TEST-START | dromaeo_css 04:03:48 INFO - operating with platform_type : linux_ 04:03:48 INFO - Initialising browser for dromaeo_css test... 04:03:48 INFO - TEST-INFO | started process 19541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3V5gBc/profile http://localhost:47457/getInfo.html) 04:03:53 INFO - PROCESS | 19541 | __metrics Screen width/height:1600/1200 04:03:53 INFO - PROCESS | 19541 | colorDepth:24 04:03:53 INFO - PROCESS | 19541 | Browser inner width/height: 1024/697 04:03:53 INFO - PROCESS | 19541 | __metrics 04:03:53 ERROR - PROCESS | 19541 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:03:54 INFO - TEST-INFO | 19541: exit 0 04:03:54 INFO - Browser initialized. 04:03:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:54 INFO - TEST-INFO | started process 19669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3V5gBc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:06 INFO - PROCESS | 19669 | RSS: Main: 149295104 04:04:06 INFO - PROCESS | 19669 | 04:04:55 INFO - PROCESS | 19669 | 1474974295644 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:07:04 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:47457/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47457/tests/dromaeo/cssquery-ext.html) 04:07:05 INFO - PROCESS | 19669 | RSS: Main: 158138368 04:07:05 INFO - PROCESS | 19669 | 04:10:07 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:47457/tests/dromaeo/cssquery-ext.html (next: http://localhost:47457/tests/dromaeo/cssquery-jquery.html) 04:10:07 INFO - PROCESS | 19669 | RSS: Main: 155271168 04:10:07 INFO - PROCESS | 19669 | 04:13:09 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:47457/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47457/tests/dromaeo/cssquery-mootools.html) 04:13:10 INFO - PROCESS | 19669 | RSS: Main: 154288128 04:13:10 INFO - PROCESS | 19669 | 04:16:12 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:47457/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47457/tests/dromaeo/cssquery-prototype.html) 04:16:12 INFO - PROCESS | 19669 | RSS: Main: 155742208 04:16:12 INFO - PROCESS | 19669 | 04:19:15 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:47457/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47457/tests/dromaeo/cssquery-yui.html) 04:19:15 INFO - PROCESS | 19669 | RSS: Main: 156975104 04:19:15 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:47457/tests/dromaeo/cssquery-yui.html (next: http://localhost:47457/tests/dromaeo/cssquery-dojo.html) 04:22:18 INFO - PROCESS | 19669 | RSS: Main: 156876800 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | __start_tp_report 04:22:18 INFO - PROCESS | 19669 | _x_x_mozilla_page_load 04:22:18 INFO - PROCESS | 19669 | _x_x_mozilla_page_load_details 04:22:18 INFO - PROCESS | 19669 | |i|pagename|runs| 04:22:18 INFO - PROCESS | 19669 | |0;dojo.html;3276.6559511251317;3295.32445848601;3299.3071454994465;3302.1414432247607;3324.5179448979898;5759.251297331346;5773.942260577388;5779.21980532628;5803.6227645203035;5810.5932584719085;5889.85275368116;5951;5958.344582095966;5962.821115366546;5982.132590774335;5305.973470132644;5356.839294821161;5357;5414.377346605132;5482.068048431776;5228.137357336035;5234.42421333653;5278.392984806758;5285.603579731516;5336.4129945705945;5287.841364759063;5297.496737809902;5358.571314294866;5387.892242155154;5450.264214331054;5374.193870919355;5378.300820893279;5389.51494365507;5389.676619402849;5412.485813847678;5044.672096313765;5125.974370128126;5159.25190847325;5311.681299122065;5343;5735;5820.563457740686;5820.708964551755;5828.475437210629;5856.619319744245;6221.408966148254;6282.026285925689;6289.622622642656;6294.527910406738;6298.212723409574;6001.849953751147;6141.17917434816;6283.151774510428;6289.276733175698;6318.778842740528;5827.533797296206;5925.851853703692;5932.436418540188;5956.583039187259;5967.015442452033;6457.806265812033;6481.449076828522;6502.902456463157;6511.088447617338;6511.120998665215;6000;6102.9930061540235;6218.626882387071;6222.875542489215;6225.252969643671;6201.937980620226;6288.245410550763;6330.620162790247;6333.809985700436;6340.270868850049;6307.747690092437;6315.463185629273;6316.463100636497;6327.620342779448;6332.145160403286;5968.313643930916;6058.787942421994;6293.30773614902;6300.9684951574945;6320.367963203643;4723.055388922229;4738.194506933761;4759.785809638574;4793.400824896888;4793.448753393334;4222.577742225814;4226.091390351089;4228.344606585984;4236.4704411948505;4254.340577210537;5739.942600574024;5899.734511946973;5925.73334199962;5968.134620480006;5988.251468566429;6321.273053598895;6388.616682999035;6410.423061924449;6436.774712885027;6446.161998940108;6016.819495415145;6043.788467403708;6067;6073;6079.939200608026;5066.923996140061;5172.172452407597;5271.499207575274;5272.288241087481;5290.365156181206;6519.250286217051;6587.604743715392;6629.635370054693;6633.86732265352;6647.368499992493;6390;6404.327545607644;6404.615723056631;6408.58344207625;6430.453411460078;6206.596571222856;6428.19647544057;6579.703913323816;6581.3747693969;6630.171228596426;6155.045967874987;6253.499720022296;6269.090981807703;6274.435300822948;6276.874462510633;6431.356864313719;6432.35676432353;6433.871322573429;6434.67826608677;6443.484521238196;6008.849778755566;6011.549133814894;6236.532260080421;6243.875122497616;6248.593841400295;6057.606255593372;6099.420555047263;6108.0688921796145;6110.801781737137;6135.723892424762;6042.395760423922;6044.607100538451;6048.183495228264;6063.242094738158;6087.634741915499;5882.382349853204;6078.787242446493;6133.294671112879;6169.537284703575;6170.9074363885475;5996.820095396971;6052.939470605237;6084.908726369196;6120.693965301806;6121.265448146251 04:22:18 INFO - PROCESS | 19669 | |1;ext.html;565.7369323264684;630.5491573524929;639.3574457670044;641.9696387298385;696.1506961506959;42416.36375454371;46892.76553617236;46895;46908.29637555435;47095.29357059647;47827;48349.274760878616;48374.51625483744;48499.75750121244;48583.51416485834;9172.266218702487;9352.532373381304;9364.625414983393;9374.812503749921;9376.343655944087;9187.586558604846;9303.581338839735;9319.207867331252;9324.114209150153;9334.53327333634;9314.627414903396;9318.673846415377;9320.02139775324;9326.720198394025;9346;9310.441373517542;9314.068593140699;9323.347365684405;9350.579223934872;9364.625414983393;9203.40177888435;9282.814343713088;9291.628334866597;9295.860562091573;9299.953500232523;44425;44990;45105.774471127435;45124.323135153;45179.32231016537;3888.4556162137324;4031.9395209071886;4135.193637240739;4450.243458612012;4777.761111944389;34727.6527234727;35745.285094298226;35837.28325433477;36105.63894361076;36470.81764591187;4762.309465127537;4782.928256076161;4788.377510923592;4841.2496063110275;4854.878628034292;376474;378685;380774;384081;384635;66394.66802665955;66619;66685;66861.33138668552;66935;40474.59525404767;41389.1722165561;41444.1711165781;43873.78063109728;43880.56119438765;15459.536213913601;15590.688186236212;15596.454124105829;15607.375704971673;15628.68742625164;13873.167609943233;13874.236916969663;14039.578812635636;14060;14167;21076.578468430547;21291.36125916225;21310.147594096372;21412.25057122993;21534;7626.618669066635;7794.3764498839955;7815.921840781633;7866.685332586747;7992.880106798402;1028.93311934724;1126.7802778458122;1210.2073142091945;1225.087309954072;1248.5942068827667;34024.82987585046;34089.82955085209;34291;34784.652153478644;35031;1150.6778102131416;1190.6844686158174;1211.6486218996392;1237.3813093453273;1244.7883859743865;18220.54448638768;18264.263517712865;18281.177347019417;18384.724229136573;18418.907905460386;614732;627888;628809;630748;632458;65145.697086058964;65606.34393656098;65624.34375656278;65626.34373656298;65710.34289657042;1405.4588983241526;1445.4579532675248;1447.7466443372368;1448.2541491132076;1469.1111877314072;33790.324193516484;34055.318893621494;34377.79677711268;34762.65237347594;35131.47302790409;57810.13284800816;58077;58126;58296.12555811581;58317;491684;492123;494471;495981;496994;31537.369252615277;31926.521102183022;32538;32712.018639440856;34221.82889085539;52844.47155528549;53693;54308.45691543192;54508;55477;45608.77195614001;46785;47061.7646911777;47544.286835698185;47980.760096199294;45902.770486147354;46063.76968115272;46920.7653961728;47646;47723.76138119426;44802.21019731796;45178;46237.30644040409;46512.53487465082;46610.300845486665;39171.608283916794;40339;40559.17483713181;40635.796821015705;41356.58643413527;30563.694363056973;30819.38361232718;31053;31669;31702.365952681277 04:22:18 INFO - PROCESS | 19669 | |2;jquery.html;433.815953581693;435.5948967460263;439.0713640650026;442.7188735153178;454.4206137175103;19609.803901960975;21233.57532849342;21418.464538386546;21636.24273150442;21993.560128797413;19917.40247792565;20311.796882031176;20601.278955236532;20708;20735.377938661826;5994.580379373435;6150.815475535719;6207.937920620781;6211.409916057967;6213.378662133796;5922.31893332268;6093.512518998469;6103.328633850273;6114.449699527042;6118.11287363332;5853.443922827325;5971.343152253248;6079;6116.816495505142;6169.136320915076;5914.526837852983;6090.756369745205;6106.542009349294;6110.602810817282;6126.785562505291;6133.202683651097;6168.845778855564;6217.595856269328;6229.25248970122;6241;17215.483535493957;23636.527269454513;24026;24046.398840028964;24201.87899060511;2710.8644567771535;3008.247938015496;3025.3041800386036;3177.507486339598;3188.7608429367892;10427.635032773816;10863.402512861789;11033.117350611932;11193.776124477547;11289.209755317132;1999.4401567561106;2075.5122546201633;2094.204202403077;2188.321620297713;2217.2904670505445;86224.54078471388;86480.56759716161;87071;87772;89506;11710.355930423739;12005.63983080509;12022.639320820215;12039.819402708967;12213.633590992284;17303.3943811966;17493.65012699739;17518.299268029135;17530.47408577745;17565.824341756674;8271.8345633087;8450.154984501502;8592.742217733477;8649.654013839376;8780.736577902673;8078.959605202054;8311.833763324821;8535.231829135408;8564.100769419247;8692.739217823475;4903.239997800347;5147.202183661539;5201.843944681666;5236.214567814782;5275.208718692227;1946.639871623754;2059.6910463430604;2160.0819651647985;2180.09526046692;2184.388371256051;944.4899754132691;1023.1405619279692;1042.95828166874;1044.749260177567;1052.4685034057752;20709.896450517954;21159.471013224793;21285.46786330323;21310;21361.14555417766;1022.5705203814416;1025.661531694539;1039.6205385034407;1043.9947800261102;1077.7467295185625;11316.20786544934;11633.418329083512;11801.645950621494;11823.76352472963;11863;545422;565711;597492;613533;617294;98216;99325;101205;102858;105940.47029764802;931.1666058877403;1060.750723579958;1086.7826434713088;1099.0383414512303;1100.1693721240572;19034.428967131007;19605.70591441158;19678.21287148498;19768.209271628974;19813.801861981774;45351.54648453473;46920.530794691615;47380.52619473761;47410.52589474061;47510;61640;64684;64900.35099648943;66438.66780666065;66694.33305667076;8514.191151840565;8677.826443471222;8747.693830715894;8813.471191728517;8899.466032038099;13295.601131966056;13695.931520342334;14040.227787471378;14639.92680036593;14655.853441465875;12332.876671233531;12778;12948.482060717466;12974.091813572959;13089.803652945404;12270.509179632714;12436.316002619942;12751.48994040228;12952.611421656988;13201.933990329986;12496.312702801433;12574.748505030031;12704.36478176106;12849.164804287691;13121.49102853146;9289.489078100769;9321.906780932104;9349.719508414486;9370.906290937004;9712.75718107053;9433.29250306216;11443.370614616277;12132;12142.757144856876;12787 04:22:18 INFO - PROCESS | 19669 | |3;mootools.html;1543.7993060902083;1575.5667191522332;1757.947261582153;1813.4559632110363;1846.1046392499643;9452.574634141463;9876.407415555072;10084.688990431243;10167.440790756506;10257.333273337228;9973.351732137424;10089;10117.595296188161;10144.898551014488;10155.441450720207;2678.142994241848;2726.6046423268713;2726.8636568171514;2728;2731.289864635189;2574.948501029978;2646.6691663542056;2648.1261183809393;2648.980142645086;2653.5886937524715;2632.7104018557943;2674.7860171186358;2675.3445405875586;2676.8260063095836;2679.3435608276;2577.201067669029;2594.455164415466;2633.539130652138;2644.761971422581;2660.6807183137953;2593.766561009499;2594.2736033910537;2597.2078516052597;2600.3499125218696;2637.3406648337914;9944.950275248577;10119.392836429837;10134.13859821916;10140.797184056277;10147.086762191364;5830.475257226827;5958.910616340759;5962.403759624046;5963.165156878041;5986.431289027579;3727.235916637083;3818.9618103818884;3874.2832575973252;3962.9009274768073;4040.2223920634005;1248.2635245205372;1265.2851139106376;1274.9171303865312;1278.4055414232334;1280.3022352817736;14125.081869678437;14215.431382744679;14239.50161744334;14241.71516569673;14261.001729878913;4911.803527858917;4933.112039832865;5081.136206844772;5111.156659151198;5202.3497062867145;10988.230823842414;11001.889981100247;11003.22977391575;11008.889911100787;11047.779044419067;5919.082542205965;5925.881482370414;5932.525397968238;5940.108983652487;5944.583879128506;4812.494688057774;5380.596455265871;5492.462110609036;5510.035743744828;5525.972370138124;4340.65274778017;4394.868153955386;4513.684042117086;4515.525869783691;4540.614047805973;1260;1261.7161138743893;1276.8786965238287;1283.2749496534427;1284.1396264502805;1098.8626421697288;1101.7465982823996;1103.25530267071;1110.3171549497001;1115.9274647147909;6717.093192419059;6726.091977583062;6726.7981960541265;6971.51199416036;7014.088168538057;527.3329238513284;528.183955788308;529.3118945371002;544.768473398804;1067.7330667333167;4532.478764942074;4649.790759415834;4654.185517534418;4666.789994450258;4717.669763116549;12202.694932626579;12310.692232694255;12586.18189817659;12591.496340146476;12752.362381880868;12299.262044277371;12383.947364473941;12392.504299828086;12397.256164630151;12404.81392779109;8877.422967507091;9174.495402752913;9238.260939124853;9246.86129708055;9288.814223715488;6908.3091690830515;6943.340382663639;7008.474364422791;7013.29867013315;7067.081279433641;11408.315501069963;11473.196876218584;11562.19064665499;11715.941420292844;11751.118666099906;11663.183577149519;11766.647000589996;11834.112441566745;11877.58428455;11925.821112683143;7701.92298077012;8132.837343252983;8286.502809831429;8363.498190108612;8465.873011904703;9750.902490974999;9876.85184722244;9877;9897.257705672248;9907.653232136841;8371.37214708887;8412.747617571482;8468.576571171294;8493.23560879499;8648.913510864812;8445.408821382443;8555;8616.698415555426;8680.652773889226;8716.43343182691;8022.157673444204;8029.7189598363775;8165.673373065011;8202.26179643835;8216.301614362847;5867.882642347044;5908.084246941731;6001.759929602942;6066.423689749467;6137.693115344304;5999.970000150146;6020.217371741645;6063.151158837678;6165.630062196283;6186.876262474635 04:22:18 INFO - PROCESS | 19669 | |4;prototype.html;355.1972542054955;362.2103813686165;363.32784348954436;364.09885533305055;366.7414472796677;5868.530517558595;5882.529397648189;5951.523878089753;5975.282966044081;5997.970010149948;5850.736716847741;5857.4435428634315;5869.7358618862145;5891.145783861338;5891.675957822318;4597.862064138081;4614.515475875027;4623.8150473981;4624.283236098393;4630.305454181866;4507.909841803162;4562.133194693014;4572.513932971781;4583.945692490729;4609.1473077480605;4482.394876691637;4496.685232033759;4508.368828364031;4534.909301813962;4554.521775213605;4541.750203738793;4546.249868771649;4547.113312903985;4576.633869290449;4592.47186573545;3904.2386734586767;3934.9016274593077;4027.3153563893916;4045.292073887058;4059.5940405959464;5675.51758100562;5703.600747947646;5714.485696287354;5722.084466485342;5822.912656310159;5181.740912954338;5196.53231209193;5205.297284866532;5240.475952404767;5253.816116435944;5904.232449781543;6086.726097325631;6112.847178820521;6134.006447904449;6202.472789812871;4367.301231802896;4378.846740364103;4386.583274588909;4412.911741765147;4428.844990425352;6339.968300158515;6444.162258906359;6445.645489498076;6468.256150542701;6510.609363438161;4472.686911916199;4494.9325760113625;4498.977505112453;4505.256632655575;4509.075639493896;4577.244754615451;4578.381918440968;4579.175748365326;4580.152671755669;4581.633469322446;5156.329677142023;5229.921551176735;5270.631055826056;5280.471952804765;5288.233206185082;5978.402159784074;6134.018557030854;6187.721552530147;6216.502679785606;6231.906521402183;1551.2321400906624;1566.4908904606048;1574.2207607234493;1574.2286279722853;1574.4174655377583;985.1429256546706;999.9350042247231;1005.2109094360892;1017.6590842067842;1021.6117875207374;5201.973990130025;5204.386640141568;5244.265802787613;5261.842144735664;5305.320812989416;5550;5551.944480555143;5553.361363443256;5579.38626751057;5613.382527921925;4979.278004689299;5231.901300726814;5248;5273.288106105627;5309.65487243328;2947.4252520758673;2971.465136275491;2975.895843645462;2978.910632681023;2985.6118704568266;5674.886502270014;5708.686022268815;5800;5805.36141024487;5815.41845815415;5948.910766338508;6391.456726178327;6455.580387274812;6491.857686963291;6522.673866306665;6636.336366363325;6637.435817955431;6652.900206496906;6655.600663960081;6707.966460167668;6151.323354431099;6289.371062893674;6316.463100636497;6342.7145778441;6414.647194404352;6274.341194174728;6280.591761535486;6341.460975816923;6358.650274234961;6369.87260254783;6302.401271879165;6522.325846403141;6606.834829129118;6629.171353580802;6638.435732962752;4467.721462054441;4477.238869392277;4488.304312831517;4532.818687252473;4554.157480866051;6200.255969283535;6393.29673735898;6487.658855689229;6504.674766261763;6510.153680021567;6154.630722156685;6157.6613286269685;6166.167567378347;6182.536309776875;6196.566240363311;6075.450760056157;6161.075838624242;6198.473129784019;6233.252009758858;6269.216347956505;6119;6130.7241174146375;6174.14775567337;6229.345918678474;6235.96882015587;6247.187865577627;6257.121724007008;6265.404786545271;6293.244810622755;6339.366063393623;5822.388649191943;6014.27828660546;6028.3971602839365;6029.336772955059;6138.171346868295 04:22:18 INFO - PROCESS | 19669 | |5;yui.html;801.5471258738816;810.0401024785626;839.9286060684841;848.1857416879797;851.9787005324868;15453.45912893049;16495.092769897652;16554.668906621875;16639.83360166398;18211.27154913805;16364.263608137633;16642;16692.66614667706;16709.498715038568;16723.749143762823;889.8576227803553;895.2211575928951;913.0823522360018;923.6720964057763;925.6158694141923;920.3419555018161;920.6041402197053;923.3029063057382;924.3529529329496;924.5469719837265;972.7811242470458;974.7660561465268;976.8290549153905;977.4965892565299;978.7895602445473;969.6509256667629;970.5341436110671;971.281251873612;971.4122955611895;973.1387721866129;714.7998560403096;715.3597530210485;715.4383808710189;715.8389362393472;717.2755516927888;16950;17430.389936352167;17430.47708568745;17470.563235919075;17473.21370538329;15971.840281597151;16065.518034458868;16582.419615313527;16855.57861053471;17115.31538738449;13127.86872131276;13301;13338.666533336647;13667.794983075262;13824.516141934984;3963.128111815396;4148.62662360386;4195.979020104911;4219.324908014733;4254.638355739766;83267.0450313575;83625.16374836235;83867.5806620963;83896;84109;12281.385930703429;12398.876011239952;12650.81023784644;12762.10665253442;12770.23378597287;21821.127154913625;21851.78148218529;21869.234576789735;21891;21929.780702192773;8821.426607270507;8898.822023559622;9135.132162444557;9224.538773061455;9348.252139828797;4905.583025442806;4926.359573255454;5009.7495125243595;5011.8496445105975;5018.899622007612;3881.825317860703;4016.256992456405;4029.6776257899883;4031;4093.89765255871;715.6421789105448;723.8769409200344;730.0399974034128;735.7608777147342;735.8160459885029;739.7189068154067;810.9189081091844;839.4585492357518;856.5802756649197;867.0635713429481;10649.9467502662;10742.207026173252;10928.890711092787;11564;11729.589464368706;725.8548290341953;731.0861423220974;775.3564541430599;814.1126172472034;815.6778072661266;4841.298011788342;5403.621746477709;5448.400675925645;5462.235287059815;5504.587155963239;114384.42807785908;117159.41420293014;117758.41120794341;117768;118618;99210;99608;99639.51261705805;99890.50054749679;100466;83512.99999999878;88423.55788221018;89341.10658893458;90839.54580227057;92159.53920230355;10492.632757853438;10798.892011079788;11054.557817687202;11096.500657470595;11275.66173014811;52339.90640374342;52799.73600131975;53316;54876.451235488734;54947.72526137344;68446.65776671085;69184.65407673131;75354.98580056736;75684.62157689397;76960.61519692365;13118.606441806762;13229.007824413015;13307.866921330662;13348.799768003293;13610.183388996691;15565.299561519532;15876;16784.916075419544;17175.141242937552;17272.309107635552;13296.468141274627;13305.46778128864;13358.666033349244;13674.521391751241;14451.349689264218;13703;13991.370388332753;14279.42882284697;14443.277836108362;14740.778888316469;13827.51603693866;14266.71466570642;14466.855331446972;14485.203313817841;14487.782683259971;12295.631131066082;12690.238585684889;12819.871801282241;12859.807102893277;12995.350232488148;12726.809097863354;12823.166494177849;12826.166299190523;12857;13185.934070329587 04:22:18 INFO - PROCESS | 19669 | __end_tp_report 04:22:18 INFO - PROCESS | 19669 | __start_cc_report 04:22:18 INFO - PROCESS | 19669 | _x_x_mozilla_cycle_collect,358 04:22:18 INFO - PROCESS | 19669 | __end_cc_report 04:22:18 INFO - PROCESS | 19669 | __startTimestamp1474975338278__endTimestamp 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | ------- Summary: start ------- 04:22:18 INFO - PROCESS | 19669 | Number of tests: 6 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | [#0] dojo.html Cycles:165 Average:5834.06 Median:6052.94 stddev:700.34 (11.6%) stddev-sans-first:673.13 04:22:18 INFO - PROCESS | 19669 | Values: 3276.7 3295.3 3299.3 3302.1 3324.5 5759.3 5773.9 5779.2 5803.6 5810.6 5889.9 5951.0 5958.3 5962.8 5982.1 5306.0 5356.8 5357.0 5414.4 5482.1 5228.1 5234.4 5278.4 5285.6 5336.4 5287.8 5297.5 5358.6 5387.9 5450.3 5374.2 5378.3 5389.5 5389.7 5412.5 5044.7 5126.0 5159.3 5311.7 5343.0 5735.0 5820.6 5820.7 5828.5 5856.6 6221.4 6282.0 6289.6 6294.5 6298.2 6001.8 6141.2 6283.2 6289.3 6318.8 5827.5 5925.9 5932.4 5956.6 5967.0 6457.8 6481.4 6502.9 6511.1 6511.1 6000.0 6103.0 6218.6 6222.9 6225.3 6201.9 6288.2 6330.6 6333.8 6340.3 6307.7 6315.5 6316.5 6327.6 6332.1 5968.3 6058.8 6293.3 6301.0 6320.4 4723.1 4738.2 4759.8 4793.4 4793.4 4222.6 4226.1 4228.3 4236.5 4254.3 5739.9 5899.7 5925.7 5968.1 5988.3 6321.3 6388.6 6410.4 6436.8 6446.2 6016.8 6043.8 6067.0 6073.0 6079.9 5066.9 5172.2 5271.5 5272.3 5290.4 6519.3 6587.6 6629.6 6633.9 6647.4 6390.0 6404.3 6404.6 6408.6 6430.5 6206.6 6428.2 6579.7 6581.4 6630.2 6155.0 6253.5 6269.1 6274.4 6276.9 6431.4 6432.4 6433.9 6434.7 6443.5 6008.8 6011.5 6236.5 6243.9 6248.6 6057.6 6099.4 6108.1 6110.8 6135.7 6042.4 6044.6 6048.2 6063.2 6087.6 5882.4 6078.8 6133.3 6169.5 6170.9 5996.8 6052.9 6084.9 6120.7 6121.3 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | [#1] ext.html Cycles:180 Average:67050.43 Median:46374.92 stddev:135732.73 (292.7%) stddev-sans-first:136021.70 04:22:18 INFO - PROCESS | 19669 | Values: 565.7 630.5 639.4 642.0 696.2 42416.4 46892.8 46895.0 46908.3 47095.3 47827.0 48349.3 48374.5 48499.8 48583.5 9172.3 9352.5 9364.6 9374.8 9376.3 9187.6 9303.6 9319.2 9324.1 9334.5 9314.6 9318.7 9320.0 9326.7 9346.0 9310.4 9314.1 9323.3 9350.6 9364.6 9203.4 9282.8 9291.6 9295.9 9300.0 44425.0 44990.0 45105.8 45124.3 45179.3 3888.5 4031.9 4135.2 4450.2 4777.8 34727.7 35745.3 35837.3 36105.6 36470.8 4762.3 4782.9 4788.4 4841.2 4854.9 376474.0 378685.0 380774.0 384081.0 384635.0 66394.7 66619.0 66685.0 66861.3 66935.0 40474.6 41389.2 41444.2 43873.8 43880.6 15459.5 15590.7 15596.5 15607.4 15628.7 13873.2 13874.2 14039.6 14060.0 14167.0 21076.6 21291.4 21310.1 21412.3 21534.0 7626.6 7794.4 7815.9 7866.7 7992.9 1028.9 1126.8 1210.2 1225.1 1248.6 34024.8 34089.8 34291.0 34784.7 35031.0 1150.7 1190.7 1211.6 1237.4 1244.8 18220.5 18264.3 18281.2 18384.7 18418.9 614732.0 627888.0 628809.0 630748.0 632458.0 65145.7 65606.3 65624.3 65626.3 65710.3 1405.5 1445.5 1447.7 1448.3 1469.1 33790.3 34055.3 34377.8 34762.7 35131.5 57810.1 58077.0 58126.0 58296.1 58317.0 491684.0 492123.0 494471.0 495981.0 496994.0 31537.4 31926.5 32538.0 32712.0 34221.8 52844.5 53693.0 54308.5 54508.0 55477.0 45608.8 46785.0 47061.8 47544.3 47980.8 45902.8 46063.8 46920.8 47646.0 47723.8 44802.2 45178.0 46237.3 46512.5 46610.3 39171.6 40339.0 40559.2 40635.8 41356.6 30563.7 30819.4 31053.0 31669.0 31702.4 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | [#2] jquery.html Cycles:180 Average:33091.45 Median:12926.91 stddev:96825.84 (749.0%) stddev-sans-first:97066.41 04:22:18 INFO - PROCESS | 19669 | Values: 433.8 435.6 439.1 442.7 454.4 19609.8 21233.6 21418.5 21636.2 21993.6 19917.4 20311.8 20601.3 20708.0 20735.4 5994.6 6150.8 6207.9 6211.4 6213.4 5922.3 6093.5 6103.3 6114.4 6118.1 5853.4 5971.3 6079.0 6116.8 6169.1 5914.5 6090.8 6106.5 6110.6 6126.8 6133.2 6168.8 6217.6 6229.3 6241.0 17215.5 23636.5 24026.0 24046.4 24201.9 2710.9 3008.2 3025.3 3177.5 3188.8 10427.6 10863.4 11033.1 11193.8 11289.2 1999.4 2075.5 2094.2 2188.3 2217.3 86224.5 86480.6 87071.0 87772.0 89506.0 11710.4 12005.6 12022.6 12039.8 12213.6 17303.4 17493.7 17518.3 17530.5 17565.8 8271.8 8450.2 8592.7 8649.7 8780.7 8079.0 8311.8 8535.2 8564.1 8692.7 4903.2 5147.2 5201.8 5236.2 5275.2 1946.6 2059.7 2160.1 2180.1 2184.4 944.5 1023.1 1043.0 1044.7 1052.5 20709.9 21159.5 21285.5 21310.0 21361.1 1022.6 1025.7 1039.6 1044.0 1077.7 11316.2 11633.4 11801.6 11823.8 11863.0 545422.0 565711.0 597492.0 613533.0 617294.0 98216.0 99325.0 101205.0 102858.0 105940.5 931.2 1060.8 1086.8 1099.0 1100.2 19034.4 19605.7 19678.2 19768.2 19813.8 45351.5 46920.5 47380.5 47410.5 47510.0 61640.0 64684.0 64900.4 66438.7 66694.3 8514.2 8677.8 8747.7 8813.5 8899.5 13295.6 13695.9 14040.2 14639.9 14655.9 12332.9 12778.0 12948.5 12974.1 13089.8 12270.5 12436.3 12751.5 12952.6 13201.9 12496.3 12574.7 12704.4 12849.2 13121.5 9289.5 9321.9 9349.7 9370.9 9712.8 9433.3 11443.4 12132.0 12142.8 12787.0 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | [#3] mootools.html Cycles:180 Average:6568.72 Median:4001.56 stddev:3771.88 (94.3%) stddev-sans-first:3763.55 04:22:18 INFO - PROCESS | 19669 | Values: 1543.8 1575.6 1757.9 1813.5 1846.1 9452.6 9876.4 10084.7 10167.4 10257.3 9973.4 10089.0 10117.6 10144.9 10155.4 2678.1 2726.6 2726.9 2728.0 2731.3 2574.9 2646.7 2648.1 2649.0 2653.6 2632.7 2674.8 2675.3 2676.8 2679.3 2577.2 2594.5 2633.5 2644.8 2660.7 2593.8 2594.3 2597.2 2600.3 2637.3 9945.0 10119.4 10134.1 10140.8 10147.1 5830.5 5958.9 5962.4 5963.2 5986.4 3727.2 3819.0 3874.3 3962.9 4040.2 1248.3 1265.3 1274.9 1278.4 1280.3 14125.1 14215.4 14239.5 14241.7 14261.0 4911.8 4933.1 5081.1 5111.2 5202.3 10988.2 11001.9 11003.2 11008.9 11047.8 5919.1 5925.9 5932.5 5940.1 5944.6 4812.5 5380.6 5492.5 5510.0 5526.0 4340.7 4394.9 4513.7 4515.5 4540.6 1260.0 1261.7 1276.9 1283.3 1284.1 1098.9 1101.7 1103.3 1110.3 1115.9 6717.1 6726.1 6726.8 6971.5 7014.1 527.3 528.2 529.3 544.8 1067.7 4532.5 4649.8 4654.2 4666.8 4717.7 12202.7 12310.7 12586.2 12591.5 12752.4 12299.3 12383.9 12392.5 12397.3 12404.8 8877.4 9174.5 9238.3 9246.9 9288.8 6908.3 6943.3 7008.5 7013.3 7067.1 11408.3 11473.2 11562.2 11715.9 11751.1 11663.2 11766.6 11834.1 11877.6 11925.8 7701.9 8132.8 8286.5 8363.5 8465.9 9750.9 9876.9 9877.0 9897.3 9907.7 8371.4 8412.7 8468.6 8493.2 8648.9 8445.4 8555.0 8616.7 8680.7 8716.4 8022.2 8029.7 8165.7 8202.3 8216.3 5867.9 5908.1 6001.8 6066.4 6137.7 6000.0 6020.2 6063.2 6165.6 6186.9 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | [#4] prototype.html Cycles:180 Average:5111.86 Median:5706.14 stddev:1522.68 (26.7%) stddev-sans-first:1484.51 04:22:18 INFO - PROCESS | 19669 | Values: 355.2 362.2 363.3 364.1 366.7 5868.5 5882.5 5951.5 5975.3 5998.0 5850.7 5857.4 5869.7 5891.1 5891.7 4597.9 4614.5 4623.8 4624.3 4630.3 4507.9 4562.1 4572.5 4583.9 4609.1 4482.4 4496.7 4508.4 4534.9 4554.5 4541.8 4546.2 4547.1 4576.6 4592.5 3904.2 3934.9 4027.3 4045.3 4059.6 5675.5 5703.6 5714.5 5722.1 5822.9 5181.7 5196.5 5205.3 5240.5 5253.8 5904.2 6086.7 6112.8 6134.0 6202.5 4367.3 4378.8 4386.6 4412.9 4428.8 6340.0 6444.2 6445.6 6468.3 6510.6 4472.7 4494.9 4499.0 4505.3 4509.1 4577.2 4578.4 4579.2 4580.2 4581.6 5156.3 5229.9 5270.6 5280.5 5288.2 5978.4 6134.0 6187.7 6216.5 6231.9 1551.2 1566.5 1574.2 1574.2 1574.4 985.1 999.9 1005.2 1017.7 1021.6 5202.0 5204.4 5244.3 5261.8 5305.3 5550.0 5551.9 5553.4 5579.4 5613.4 4979.3 5231.9 5248.0 5273.3 5309.7 2947.4 2971.5 2975.9 2978.9 2985.6 5674.9 5708.7 5800.0 5805.4 5815.4 5948.9 6391.5 6455.6 6491.9 6522.7 6636.3 6637.4 6652.9 6655.6 6708.0 6151.3 6289.4 6316.5 6342.7 6414.6 6274.3 6280.6 6341.5 6358.7 6369.9 6302.4 6522.3 6606.8 6629.2 6638.4 4467.7 4477.2 4488.3 4532.8 4554.2 6200.3 6393.3 6487.7 6504.7 6510.2 6154.6 6157.7 6166.2 6182.5 6196.6 6075.5 6161.1 6198.5 6233.3 6269.2 6119.0 6130.7 6174.1 6229.3 6236.0 6247.2 6257.1 6265.4 6293.2 6339.4 5822.4 6014.3 6028.4 6029.3 6138.2 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - PROCESS | 19669 | [#5] yui.html Cycles:180 Average:21840.51 Median:4062.45 stddev:30545.24 (751.9%) stddev-sans-first:30590.07 04:22:18 INFO - PROCESS | 19669 | Values: 801.5 810.0 839.9 848.2 852.0 15453.5 16495.1 16554.7 16639.8 18211.3 16364.3 16642.0 16692.7 16709.5 16723.7 889.9 895.2 913.1 923.7 925.6 920.3 920.6 923.3 924.4 924.5 972.8 974.8 976.8 977.5 978.8 969.7 970.5 971.3 971.4 973.1 714.8 715.4 715.4 715.8 717.3 16950.0 17430.4 17430.5 17470.6 17473.2 15971.8 16065.5 16582.4 16855.6 17115.3 13127.9 13301.0 13338.7 13667.8 13824.5 3963.1 4148.6 4196.0 4219.3 4254.6 83267.0 83625.2 83867.6 83896.0 84109.0 12281.4 12398.9 12650.8 12762.1 12770.2 21821.1 21851.8 21869.2 21891.0 21929.8 8821.4 8898.8 9135.1 9224.5 9348.3 4905.6 4926.4 5009.7 5011.8 5018.9 3881.8 4016.3 4029.7 4031.0 4093.9 715.6 723.9 730.0 735.8 735.8 739.7 810.9 839.5 856.6 867.1 10649.9 10742.2 10928.9 11564.0 11729.6 725.9 731.1 775.4 814.1 815.7 4841.3 5403.6 5448.4 5462.2 5504.6 114384.4 117159.4 117758.4 117768.0 118618.0 99210.0 99608.0 99639.5 99890.5 100466.0 83513.0 88423.6 89341.1 90839.5 92159.5 10492.6 10798.9 11054.6 11096.5 11275.7 52339.9 52799.7 53316.0 54876.5 54947.7 68446.7 69184.7 75355.0 75684.6 76960.6 13118.6 13229.0 13307.9 13348.8 13610.2 15565.3 15876.0 16784.9 17175.1 17272.3 13296.5 13305.5 13358.7 13674.5 14451.3 13703.0 13991.4 14279.4 14443.3 14740.8 13827.5 14266.7 14466.9 14485.2 14487.8 12295.6 12690.2 12819.9 12859.8 12995.4 12726.8 12823.2 12826.2 12857.0 13185.9 04:22:18 INFO - PROCESS | 19669 | -------- Summary: end -------- 04:22:18 INFO - PROCESS | 19669 | 04:22:18 INFO - TEST-INFO | 19669: exit 0 04:22:18 INFO - TEST-OK | dromaeo_css | took 1110169ms 04:22:18 INFO - TEST-START | kraken 04:22:18 INFO - operating with platform_type : linux_ 04:22:18 INFO - Initialising browser for kraken test... 04:22:18 INFO - TEST-INFO | started process 19919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqwLn2/profile http://localhost:47457/getInfo.html) 04:22:23 INFO - PROCESS | 19919 | __metrics Screen width/height:1600/1200 04:22:23 INFO - PROCESS | 19919 | colorDepth:24 04:22:23 INFO - PROCESS | 19919 | Browser inner width/height: 1024/697 04:22:23 INFO - PROCESS | 19919 | __metrics 04:22:23 ERROR - PROCESS | 19919 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:22:24 INFO - TEST-INFO | 19919: exit 0 04:22:24 INFO - Browser initialized. 04:22:24 INFO - Running cycle 1/1 for kraken test... 04:22:24 INFO - TEST-INFO | started process 20044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqwLn2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:36 INFO - PROCESS | 20044 | RSS: Main: 149364736 04:22:36 INFO - PROCESS | 20044 | 04:22:38 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47457/tests/kraken/driver.html?testName=audio-beat-detection) 04:22:39 INFO - PROCESS | 20044 | RSS: Main: 156213248 04:22:39 INFO - PROCESS | 20044 | 04:22:42 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47457/tests/kraken/driver.html?testName=audio-dft) 04:22:42 INFO - PROCESS | 20044 | RSS: Main: 154992640 04:22:42 INFO - PROCESS | 20044 | 04:22:45 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47457/tests/kraken/driver.html?testName=audio-fft) 04:22:46 INFO - PROCESS | 20044 | RSS: Main: 155791360 04:22:46 INFO - PROCESS | 20044 | 04:22:48 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47457/tests/kraken/driver.html?testName=audio-oscillator) 04:22:49 INFO - PROCESS | 20044 | RSS: Main: 155578368 04:22:49 INFO - PROCESS | 20044 | 04:22:51 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47457/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:51 INFO - PROCESS | 20044 | RSS: Main: 155406336 04:22:51 INFO - PROCESS | 20044 | 04:22:54 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47457/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:55 INFO - PROCESS | 20044 | RSS: Main: 155783168 04:22:55 INFO - PROCESS | 20044 | 04:22:58 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47457/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:59 INFO - PROCESS | 20044 | RSS: Main: 156078080 04:22:59 INFO - PROCESS | 20044 | 04:23:02 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47457/tests/kraken/driver.html?testName=json-parse-financial) 04:23:02 INFO - PROCESS | 20044 | RSS: Main: 156340224 04:23:02 INFO - PROCESS | 20044 | 04:23:04 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47457/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:23:05 INFO - PROCESS | 20044 | RSS: Main: 155144192 04:23:05 INFO - PROCESS | 20044 | 04:23:06 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:23:07 INFO - PROCESS | 20044 | RSS: Main: 156205056 04:23:07 INFO - PROCESS | 20044 | 04:23:09 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:23:10 INFO - PROCESS | 20044 | RSS: Main: 156856320 04:23:10 INFO - PROCESS | 20044 | 04:23:12 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:23:13 INFO - PROCESS | 20044 | RSS: Main: 156254208 04:23:13 INFO - PROCESS | 20044 | 04:23:15 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:23:16 INFO - PROCESS | 20044 | RSS: Main: 156815360 04:23:16 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | Cycle 1(1): loaded http://localhost:47457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47457/tests/kraken/driver.html?testName=ai-astar) 04:23:18 INFO - PROCESS | 20044 | RSS: Main: 158400512 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | __start_tp_report 04:23:18 INFO - PROCESS | 20044 | _x_x_mozilla_page_load 04:23:18 INFO - PROCESS | 20044 | _x_x_mozilla_page_load_details 04:23:18 INFO - PROCESS | 20044 | |i|pagename|runs| 04:23:18 INFO - PROCESS | 20044 | |0;ai-astar;102;111;104;111;110;112;109;109;110;110 04:23:18 INFO - PROCESS | 20044 | |1;audio-beat-detection;142;114;137;171;124;145;149;118;183;122 04:23:18 INFO - PROCESS | 20044 | |2;audio-dft;161;162;162;161;162;162;162;159;161;161 04:23:18 INFO - PROCESS | 20044 | |3;audio-fft;75;75;77;188;74;75;74;75;163;77 04:23:18 INFO - PROCESS | 20044 | |4;audio-oscillator;83;83;153;84;83;84;146;83;83;152 04:23:18 INFO - PROCESS | 20044 | |5;imaging-gaussian-blur;117;118;118;117;116;117;117;118;118;117 04:23:18 INFO - PROCESS | 20044 | |6;imaging-darkroom;147;146;148;147;147;146;149;147;147;146 04:23:18 INFO - PROCESS | 20044 | |7;imaging-desaturate;95;96;96;97;96;95;96;95;95;95 04:23:18 INFO - PROCESS | 20044 | |8;json-parse-financial;53;50;51;52;55;53;52;51;51;54 04:23:18 INFO - PROCESS | 20044 | |9;json-stringify-tinderbox;62;60;60;60;60;59;59;60;62;61 04:23:18 INFO - PROCESS | 20044 | |10;stanford-crypto-aes;73;72;72;73;72;71;73;73;71;76 04:23:18 INFO - PROCESS | 20044 | |11;stanford-crypto-ccm;117;126;125;129;131;117;122;122;154;128 04:23:18 INFO - PROCESS | 20044 | |12;stanford-crypto-pbkdf2;156;155;150;154;150;150;155;151;150;149 04:23:18 INFO - PROCESS | 20044 | |13;stanford-crypto-sha256-iterative;61;62;64;62;62;60;64;61;60;60 04:23:18 INFO - PROCESS | 20044 | __end_tp_report 04:23:18 INFO - PROCESS | 20044 | __start_cc_report 04:23:18 INFO - PROCESS | 20044 | _x_x_mozilla_cycle_collect,880 04:23:18 INFO - PROCESS | 20044 | __end_cc_report 04:23:18 INFO - PROCESS | 20044 | __startTimestamp1474975398345__endTimestamp 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | ------- Summary: start ------- 04:23:18 INFO - PROCESS | 20044 | Number of tests: 14 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.22 (2.9%) stddev-sans-first:2.30 04:23:18 INFO - PROCESS | 20044 | Values: 102.0 111.0 104.0 111.0 110.0 112.0 109.0 109.0 110.0 110.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:143.50 stddev:22.77 (15.9%) stddev-sans-first:24.15 04:23:18 INFO - PROCESS | 20044 | Values: 142.0 114.0 137.0 171.0 124.0 145.0 149.0 118.0 183.0 122.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 04:23:18 INFO - PROCESS | 20044 | Values: 161.0 162.0 162.0 161.0 162.0 162.0 162.0 159.0 161.0 161.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:42.69 (56.9%) stddev-sans-first:44.64 04:23:18 INFO - PROCESS | 20044 | Values: 75.0 75.0 77.0 188.0 74.0 75.0 74.0 75.0 163.0 77.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:83.00 stddev:32.44 (39.1%) stddev-sans-first:33.56 04:23:18 INFO - PROCESS | 20044 | Values: 83.0 83.0 153.0 84.0 83.0 84.0 146.0 83.0 83.0 152.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:23:18 INFO - PROCESS | 20044 | Values: 117.0 118.0 118.0 117.0 116.0 117.0 117.0 118.0 118.0 117.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 04:23:18 INFO - PROCESS | 20044 | Values: 147.0 146.0 148.0 147.0 147.0 146.0 149.0 147.0 147.0 146.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 04:23:18 INFO - PROCESS | 20044 | Values: 95.0 96.0 96.0 97.0 96.0 95.0 96.0 95.0 95.0 95.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.55 (3.0%) stddev-sans-first:1.62 04:23:18 INFO - PROCESS | 20044 | Values: 53.0 50.0 51.0 52.0 55.0 53.0 52.0 51.0 51.0 54.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:1.06 (1.8%) stddev-sans-first:0.93 04:23:18 INFO - PROCESS | 20044 | Values: 62.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 62.0 61.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:73.00 stddev:1.43 (2.0%) stddev-sans-first:1.51 04:23:18 INFO - PROCESS | 20044 | Values: 73.0 72.0 72.0 73.0 72.0 71.0 73.0 73.0 71.0 76.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:127.00 stddev:10.57 (8.3%) stddev-sans-first:10.56 04:23:18 INFO - PROCESS | 20044 | Values: 117.0 126.0 125.0 129.0 131.0 117.0 122.0 122.0 154.0 128.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:152.50 stddev:2.67 (1.7%) stddev-sans-first:2.40 04:23:18 INFO - PROCESS | 20044 | Values: 156.0 155.0 150.0 154.0 150.0 150.0 155.0 151.0 150.0 149.0 04:23:18 INFO - PROCESS | 20044 | 04:23:18 INFO - PROCESS | 20044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.51 (2.4%) stddev-sans-first:1.58 04:23:18 INFO - PROCESS | 20044 | Values: 61.0 62.0 64.0 62.0 62.0 60.0 64.0 61.0 60.0 60.0 04:23:18 INFO - PROCESS | 20044 | -------- Summary: end -------- 04:23:18 INFO - PROCESS | 20044 | 04:23:19 INFO - TEST-INFO | 20044: exit 0 04:23:19 INFO - TEST-OK | kraken | took 60365ms 04:23:19 INFO - SUITE-END | took 1170s 04:23:19 INFO - Completed test suite (00:19:30) 04:23:19 INFO - javascript benchmark 04:23:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7935.120700808328, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.6559511251317, 3295.32445848601, 3299.3071454994465, 3302.1414432247607, 3324.5179448979898, 5759.251297331346, 5773.942260577388, 5779.21980532628, 5803.6227645203035, 5810.5932584719085, 5889.85275368116, 5951.0, 5958.344582095966, 5962.821115366546, 5982.132590774335, 5305.973470132644, 5356.839294821161, 5357.0, 5414.377346605132, 5482.068048431776, 5228.137357336035, 5234.42421333653, 5278.392984806758, 5285.603579731516, 5336.4129945705945, 5287.841364759063, 5297.496737809902, 5358.571314294866, 5387.892242155154, 5450.264214331054, 5374.193870919355, 5378.300820893279, 5389.51494365507, 5389.676619402849, 5412.485813847678, 5044.672096313765, 5125.974370128126, 5159.25190847325, 5311.681299122065, 5343.0, 5735.0, 5820.563457740686, 5820.708964551755, 5828.475437210629, 5856.619319744245, 6221.408966148254, 6282.026285925689, 6289.622622642656, 6294.527910406738, 6298.212723409574, 6001.849953751147, 6141.17917434816, 6283.151774510428, 6289.276733175698, 6318.778842740528, 5827.533797296206, 5925.851853703692, 5932.436418540188, 5956.583039187259, 5967.015442452033, 6457.806265812033, 6481.449076828522, 6502.902456463157, 6511.088447617338, 6511.120998665215, 6000.0, 6102.9930061540235, 6218.626882387071, 6222.875542489215, 6225.252969643671, 6201.937980620226, 6288.245410550763, 6330.620162790247, 6333.809985700436, 6340.270868850049, 6307.747690092437, 6315.463185629273, 6316.463100636497, 6327.620342779448, 6332.145160403286, 5968.313643930916, 6058.787942421994, 6293.30773614902, 6300.9684951574945, 6320.367963203643, 4723.055388922229, 4738.194506933761, 4759.785809638574, 4793.400824896888, 4793.448753393334, 4222.577742225814, 4226.091390351089, 4228.344606585984, 4236.4704411948505, 4254.340577210537, 5739.942600574024, 5899.734511946973, 5925.73334199962, 5968.134620480006, 5988.251468566429, 6321.273053598895, 6388.616682999035, 6410.423061924449, 6436.774712885027, 6446.161998940108, 6016.819495415145, 6043.788467403708, 6067.0, 6073.0, 6079.939200608026, 5066.923996140061, 5172.172452407597, 5271.499207575274, 5272.288241087481, 5290.365156181206, 6519.250286217051, 6587.604743715392, 6629.635370054693, 6633.86732265352, 6647.368499992493, 6390.0, 6404.327545607644, 6404.615723056631, 6408.58344207625, 6430.453411460078, 6206.596571222856, 6428.19647544057, 6579.703913323816, 6581.3747693969, 6630.171228596426, 6155.045967874987, 6253.499720022296, 6269.090981807703, 6274.435300822948, 6276.874462510633, 6431.356864313719, 6432.35676432353, 6433.871322573429, 6434.67826608677, 6443.484521238196, 6008.849778755566, 6011.549133814894, 6236.532260080421, 6243.875122497616, 6248.593841400295, 6057.606255593372, 6099.420555047263, 6108.0688921796145, 6110.801781737137, 6135.723892424762, 6042.395760423922, 6044.607100538451, 6048.183495228264, 6063.242094738158, 6087.634741915499, 5882.382349853204, 6078.787242446493, 6133.294671112879, 6169.537284703575, 6170.9074363885475, 5996.820095396971, 6052.939470605237, 6084.908726369196, 6120.693965301806, 6121.265448146251], "value": 5783.960756784587, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7369323264684, 630.5491573524929, 639.3574457670044, 641.9696387298385, 696.1506961506959, 42416.36375454371, 46892.76553617236, 46895.0, 46908.29637555435, 47095.29357059647, 47827.0, 48349.274760878616, 48374.51625483744, 48499.75750121244, 48583.51416485834, 9172.266218702487, 9352.532373381304, 9364.625414983393, 9374.812503749921, 9376.343655944087, 9187.586558604846, 9303.581338839735, 9319.207867331252, 9324.114209150153, 9334.53327333634, 9314.627414903396, 9318.673846415377, 9320.02139775324, 9326.720198394025, 9346.0, 9310.441373517542, 9314.068593140699, 9323.347365684405, 9350.579223934872, 9364.625414983393, 9203.40177888435, 9282.814343713088, 9291.628334866597, 9295.860562091573, 9299.953500232523, 44425.0, 44990.0, 45105.774471127435, 45124.323135153, 45179.32231016537, 3888.4556162137324, 4031.9395209071886, 4135.193637240739, 4450.243458612012, 4777.761111944389, 34727.6527234727, 35745.285094298226, 35837.28325433477, 36105.63894361076, 36470.81764591187, 4762.309465127537, 4782.928256076161, 4788.377510923592, 4841.2496063110275, 4854.878628034292, 376474.0, 378685.0, 380774.0, 384081.0, 384635.0, 66394.66802665955, 66619.0, 66685.0, 66861.33138668552, 66935.0, 40474.59525404767, 41389.1722165561, 41444.1711165781, 43873.78063109728, 43880.56119438765, 15459.536213913601, 15590.688186236212, 15596.454124105829, 15607.375704971673, 15628.68742625164, 13873.167609943233, 13874.236916969663, 14039.578812635636, 14060.0, 14167.0, 21076.578468430547, 21291.36125916225, 21310.147594096372, 21412.25057122993, 21534.0, 7626.618669066635, 7794.3764498839955, 7815.921840781633, 7866.685332586747, 7992.880106798402, 1028.93311934724, 1126.7802778458122, 1210.2073142091945, 1225.087309954072, 1248.5942068827667, 34024.82987585046, 34089.82955085209, 34291.0, 34784.652153478644, 35031.0, 1150.6778102131416, 1190.6844686158174, 1211.6486218996392, 1237.3813093453273, 1244.7883859743865, 18220.54448638768, 18264.263517712865, 18281.177347019417, 18384.724229136573, 18418.907905460386, 614732.0, 627888.0, 628809.0, 630748.0, 632458.0, 65145.697086058964, 65606.34393656098, 65624.34375656278, 65626.34373656298, 65710.34289657042, 1405.4588983241526, 1445.4579532675248, 1447.7466443372368, 1448.2541491132076, 1469.1111877314072, 33790.324193516484, 34055.318893621494, 34377.79677711268, 34762.65237347594, 35131.47302790409, 57810.13284800816, 58077.0, 58126.0, 58296.12555811581, 58317.0, 491684.0, 492123.0, 494471.0, 495981.0, 496994.0, 31537.369252615277, 31926.521102183022, 32538.0, 32712.018639440856, 34221.82889085539, 52844.47155528549, 53693.0, 54308.45691543192, 54508.0, 55477.0, 45608.77195614001, 46785.0, 47061.7646911777, 47544.286835698185, 47980.760096199294, 45902.770486147354, 46063.76968115272, 46920.7653961728, 47646.0, 47723.76138119426, 44802.21019731796, 45178.0, 46237.30644040409, 46512.53487465082, 46610.300845486665, 39171.608283916794, 40339.0, 40559.17483713181, 40635.796821015705, 41356.58643413527, 30563.694363056973, 30819.38361232718, 31053.0, 31669.0, 31702.365952681277], "value": 21784.89926178315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.815953581693, 435.5948967460263, 439.0713640650026, 442.7188735153178, 454.4206137175103, 19609.803901960975, 21233.57532849342, 21418.464538386546, 21636.24273150442, 21993.560128797413, 19917.40247792565, 20311.796882031176, 20601.278955236532, 20708.0, 20735.377938661826, 5994.580379373435, 6150.815475535719, 6207.937920620781, 6211.409916057967, 6213.378662133796, 5922.31893332268, 6093.512518998469, 6103.328633850273, 6114.449699527042, 6118.11287363332, 5853.443922827325, 5971.343152253248, 6079.0, 6116.816495505142, 6169.136320915076, 5914.526837852983, 6090.756369745205, 6106.542009349294, 6110.602810817282, 6126.785562505291, 6133.202683651097, 6168.845778855564, 6217.595856269328, 6229.25248970122, 6241.0, 17215.483535493957, 23636.527269454513, 24026.0, 24046.398840028964, 24201.87899060511, 2710.8644567771535, 3008.247938015496, 3025.3041800386036, 3177.507486339598, 3188.7608429367892, 10427.635032773816, 10863.402512861789, 11033.117350611932, 11193.776124477547, 11289.209755317132, 1999.4401567561106, 2075.5122546201633, 2094.204202403077, 2188.321620297713, 2217.2904670505445, 86224.54078471388, 86480.56759716161, 87071.0, 87772.0, 89506.0, 11710.355930423739, 12005.63983080509, 12022.639320820215, 12039.819402708967, 12213.633590992284, 17303.3943811966, 17493.65012699739, 17518.299268029135, 17530.47408577745, 17565.824341756674, 8271.8345633087, 8450.154984501502, 8592.742217733477, 8649.654013839376, 8780.736577902673, 8078.959605202054, 8311.833763324821, 8535.231829135408, 8564.100769419247, 8692.739217823475, 4903.239997800347, 5147.202183661539, 5201.843944681666, 5236.214567814782, 5275.208718692227, 1946.639871623754, 2059.6910463430604, 2160.0819651647985, 2180.09526046692, 2184.388371256051, 944.4899754132691, 1023.1405619279692, 1042.95828166874, 1044.749260177567, 1052.4685034057752, 20709.896450517954, 21159.471013224793, 21285.46786330323, 21310.0, 21361.14555417766, 1022.5705203814416, 1025.661531694539, 1039.6205385034407, 1043.9947800261102, 1077.7467295185625, 11316.20786544934, 11633.418329083512, 11801.645950621494, 11823.76352472963, 11863.0, 545422.0, 565711.0, 597492.0, 613533.0, 617294.0, 98216.0, 99325.0, 101205.0, 102858.0, 105940.47029764802, 931.1666058877403, 1060.750723579958, 1086.7826434713088, 1099.0383414512303, 1100.1693721240572, 19034.428967131007, 19605.70591441158, 19678.21287148498, 19768.209271628974, 19813.801861981774, 45351.54648453473, 46920.530794691615, 47380.52619473761, 47410.52589474061, 47510.0, 61640.0, 64684.0, 64900.35099648943, 66438.66780666065, 66694.33305667076, 8514.191151840565, 8677.826443471222, 8747.693830715894, 8813.471191728517, 8899.466032038099, 13295.601131966056, 13695.931520342334, 14040.227787471378, 14639.92680036593, 14655.853441465875, 12332.876671233531, 12778.0, 12948.482060717466, 12974.091813572959, 13089.803652945404, 12270.509179632714, 12436.316002619942, 12751.48994040228, 12952.611421656988, 13201.933990329986, 12496.312702801433, 12574.748505030031, 12704.36478176106, 12849.164804287691, 13121.49102853146, 9289.489078100769, 9321.906780932104, 9349.719508414486, 9370.906290937004, 9712.75718107053, 9433.29250306216, 11443.370614616277, 12132.0, 12142.757144856876, 12787.0], "value": 10005.814267196882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.7993060902083, 1575.5667191522332, 1757.947261582153, 1813.4559632110363, 1846.1046392499643, 9452.574634141463, 9876.407415555072, 10084.688990431243, 10167.440790756506, 10257.333273337228, 9973.351732137424, 10089.0, 10117.595296188161, 10144.898551014488, 10155.441450720207, 2678.142994241848, 2726.6046423268713, 2726.8636568171514, 2728.0, 2731.289864635189, 2574.948501029978, 2646.6691663542056, 2648.1261183809393, 2648.980142645086, 2653.5886937524715, 2632.7104018557943, 2674.7860171186358, 2675.3445405875586, 2676.8260063095836, 2679.3435608276, 2577.201067669029, 2594.455164415466, 2633.539130652138, 2644.761971422581, 2660.6807183137953, 2593.766561009499, 2594.2736033910537, 2597.2078516052597, 2600.3499125218696, 2637.3406648337914, 9944.950275248577, 10119.392836429837, 10134.13859821916, 10140.797184056277, 10147.086762191364, 5830.475257226827, 5958.910616340759, 5962.403759624046, 5963.165156878041, 5986.431289027579, 3727.235916637083, 3818.9618103818884, 3874.2832575973252, 3962.9009274768073, 4040.2223920634005, 1248.2635245205372, 1265.2851139106376, 1274.9171303865312, 1278.4055414232334, 1280.3022352817736, 14125.081869678437, 14215.431382744679, 14239.50161744334, 14241.71516569673, 14261.001729878913, 4911.803527858917, 4933.112039832865, 5081.136206844772, 5111.156659151198, 5202.3497062867145, 10988.230823842414, 11001.889981100247, 11003.22977391575, 11008.889911100787, 11047.779044419067, 5919.082542205965, 5925.881482370414, 5932.525397968238, 5940.108983652487, 5944.583879128506, 4812.494688057774, 5380.596455265871, 5492.462110609036, 5510.035743744828, 5525.972370138124, 4340.65274778017, 4394.868153955386, 4513.684042117086, 4515.525869783691, 4540.614047805973, 1260.0, 1261.7161138743893, 1276.8786965238287, 1283.2749496534427, 1284.1396264502805, 1098.8626421697288, 1101.7465982823996, 1103.25530267071, 1110.3171549497001, 1115.9274647147909, 6717.093192419059, 6726.091977583062, 6726.7981960541265, 6971.51199416036, 7014.088168538057, 527.3329238513284, 528.183955788308, 529.3118945371002, 544.768473398804, 1067.7330667333167, 4532.478764942074, 4649.790759415834, 4654.185517534418, 4666.789994450258, 4717.669763116549, 12202.694932626579, 12310.692232694255, 12586.18189817659, 12591.496340146476, 12752.362381880868, 12299.262044277371, 12383.947364473941, 12392.504299828086, 12397.256164630151, 12404.81392779109, 8877.422967507091, 9174.495402752913, 9238.260939124853, 9246.86129708055, 9288.814223715488, 6908.3091690830515, 6943.340382663639, 7008.474364422791, 7013.29867013315, 7067.081279433641, 11408.315501069963, 11473.196876218584, 11562.19064665499, 11715.941420292844, 11751.118666099906, 11663.183577149519, 11766.647000589996, 11834.112441566745, 11877.58428455, 11925.821112683143, 7701.92298077012, 8132.837343252983, 8286.502809831429, 8363.498190108612, 8465.873011904703, 9750.902490974999, 9876.85184722244, 9877.0, 9897.257705672248, 9907.653232136841, 8371.37214708887, 8412.747617571482, 8468.576571171294, 8493.23560879499, 8648.913510864812, 8445.408821382443, 8555.0, 8616.698415555426, 8680.652773889226, 8716.43343182691, 8022.157673444204, 8029.7189598363775, 8165.673373065011, 8202.26179643835, 8216.301614362847, 5867.882642347044, 5908.084246941731, 6001.759929602942, 6066.423689749467, 6137.693115344304, 5999.970000150146, 6020.217371741645, 6063.151158837678, 6165.630062196283, 6186.876262474635], "value": 5175.166909416103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.1972542054955, 362.2103813686165, 363.32784348954436, 364.09885533305055, 366.7414472796677, 5868.530517558595, 5882.529397648189, 5951.523878089753, 5975.282966044081, 5997.970010149948, 5850.736716847741, 5857.4435428634315, 5869.7358618862145, 5891.145783861338, 5891.675957822318, 4597.862064138081, 4614.515475875027, 4623.8150473981, 4624.283236098393, 4630.305454181866, 4507.909841803162, 4562.133194693014, 4572.513932971781, 4583.945692490729, 4609.1473077480605, 4482.394876691637, 4496.685232033759, 4508.368828364031, 4534.909301813962, 4554.521775213605, 4541.750203738793, 4546.249868771649, 4547.113312903985, 4576.633869290449, 4592.47186573545, 3904.2386734586767, 3934.9016274593077, 4027.3153563893916, 4045.292073887058, 4059.5940405959464, 5675.51758100562, 5703.600747947646, 5714.485696287354, 5722.084466485342, 5822.912656310159, 5181.740912954338, 5196.53231209193, 5205.297284866532, 5240.475952404767, 5253.816116435944, 5904.232449781543, 6086.726097325631, 6112.847178820521, 6134.006447904449, 6202.472789812871, 4367.301231802896, 4378.846740364103, 4386.583274588909, 4412.911741765147, 4428.844990425352, 6339.968300158515, 6444.162258906359, 6445.645489498076, 6468.256150542701, 6510.609363438161, 4472.686911916199, 4494.9325760113625, 4498.977505112453, 4505.256632655575, 4509.075639493896, 4577.244754615451, 4578.381918440968, 4579.175748365326, 4580.152671755669, 4581.633469322446, 5156.329677142023, 5229.921551176735, 5270.631055826056, 5280.471952804765, 5288.233206185082, 5978.402159784074, 6134.018557030854, 6187.721552530147, 6216.502679785606, 6231.906521402183, 1551.2321400906624, 1566.4908904606048, 1574.2207607234493, 1574.2286279722853, 1574.4174655377583, 985.1429256546706, 999.9350042247231, 1005.2109094360892, 1017.6590842067842, 1021.6117875207374, 5201.973990130025, 5204.386640141568, 5244.265802787613, 5261.842144735664, 5305.320812989416, 5550.0, 5551.944480555143, 5553.361363443256, 5579.38626751057, 5613.382527921925, 4979.278004689299, 5231.901300726814, 5248.0, 5273.288106105627, 5309.65487243328, 2947.4252520758673, 2971.465136275491, 2975.895843645462, 2978.910632681023, 2985.6118704568266, 5674.886502270014, 5708.686022268815, 5800.0, 5805.36141024487, 5815.41845815415, 5948.910766338508, 6391.456726178327, 6455.580387274812, 6491.857686963291, 6522.673866306665, 6636.336366363325, 6637.435817955431, 6652.900206496906, 6655.600663960081, 6707.966460167668, 6151.323354431099, 6289.371062893674, 6316.463100636497, 6342.7145778441, 6414.647194404352, 6274.341194174728, 6280.591761535486, 6341.460975816923, 6358.650274234961, 6369.87260254783, 6302.401271879165, 6522.325846403141, 6606.834829129118, 6629.171353580802, 6638.435732962752, 4467.721462054441, 4477.238869392277, 4488.304312831517, 4532.818687252473, 4554.157480866051, 6200.255969283535, 6393.29673735898, 6487.658855689229, 6504.674766261763, 6510.153680021567, 6154.630722156685, 6157.6613286269685, 6166.167567378347, 6182.536309776875, 6196.566240363311, 6075.450760056157, 6161.075838624242, 6198.473129784019, 6233.252009758858, 6269.216347956505, 6119.0, 6130.7241174146375, 6174.14775567337, 6229.345918678474, 6235.96882015587, 6247.187865577627, 6257.121724007008, 6265.404786545271, 6293.244810622755, 6339.366063393623, 5822.388649191943, 6014.27828660546, 6028.3971602839365, 6029.336772955059, 6138.171346868295], "value": 4624.686942373698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.5471258738816, 810.0401024785626, 839.9286060684841, 848.1857416879797, 851.9787005324868, 15453.45912893049, 16495.092769897652, 16554.668906621875, 16639.83360166398, 18211.27154913805, 16364.263608137633, 16642.0, 16692.66614667706, 16709.498715038568, 16723.749143762823, 889.8576227803553, 895.2211575928951, 913.0823522360018, 923.6720964057763, 925.6158694141923, 920.3419555018161, 920.6041402197053, 923.3029063057382, 924.3529529329496, 924.5469719837265, 972.7811242470458, 974.7660561465268, 976.8290549153905, 977.4965892565299, 978.7895602445473, 969.6509256667629, 970.5341436110671, 971.281251873612, 971.4122955611895, 973.1387721866129, 714.7998560403096, 715.3597530210485, 715.4383808710189, 715.8389362393472, 717.2755516927888, 16950.0, 17430.389936352167, 17430.47708568745, 17470.563235919075, 17473.21370538329, 15971.840281597151, 16065.518034458868, 16582.419615313527, 16855.57861053471, 17115.31538738449, 13127.86872131276, 13301.0, 13338.666533336647, 13667.794983075262, 13824.516141934984, 3963.128111815396, 4148.62662360386, 4195.979020104911, 4219.324908014733, 4254.638355739766, 83267.0450313575, 83625.16374836235, 83867.5806620963, 83896.0, 84109.0, 12281.385930703429, 12398.876011239952, 12650.81023784644, 12762.10665253442, 12770.23378597287, 21821.127154913625, 21851.78148218529, 21869.234576789735, 21891.0, 21929.780702192773, 8821.426607270507, 8898.822023559622, 9135.132162444557, 9224.538773061455, 9348.252139828797, 4905.583025442806, 4926.359573255454, 5009.7495125243595, 5011.8496445105975, 5018.899622007612, 3881.825317860703, 4016.256992456405, 4029.6776257899883, 4031.0, 4093.89765255871, 715.6421789105448, 723.8769409200344, 730.0399974034128, 735.7608777147342, 735.8160459885029, 739.7189068154067, 810.9189081091844, 839.4585492357518, 856.5802756649197, 867.0635713429481, 10649.9467502662, 10742.207026173252, 10928.890711092787, 11564.0, 11729.589464368706, 725.8548290341953, 731.0861423220974, 775.3564541430599, 814.1126172472034, 815.6778072661266, 4841.298011788342, 5403.621746477709, 5448.400675925645, 5462.235287059815, 5504.587155963239, 114384.42807785908, 117159.41420293014, 117758.41120794341, 117768.0, 118618.0, 99210.0, 99608.0, 99639.51261705805, 99890.50054749679, 100466.0, 83512.99999999878, 88423.55788221018, 89341.10658893458, 90839.54580227057, 92159.53920230355, 10492.632757853438, 10798.892011079788, 11054.557817687202, 11096.500657470595, 11275.66173014811, 52339.90640374342, 52799.73600131975, 53316.0, 54876.451235488734, 54947.72526137344, 68446.65776671085, 69184.65407673131, 75354.98580056736, 75684.62157689397, 76960.61519692365, 13118.606441806762, 13229.007824413015, 13307.866921330662, 13348.799768003293, 13610.183388996691, 15565.299561519532, 15876.0, 16784.916075419544, 17175.141242937552, 17272.309107635552, 13296.468141274627, 13305.46778128864, 13358.666033349244, 13674.521391751241, 14451.349689264218, 13703.0, 13991.370388332753, 14279.42882284697, 14443.277836108362, 14740.778888316469, 13827.51603693866, 14266.71466570642, 14466.855331446972, 14485.203313817841, 14487.782683259971, 12295.631131066082, 12690.238585684889, 12819.871801282241, 12859.807102893277, 12995.350232488148, 12726.809097863354, 12823.166494177849, 12826.166299190523, 12857.0, 13185.934070329587], "value": 8272.577317016754, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 104.0, 111.0, 110.0, 112.0, 109.0, 109.0, 110.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 137.0, 171.0, 124.0, 145.0, 149.0, 118.0, 183.0, 122.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 159.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 188.0, 74.0, 75.0, 74.0, 75.0, 163.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 153.0, 84.0, 83.0, 84.0, 146.0, 83.0, 83.0, 152.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 149.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 52.0, 55.0, 53.0, 52.0, 51.0, 51.0, 54.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 62.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 73.0, 72.0, 71.0, 73.0, 73.0, 71.0, 76.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 126.0, 125.0, 129.0, 131.0, 117.0, 122.0, 122.0, 154.0, 128.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 150.0, 154.0, 150.0, 150.0, 155.0, 151.0, 150.0, 149.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 62.0, 62.0, 60.0, 64.0, 61.0, 60.0, 60.0], "value": 61.6, "unit": "score"}]}]} 04:23:19 INFO - Return code: 0 04:23:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:23:19 ERROR - # TBPL SUCCESS # 04:23:19 INFO - Running post-action listener: _resource_record_post_action 04:23:19 INFO - [mozharness: 2016-09-27 11:23:19.687612Z] Finished run-tests step (success) 04:23:19 INFO - Running post-run listener: _resource_record_post_run 04:23:19 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 1732608; Write bytes: 290893824; Read time: 36; Write time: 194164 04:23:19 INFO - TinderboxPrint: CPU usage
13.2% 04:23:19 INFO - TinderboxPrint: I/O read bytes / time
1,732,608 / 36 04:23:19 INFO - TinderboxPrint: I/O write bytes / time
290,893,824 / 194,164 04:23:19 INFO - TinderboxPrint: CPU idle
8,208.0 (86.8%) 04:23:19 INFO - TinderboxPrint: CPU user
1,195.7 (12.6%) 04:23:19 INFO - TinderboxPrint: Swap in / out
0 / 0 04:23:19 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70090752; Read time: 0; Write time: 41436 04:23:19 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 220803072; Read time: 0; Write time: 152728 04:23:20 INFO - Running post-run listener: _upload_blobber_files 04:23:20 INFO - Blob upload gear active. 04:23:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:23:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:23:20 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'] 04:23:20 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 04:23:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:23:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:25 INFO - (blobuploader) - INFO - Done attempting. 04:23:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:23:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:23:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:26 INFO - (blobuploader) - INFO - Done attempting. 04:23:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:23:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:27 INFO - (blobuploader) - INFO - Done attempting. 04:23:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:23:27 INFO - Return code: 0 04:23:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:23:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:23:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e6fc539321e41ef0db30e5f5d3ce8cdeb4f298b581132efe1e6d7f8714c74982d729964ecaf94f82e963c85d293c8ace2cb41459f00b878a605b190a40a11b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8448f6372a6812b2230f0fdd43aaec123d156cd3b065e46154164950f91ff9505bb59f50001f46554c55f0d5d68e2e95ea8af4bcae33b37dd71a60d7f5193217", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1ff0f27fce53e3953f7f205fe012e85f369a5a23f2bb96169bad54be03e1e6c2f867887e89a1b3e307c69ffe905e24ec58d932e98d79cc03ef6f17af40d91da"} 04:23:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:23:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:23:27 INFO - Contents: 04:23:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e6fc539321e41ef0db30e5f5d3ce8cdeb4f298b581132efe1e6d7f8714c74982d729964ecaf94f82e963c85d293c8ace2cb41459f00b878a605b190a40a11b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8448f6372a6812b2230f0fdd43aaec123d156cd3b065e46154164950f91ff9505bb59f50001f46554c55f0d5d68e2e95ea8af4bcae33b37dd71a60d7f5193217", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1ff0f27fce53e3953f7f205fe012e85f369a5a23f2bb96169bad54be03e1e6c2f867887e89a1b3e307c69ffe905e24ec58d932e98d79cc03ef6f17af40d91da"} 04:23:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:23:27 INFO - Copying logs to upload dir... 04:23:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:23:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.733409 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-09-27 04:23:26.111008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:26.114156) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615 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/7e6fc539321e41ef0db30e5f5d3ce8cdeb4f298b581132efe1e6d7f8714c74982d729964ecaf94f82e963c85d293c8ace2cb41459f00b878a605b190a40a11b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8448f6372a6812b2230f0fdd43aaec123d156cd3b065e46154164950f91ff9505bb59f50001f46554c55f0d5d68e2e95ea8af4bcae33b37dd71a60d7f5193217", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1ff0f27fce53e3953f7f205fe012e85f369a5a23f2bb96169bad54be03e1e6c2f867887e89a1b3e307c69ffe905e24ec58d932e98d79cc03ef6f17af40d91da"} build_url:https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/aJKlL4sIRCiVy3EvdthOFQ/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/7e6fc539321e41ef0db30e5f5d3ce8cdeb4f298b581132efe1e6d7f8714c74982d729964ecaf94f82e963c85d293c8ace2cb41459f00b878a605b190a40a11b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8448f6372a6812b2230f0fdd43aaec123d156cd3b065e46154164950f91ff9505bb59f50001f46554c55f0d5d68e2e95ea8af4bcae33b37dd71a60d7f5193217", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1ff0f27fce53e3953f7f205fe012e85f369a5a23f2bb96169bad54be03e1e6c2f867887e89a1b3e307c69ffe905e24ec58d932e98d79cc03ef6f17af40d91da"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:26.139488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:26.139839) ========= 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=17051fcd5208b27b50bedfeb000001dd-1474973731.457795-69775615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:26.221598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:23:26.221931) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:23:26.222511) ========= ========= Total master_lag: 0.17 =========