builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1475023919.03 results: success (0) buildid: 20160927145221 builduid: b728dfd543a84a268de99d9b6fb45321 revision: 0c6ccccaee828bc55a32d17ce875f0d6db0f9bb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.032421) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.032982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.033400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.134846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.135422) ========= 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=4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 17:51:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-09-27 17:51:59 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136188 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.291300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.291699) ========= 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=4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.340975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:51:59.341353) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0c6ccccaee828bc55a32d17ce875f0d6db0f9bb3 --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 0c6ccccaee828bc55a32d17ce875f0d6db0f9bb3 --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=4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 17:51:59,557 truncating revision to first 12 chars 2016-09-27 17:51:59,557 Setting DEBUG logging. 2016-09-27 17:51:59,557 attempt 1/10 2016-09-27 17:51:59,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0c6ccccaee82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 17:52:00,082 unpacking tar archive at: mozilla-beta-0c6ccccaee82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.868484 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:52:00.223386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 17:52:00.223704) ========= script_repo_revision: 0c6ccccaee828bc55a32d17ce875f0d6db0f9bb3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 17:52:00.224157) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 17:52:00.224467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 17:52:00.236818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-09-27 17:52:00.237121) ========= /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=4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:52:00 INFO - MultiFileLogger online at 20160927 17:52:00 in /builds/slave/test 17:52:00 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 17:52:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:52:00 INFO - {'append_to_log': False, 17:52:00 INFO - 'base_work_dir': '/builds/slave/test', 17:52:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:52:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:52:00 INFO - 'branch': 'Mozilla-Beta', 17:52:00 INFO - 'buildbot_json_path': 'buildprops.json', 17:52:00 INFO - 'config_files': ('talos/linux_config.py',), 17:52:00 INFO - 'default_actions': ('clobber', 17:52:00 INFO - 'read-buildbot-config', 17:52:00 INFO - 'download-and-extract', 17:52:00 INFO - 'populate-webroot', 17:52:00 INFO - 'create-virtualenv', 17:52:00 INFO - 'install', 17:52:00 INFO - 'run-tests'), 17:52:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:52:00 INFO - 'download_minidump_stackwalk': True, 17:52:00 INFO - 'download_symbols': 'ondemand', 17:52:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:52:00 INFO - 'tooltool.py': '/tools/tooltool.py', 17:52:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:52:00 INFO - '/tools/misc-python/virtualenv.py')}, 17:52:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:52:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:52:00 INFO - 'installer_path': 'installer.exe', 17:52:00 INFO - 'log_level': 'info', 17:52:00 INFO - 'log_name': 'talos', 17:52:00 INFO - 'log_to_console': True, 17:52:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:52:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:52:00 INFO - 'opt_config_files': (), 17:52:00 INFO - 'pip_index': False, 17:52:00 INFO - 'sps_profile': False, 17:52:00 INFO - 'sps_profile_interval': 0, 17:52:00 INFO - 'suite': 'dromaeojs-e10s', 17:52:00 INFO - 'system_bits': '32', 17:52:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:52:00 INFO - 'title': 'talos-linux64-ix-030', 17:52:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:52:00 INFO - 'use_talos_json': True, 17:52:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:52:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:52:00 INFO - 'work_dir': 'build'} 17:52:00 INFO - [mozharness: 2016-09-28 00:52:00.543312Z] Running clobber step. 17:52:00 INFO - Running pre-action listener: _resource_record_pre_action 17:52:00 INFO - Running main action method: clobber 17:52:00 INFO - rmtree: /builds/slave/test/build 17:52:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:52:01 INFO - Running post-action listener: _resource_record_post_action 17:52:01 INFO - [mozharness: 2016-09-28 00:52:01.508074Z] Finished clobber step (success) 17:52:01 INFO - [mozharness: 2016-09-28 00:52:01.508174Z] Running read-buildbot-config step. 17:52:01 INFO - Running pre-action listener: _resource_record_pre_action 17:52:01 INFO - Running main action method: read_buildbot_config 17:52:01 INFO - Using buildbot properties: 17:52:01 INFO - { 17:52:01 INFO - "project": "", 17:52:01 INFO - "product": "firefox", 17:52:01 INFO - "script_repo_revision": "production", 17:52:01 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:52:01 INFO - "repository": "", 17:52:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 17:52:01 INFO - "buildid": "20160927145221", 17:52:01 INFO - "pgo_build": "True", 17:52:01 INFO - "basedir": "/builds/slave/test", 17:52:01 INFO - "buildnumber": 186, 17:52:01 INFO - "slavename": "talos-linux64-ix-030", 17:52:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:52:01 INFO - "platform": "ubuntu64_hw", 17:52:01 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:52:01 INFO - "branch": "mozilla-beta", 17:52:01 INFO - "repo_path": "releases/mozilla-beta", 17:52:01 INFO - "revision": "0c6ccccaee828bc55a32d17ce875f0d6db0f9bb3", 17:52:01 INFO - "stage_platform": "linux64-pgo", 17:52:01 INFO - "builduid": "b728dfd543a84a268de99d9b6fb45321", 17:52:01 INFO - "slavebuilddir": "test" 17:52:01 INFO - } 17:52:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 17:52:01 INFO - Running post-action listener: _resource_record_post_action 17:52:01 INFO - [mozharness: 2016-09-28 00:52:01.510619Z] Finished read-buildbot-config step (success) 17:52:01 INFO - [mozharness: 2016-09-28 00:52:01.510709Z] Running download-and-extract step. 17:52:01 INFO - Running pre-action listener: _resource_record_pre_action 17:52:01 INFO - Running main action method: download_and_extract 17:52:01 INFO - mkdir: /builds/slave/test/build/tests 17:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:52:01 INFO - https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:52:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:52:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:52:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17:52:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:52:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:52:01 INFO - retry: Failed, sleeping 30 seconds before retrying 17:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17:52:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:52:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:52:31 INFO - retry: Failed, sleeping 60 seconds before retrying 17:53:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17:53:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:53:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:53:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/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! 17:53:31 INFO - Caught exception: HTTP Error 404: Not Found 17:53:31 INFO - Caught exception: HTTP Error 404: Not Found 17:53:31 INFO - Caught exception: HTTP Error 404: Not Found 17:53:31 INFO - trying https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:53:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17:53:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17:53:32 INFO - Downloaded 1327 bytes. 17:53:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:53:32 INFO - Using the following test package requirements: 17:53:32 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 17:53:32 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:53:32 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 17:53:32 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'jsshell-linux-x86_64.zip'], 17:53:32 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:53:32 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 17:53:32 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 17:53:32 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 17:53:32 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:53:32 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:53:32 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:53:32 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:32 INFO - https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:53:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:53:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:53:32 INFO - retry: Failed, sleeping 30 seconds before retrying 17:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17:54:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:54:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:54:02 INFO - retry: Failed, sleeping 60 seconds before retrying 17:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 17:55:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:55:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 17:55:02 INFO - Caught exception: HTTP Error 404: Not Found 17:55:02 INFO - Caught exception: HTTP Error 404: Not Found 17:55:02 INFO - Caught exception: HTTP Error 404: Not Found 17:55:02 INFO - trying https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:02 INFO - Downloading https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:55:03 INFO - Downloaded 21773036 bytes. 17:55:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:55:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:55:04 INFO - Return code: 0 17:55:04 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 17:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:04 INFO - https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:55:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:55:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:55:04 INFO - retry: Failed, sleeping 30 seconds before retrying 17:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/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 17: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/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:55:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:55:34 INFO - retry: Failed, sleeping 60 seconds before retrying 17:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 17:56:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:56:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:56:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 17:56:34 INFO - Caught exception: HTTP Error 404: Not Found 17:56:34 INFO - Caught exception: HTTP Error 404: Not Found 17:56:34 INFO - Caught exception: HTTP Error 404: Not Found 17:56:34 INFO - trying https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:56:34 INFO - Downloading https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:56:35 INFO - Downloaded 21773036 bytes. 17:56: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'] 17:56: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 17:56:36 INFO - Return code: 0 17:56: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')]} 17:56:36 INFO - https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:56:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:56:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:56:36 INFO - retry: Failed, sleeping 30 seconds before retrying 17:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 17:57:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:57:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:57:06 INFO - retry: Failed, sleeping 60 seconds before retrying 17:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 17:58:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:58:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:58:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 17:58:06 INFO - Caught exception: HTTP Error 404: Not Found 17:58:06 INFO - Caught exception: HTTP Error 404: Not Found 17:58:06 INFO - Caught exception: HTTP Error 404: Not Found 17:58:06 INFO - trying https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:58:06 INFO - Downloading https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:58:07 INFO - Downloaded 14413740 bytes. 17:58:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:58:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:58:07 INFO - Return code: 0 17:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:58:07 INFO - https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:58:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:58:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:58:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:58:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:58:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:58:07 INFO - retry: Failed, sleeping 30 seconds before retrying 17:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 17:58:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:58:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:58:37 INFO - retry: Failed, sleeping 60 seconds before retrying 17:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 17:59:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:59:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:59:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 17:59:37 INFO - Caught exception: HTTP Error 404: Not Found 17:59:37 INFO - Caught exception: HTTP Error 404: Not Found 17:59:37 INFO - Caught exception: HTTP Error 404: Not Found 17:59:37 INFO - trying https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:59:37 INFO - Downloading https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:59:39 INFO - Downloaded 56779453 bytes. 17:59:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:59:39 INFO - mkdir: /builds/slave/test/properties 17:59:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:59:39 INFO - Writing to file /builds/slave/test/properties/build_url 17:59:39 INFO - Contents: 17:59:39 INFO - build_url:https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:59:39 INFO - Running post-action listener: _resource_record_post_action 17:59:39 INFO - Running post-action listener: set_extra_try_arguments 17:59:39 INFO - [mozharness: 2016-09-28 00:59:39.648335Z] Finished download-and-extract step (success) 17:59:39 INFO - [mozharness: 2016-09-28 00:59:39.648571Z] Running populate-webroot step. 17:59:39 INFO - Running pre-action listener: _resource_record_pre_action 17:59:39 INFO - Running main action method: populate_webroot 17:59:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:59:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:59:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:59:39 INFO - '--tppagecycles', 17:59:39 INFO - '7'], 17:59:39 INFO - 'tests': ['tsvgm']}}, 17:59:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:59:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:59:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:59:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:59:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['damp', 'tps']}, 17:59:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'tests': ['damp', 'tps']}, 17:59:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['dromaeo_dom']}, 17:59:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:59:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['basic_compositor_video']}, 17:59:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:59:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['a11yr', 17:59:39 INFO - 'ts_paint', 17:59:39 INFO - 'tpaint', 17:59:39 INFO - 'sessionrestore', 17:59:39 INFO - 'sessionrestore_no_auto_restore', 17:59:39 INFO - 'tabpaint']}, 17:59:39 INFO - 'other-e10s': {'tests': ['a11yr', 17:59:39 INFO - 'ts_paint', 17:59:39 INFO - 'tpaint', 17:59:39 INFO - 'sessionrestore', 17:59:39 INFO - 'sessionrestore_no_auto_restore', 17:59:39 INFO - 'tabpaint']}, 17:59:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:59:39 INFO - 'ts_paint', 17:59:39 INFO - 'tpaint', 17:59:39 INFO - 'sessionrestore', 17:59:39 INFO - 'sessionrestore_no_auto_restore', 17:59:39 INFO - 'tabpaint']}, 17:59:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:59:39 INFO - 'ts_paint', 17:59:39 INFO - 'tpaint', 17:59:39 INFO - 'sessionrestore', 17:59:39 INFO - 'sessionrestore_no_auto_restore', 17:59:39 INFO - 'tabpaint']}, 17:59:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['a11yr', 17:59:39 INFO - 'ts_paint', 17:59:39 INFO - 'tpaint', 17:59:39 INFO - 'sessionrestore', 17:59:39 INFO - 'sessionrestore_no_auto_restore', 17:59:39 INFO - 'tabpaint']}, 17:59:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['a11yr', 17:59:39 INFO - 'ts_paint', 17:59:39 INFO - 'tpaint', 17:59:39 INFO - 'sessionrestore', 17:59:39 INFO - 'sessionrestore_no_auto_restore', 17:59:39 INFO - 'tabpaint']}, 17:59:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['tsvgx', 17:59:39 INFO - 'tsvgr_opacity', 17:59:39 INFO - 'tart', 17:59:39 INFO - 'tscrollx', 17:59:39 INFO - 'cart']}, 17:59:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:59:39 INFO - 'tsvgr_opacity', 17:59:39 INFO - 'tart', 17:59:39 INFO - 'tscrollx', 17:59:39 INFO - 'cart']}, 17:59:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'talos_options': ['--disable-e10s'], 17:59:39 INFO - 'tests': ['tp5o']}, 17:59:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'tests': ['tp5o']}, 17:59:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'talos_options': ['--disable-e10s', 17:59:39 INFO - '--xperf_path', 17:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:39 INFO - 'tests': ['tp5n']}, 17:59:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:39 INFO - 'talos_options': ['--xperf_path', 17:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:39 INFO - 'tests': ['tp5n']}}, 17:59:39 INFO - 'talos.zip': {'path': '', 17:59:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:59:39 INFO - Running post-action listener: _resource_record_post_action 17:59:39 INFO - [mozharness: 2016-09-28 00:59:39.670359Z] Finished populate-webroot step (success) 17:59:39 INFO - [mozharness: 2016-09-28 00:59:39.670448Z] Running create-virtualenv step. 17:59:39 INFO - Running pre-action listener: _resource_record_pre_action 17:59:39 INFO - Running main action method: create_virtualenv 17:59:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:59:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:59:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:59:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:59:39 INFO - Using real prefix '/usr' 17:59:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:59:40 INFO - Installing distribute.............................................................................................................................................................................................done. 17:59:42 INFO - Installing pip.................done. 17:59:42 INFO - Return code: 0 17:59:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:59:42 INFO - Using env: {'DISPLAY': ':0', 17:59:42 INFO - 'HOME': '/home/cltbld', 17:59:42 INFO - 'LANG': 'en_US.UTF-8', 17:59:42 INFO - 'LANGUAGE': 'en_US:en', 17:59:42 INFO - 'LOGNAME': 'cltbld', 17:59:42 INFO - 'MAIL': '/var/mail/cltbld', 17:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:42 INFO - 'MOZ_NO_REMOTE': '1', 17:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:42 INFO - 'NO_EM_RESTART': '1', 17:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:42 INFO - 'PWD': '/builds/slave/test', 17:59:42 INFO - 'SHELL': '/bin/bash', 17:59:42 INFO - 'SHLVL': '1', 17:59:42 INFO - 'TERM': 'linux', 17:59:42 INFO - 'TMOUT': '86400', 17:59:42 INFO - 'USER': 'cltbld', 17:59:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:42 INFO - '_': '/tools/buildbot/bin/python'} 17:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:59:42 INFO - Cleaning up... 17:59:42 INFO - Return code: 0 17:59:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:59:42 INFO - Using env: {'DISPLAY': ':0', 17:59:42 INFO - 'HOME': '/home/cltbld', 17:59:42 INFO - 'LANG': 'en_US.UTF-8', 17:59:42 INFO - 'LANGUAGE': 'en_US:en', 17:59:42 INFO - 'LOGNAME': 'cltbld', 17:59:42 INFO - 'MAIL': '/var/mail/cltbld', 17:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:42 INFO - 'MOZ_NO_REMOTE': '1', 17:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:42 INFO - 'NO_EM_RESTART': '1', 17:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:42 INFO - 'PWD': '/builds/slave/test', 17:59:42 INFO - 'SHELL': '/bin/bash', 17:59:42 INFO - 'SHLVL': '1', 17:59:42 INFO - 'TERM': 'linux', 17:59:42 INFO - 'TMOUT': '86400', 17:59:42 INFO - 'USER': 'cltbld', 17:59:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:42 INFO - '_': '/tools/buildbot/bin/python'} 17:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:42 INFO - Downloading/unpacking psutil>=3.1.1 17:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:44 INFO - Installing collected packages: psutil 17:59:44 INFO - Running setup.py install for psutil 17:59:44 INFO - building 'psutil._psutil_linux' extension 17:59:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:59:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:59:44 INFO - building 'psutil._psutil_posix' extension 17:59:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:59:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:59:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:45 INFO - Successfully installed psutil 17:59:45 INFO - Cleaning up... 17:59:45 INFO - Return code: 0 17:59:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:59:45 INFO - Using env: {'DISPLAY': ':0', 17:59:45 INFO - 'HOME': '/home/cltbld', 17:59:45 INFO - 'LANG': 'en_US.UTF-8', 17:59:45 INFO - 'LANGUAGE': 'en_US:en', 17:59:45 INFO - 'LOGNAME': 'cltbld', 17:59:45 INFO - 'MAIL': '/var/mail/cltbld', 17:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:45 INFO - 'MOZ_NO_REMOTE': '1', 17:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:45 INFO - 'NO_EM_RESTART': '1', 17:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:45 INFO - 'PWD': '/builds/slave/test', 17:59:45 INFO - 'SHELL': '/bin/bash', 17:59:45 INFO - 'SHLVL': '1', 17:59:45 INFO - 'TERM': 'linux', 17:59:45 INFO - 'TMOUT': '86400', 17:59:45 INFO - 'USER': 'cltbld', 17:59:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:45 INFO - '_': '/tools/buildbot/bin/python'} 17:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:59:47 INFO - Installing collected packages: mozsystemmonitor 17:59:47 INFO - Running setup.py install for mozsystemmonitor 17:59:47 INFO - Successfully installed mozsystemmonitor 17:59:47 INFO - Cleaning up... 17:59:47 INFO - Return code: 0 17:59:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:59:47 INFO - Using env: {'DISPLAY': ':0', 17:59:47 INFO - 'HOME': '/home/cltbld', 17:59:47 INFO - 'LANG': 'en_US.UTF-8', 17:59:47 INFO - 'LANGUAGE': 'en_US:en', 17:59:47 INFO - 'LOGNAME': 'cltbld', 17:59:47 INFO - 'MAIL': '/var/mail/cltbld', 17:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:47 INFO - 'MOZ_NO_REMOTE': '1', 17:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:47 INFO - 'NO_EM_RESTART': '1', 17:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:47 INFO - 'PWD': '/builds/slave/test', 17:59:47 INFO - 'SHELL': '/bin/bash', 17:59:47 INFO - 'SHLVL': '1', 17:59:47 INFO - 'TERM': 'linux', 17:59:47 INFO - 'TMOUT': '86400', 17:59:47 INFO - 'USER': 'cltbld', 17:59:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:47 INFO - '_': '/tools/buildbot/bin/python'} 17:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:47 INFO - Downloading/unpacking jsonschema==2.5.1 17:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:59:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:49 INFO - Downloading functools32-3.2.3-2.tar.gz 17:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:59:49 INFO - warning: no files found matching '*.txt' 17:59:49 INFO - no previously-included directories found matching 'build' 17:59:49 INFO - no previously-included directories found matching 'dist' 17:59:49 INFO - no previously-included directories found matching '.git*' 17:59:49 INFO - Installing collected packages: jsonschema, functools32 17:59:49 INFO - Running setup.py install for functools32 17:59:50 INFO - warning: no files found matching '*.txt' 17:59:50 INFO - no previously-included directories found matching 'build' 17:59:50 INFO - no previously-included directories found matching 'dist' 17:59:50 INFO - no previously-included directories found matching '.git*' 17:59:50 INFO - Successfully installed jsonschema functools32 17:59:50 INFO - Cleaning up... 17:59:50 INFO - Return code: 0 17:59:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:50 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 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:59:50 INFO - Using env: {'DISPLAY': ':0', 17:59:50 INFO - 'HOME': '/home/cltbld', 17:59:50 INFO - 'LANG': 'en_US.UTF-8', 17:59:50 INFO - 'LANGUAGE': 'en_US:en', 17:59:50 INFO - 'LOGNAME': 'cltbld', 17:59:50 INFO - 'MAIL': '/var/mail/cltbld', 17:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:50 INFO - 'MOZ_NO_REMOTE': '1', 17:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:50 INFO - 'NO_EM_RESTART': '1', 17:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:50 INFO - 'PWD': '/builds/slave/test', 17:59:50 INFO - 'SHELL': '/bin/bash', 17:59:50 INFO - 'SHLVL': '1', 17:59:50 INFO - 'TERM': 'linux', 17:59:50 INFO - 'TMOUT': '86400', 17:59:50 INFO - 'USER': 'cltbld', 17:59:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:50 INFO - '_': '/tools/buildbot/bin/python'} 17:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:59:50 INFO - Cleaning up... 17:59:50 INFO - Return code: 0 17:59:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:50 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 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:59:50 INFO - Using env: {'DISPLAY': ':0', 17:59:50 INFO - 'HOME': '/home/cltbld', 17:59:50 INFO - 'LANG': 'en_US.UTF-8', 17:59:50 INFO - 'LANGUAGE': 'en_US:en', 17:59:50 INFO - 'LOGNAME': 'cltbld', 17:59:50 INFO - 'MAIL': '/var/mail/cltbld', 17:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:50 INFO - 'MOZ_NO_REMOTE': '1', 17:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:50 INFO - 'NO_EM_RESTART': '1', 17:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:50 INFO - 'PWD': '/builds/slave/test', 17:59:50 INFO - 'SHELL': '/bin/bash', 17:59:50 INFO - 'SHLVL': '1', 17:59:50 INFO - 'TERM': 'linux', 17:59:50 INFO - 'TMOUT': '86400', 17:59:50 INFO - 'USER': 'cltbld', 17:59:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:50 INFO - '_': '/tools/buildbot/bin/python'} 17:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:59:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:59:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:53 INFO - Downloading docopt-0.6.1.tar.gz 17:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:59:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:59:53 INFO - Running setup.py install for blobuploader 17:59:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:59:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:59:53 INFO - Running setup.py install for requests 17:59:53 INFO - Running setup.py install for docopt 17:59:53 INFO - Successfully installed blobuploader requests docopt 17:59:53 INFO - Cleaning up... 17:59:53 INFO - Return code: 0 17:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:53 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 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:59:53 INFO - Using env: {'DISPLAY': ':0', 17:59:53 INFO - 'HOME': '/home/cltbld', 17:59:53 INFO - 'LANG': 'en_US.UTF-8', 17:59:53 INFO - 'LANGUAGE': 'en_US:en', 17:59:53 INFO - 'LOGNAME': 'cltbld', 17:59:53 INFO - 'MAIL': '/var/mail/cltbld', 17:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:53 INFO - 'MOZ_NO_REMOTE': '1', 17:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:53 INFO - 'NO_EM_RESTART': '1', 17:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:53 INFO - 'PWD': '/builds/slave/test', 17:59:53 INFO - 'SHELL': '/bin/bash', 17:59:53 INFO - 'SHLVL': '1', 17:59:53 INFO - 'TERM': 'linux', 17:59:53 INFO - 'TMOUT': '86400', 17:59:53 INFO - 'USER': 'cltbld', 17:59:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:53 INFO - '_': '/tools/buildbot/bin/python'} 17:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:59:54 INFO - Running setup.py (path:/tmp/pip-eJJccY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:59:54 INFO - Running setup.py (path:/tmp/pip-Ra4Xlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:59:54 INFO - Running setup.py (path:/tmp/pip-LJusKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:59:54 INFO - Running setup.py (path:/tmp/pip-PeAuVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:59:54 INFO - Running setup.py (path:/tmp/pip-30xy4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:59:54 INFO - Running setup.py (path:/tmp/pip-31KlE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:59:54 INFO - Running setup.py (path:/tmp/pip-j77Ago-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:59:54 INFO - Running setup.py (path:/tmp/pip-2pbi4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:59:54 INFO - Running setup.py (path:/tmp/pip-4AQS3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:59:54 INFO - Running setup.py (path:/tmp/pip-RMgXsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:59:54 INFO - Running setup.py (path:/tmp/pip-fev4Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:59:54 INFO - Running setup.py (path:/tmp/pip-j_C4ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:59:54 INFO - Running setup.py (path:/tmp/pip-wYsye7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:59:54 INFO - Running setup.py (path:/tmp/pip-HoMv3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:55 INFO - Running setup.py (path:/tmp/pip-h6Vmqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:59:55 INFO - Running setup.py (path:/tmp/pip-SaJziB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:59:55 INFO - Running setup.py (path:/tmp/pip-x4Psdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:59:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:59:55 INFO - Running setup.py install for manifestparser 17:59:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:59:55 INFO - Running setup.py install for mozcrash 17:59:55 INFO - Running setup.py install for mozdebug 17:59:55 INFO - Running setup.py install for mozdevice 17:59:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:59:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:59:55 INFO - Running setup.py install for mozfile 17:59:55 INFO - Running setup.py install for mozhttpd 17:59:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:59:55 INFO - Running setup.py install for mozinfo 17:59:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:59:55 INFO - Running setup.py install for mozInstall 17:59:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Running setup.py install for mozleak 17:59:56 INFO - Running setup.py install for mozlog 17:59:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Running setup.py install for moznetwork 17:59:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Running setup.py install for mozprocess 17:59:56 INFO - Running setup.py install for mozprofile 17:59:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Running setup.py install for mozrunner 17:59:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:59:56 INFO - Running setup.py install for mozscreenshot 17:59:56 INFO - Running setup.py install for moztest 17:59:56 INFO - Running setup.py install for mozversion 17:59:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:59:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:59:57 INFO - Cleaning up... 17:59:57 INFO - Return code: 0 17:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 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 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:59:57 INFO - Using env: {'DISPLAY': ':0', 17:59:57 INFO - 'HOME': '/home/cltbld', 17:59:57 INFO - 'LANG': 'en_US.UTF-8', 17:59:57 INFO - 'LANGUAGE': 'en_US:en', 17:59:57 INFO - 'LOGNAME': 'cltbld', 17:59:57 INFO - 'MAIL': '/var/mail/cltbld', 17:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:57 INFO - 'MOZ_NO_REMOTE': '1', 17:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:57 INFO - 'NO_EM_RESTART': '1', 17:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:57 INFO - 'PWD': '/builds/slave/test', 17:59:57 INFO - 'SHELL': '/bin/bash', 17:59:57 INFO - 'SHLVL': '1', 17:59:57 INFO - 'TERM': 'linux', 17:59:57 INFO - 'TMOUT': '86400', 17:59:57 INFO - 'USER': 'cltbld', 17:59:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 17:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:57 INFO - '_': '/tools/buildbot/bin/python'} 17:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:59:57 INFO - Running setup.py (path:/tmp/pip-IQplAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:59:57 INFO - Running setup.py (path:/tmp/pip-9UAVAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:59:57 INFO - Running setup.py (path:/tmp/pip-6yNmr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:59:57 INFO - Running setup.py (path:/tmp/pip-u1T7qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:59:57 INFO - Running setup.py (path:/tmp/pip-LqVjVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:59:57 INFO - Running setup.py (path:/tmp/pip-hD8oPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:59:57 INFO - Running setup.py (path:/tmp/pip-2nBOcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:59:57 INFO - Running setup.py (path:/tmp/pip-CT3gsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:59:57 INFO - Running setup.py (path:/tmp/pip-YsQv5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:59:57 INFO - Running setup.py (path:/tmp/pip-C03JG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:59:57 INFO - Running setup.py (path:/tmp/pip-67W03t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:59:58 INFO - Running setup.py (path:/tmp/pip-NwjX22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:59:58 INFO - Running setup.py (path:/tmp/pip-uHYzvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:59:58 INFO - Running setup.py (path:/tmp/pip-UBg88G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:58 INFO - Running setup.py (path:/tmp/pip-xuQmPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:59:58 INFO - Running setup.py (path:/tmp/pip-SG0FCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:59:58 INFO - Running setup.py (path:/tmp/pip-CDhkJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:59:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:00 INFO - Downloading blessings-1.6.tar.gz 18:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:00 INFO - Installing collected packages: blessings 18:00:00 INFO - Running setup.py install for blessings 18:00:00 INFO - Successfully installed blessings 18:00:00 INFO - Cleaning up... 18:00:00 INFO - Return code: 0 18:00:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:00 INFO - Reading from file tmpfile_stdout 18:00:00 INFO - Current package versions: 18:00:00 INFO - argparse == 1.2.1 18:00:00 INFO - blessings == 1.6 18:00:00 INFO - blobuploader == 1.2.4 18:00:00 INFO - docopt == 0.6.1 18:00:00 INFO - functools32 == 3.2.3-2 18:00:00 INFO - jsonschema == 2.5.1 18:00:00 INFO - manifestparser == 1.1 18:00:00 INFO - mozInstall == 1.12 18:00:00 INFO - mozcrash == 0.17 18:00:00 INFO - mozdebug == 0.1 18:00:00 INFO - mozdevice == 0.48 18:00:00 INFO - mozfile == 1.2 18:00:00 INFO - mozhttpd == 0.7 18:00:00 INFO - mozinfo == 0.9 18:00:00 INFO - mozleak == 0.1 18:00:00 INFO - mozlog == 3.3 18:00:00 INFO - moznetwork == 0.27 18:00:00 INFO - mozprocess == 0.23 18:00:00 INFO - mozprofile == 0.28 18:00:00 INFO - mozrunner == 6.12 18:00:00 INFO - mozscreenshot == 0.1 18:00:00 INFO - mozsystemmonitor == 0.3 18:00:00 INFO - moztest == 0.7 18:00:00 INFO - mozversion == 1.4 18:00:00 INFO - psutil == 3.1.1 18:00:00 INFO - requests == 1.2.3 18:00:00 INFO - wsgiref == 0.1.2 18:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:00 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')]} 18:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:00 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')]} 18:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:00 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 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', '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 18:00:00 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 18:00:00 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 18:00:00 INFO - Using env: {'DISPLAY': ':0', 18:00:00 INFO - 'HOME': '/home/cltbld', 18:00:00 INFO - 'LANG': 'en_US.UTF-8', 18:00:00 INFO - 'LANGUAGE': 'en_US:en', 18:00:00 INFO - 'LOGNAME': 'cltbld', 18:00:00 INFO - 'MAIL': '/var/mail/cltbld', 18:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:00 INFO - 'MOZ_NO_REMOTE': '1', 18:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:00 INFO - 'NO_EM_RESTART': '1', 18:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:00 INFO - 'PWD': '/builds/slave/test', 18:00:00 INFO - 'SHELL': '/bin/bash', 18:00:00 INFO - 'SHLVL': '1', 18:00:00 INFO - 'TERM': 'linux', 18:00:00 INFO - 'TMOUT': '86400', 18:00:00 INFO - 'USER': 'cltbld', 18:00:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 18:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:00 INFO - '_': '/tools/buildbot/bin/python'} 18:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 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)) 18:00:01 INFO - Cleaning up... 18:00:01 INFO - Return code: 0 18:00:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, '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': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', '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 18:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:00:01 INFO - Using env: {'DISPLAY': ':0', 18:00:01 INFO - 'HOME': '/home/cltbld', 18:00:01 INFO - 'LANG': 'en_US.UTF-8', 18:00:01 INFO - 'LANGUAGE': 'en_US:en', 18:00:01 INFO - 'LOGNAME': 'cltbld', 18:00:01 INFO - 'MAIL': '/var/mail/cltbld', 18:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:01 INFO - 'MOZ_NO_REMOTE': '1', 18:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:01 INFO - 'NO_EM_RESTART': '1', 18:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:01 INFO - 'PWD': '/builds/slave/test', 18:00:01 INFO - 'SHELL': '/bin/bash', 18:00:01 INFO - 'SHLVL': '1', 18:00:01 INFO - 'TERM': 'linux', 18:00:01 INFO - 'TMOUT': '86400', 18:00:01 INFO - 'USER': 'cltbld', 18:00:01 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 18:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:01 INFO - '_': '/tools/buildbot/bin/python'} 18:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:00:01 INFO - Cleaning up... 18:00:01 INFO - Return code: 0 18:00:01 INFO - Running post-action listener: _resource_record_post_action 18:00:01 INFO - Running post-action listener: _start_resource_monitoring 18:00:01 INFO - Starting resource monitoring. 18:00:01 INFO - [mozharness: 2016-09-28 01:00:01.323533Z] Finished create-virtualenv step (success) 18:00:01 INFO - [mozharness: 2016-09-28 01:00:01.324063Z] Running install step. 18:00:01 INFO - Running pre-action listener: _resource_record_pre_action 18:00:01 INFO - Running main action method: install 18:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:01 INFO - Reading from file tmpfile_stdout 18:00:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:01 INFO - Reading from file tmpfile_stdout 18:00:01 INFO - Output received: 18:00:01 INFO - Usage: mozinstall [options] installer 18:00:01 INFO - Options: 18:00:01 INFO - -h, --help show this help message and exit 18:00:01 INFO - -d DEST, --destination=DEST 18:00:01 INFO - Directory to install application into. [default: 18:00:01 INFO - "/builds/slave/test"] 18:00:01 INFO - --app=APP Application being installed. [default: firefox] 18:00:01 INFO - mkdir: /builds/slave/test/build/application 18:00:01 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'] 18:00:01 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 18:00:15 INFO - Reading from file tmpfile_stdout 18:00:15 INFO - Output received: 18:00:15 INFO - /builds/slave/test/build/application/firefox/firefox 18:00:15 INFO - Running post-action listener: _resource_record_post_action 18:00:15 INFO - [mozharness: 2016-09-28 01:00:15.832953Z] Finished install step (success) 18:00:15 INFO - [mozharness: 2016-09-28 01:00:15.833232Z] Running run-tests step. 18:00:15 INFO - Running pre-action listener: _resource_record_pre_action 18:00:15 INFO - Running main action method: run_tests 18:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:00:15 INFO - Python 2.7.3 18:00:15 INFO - Return code: 0 18:00:15 INFO - grabbing minidump binary from tooltool 18:00: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')]} 18:00:15 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 0x195e570>, '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 0x195f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:00:15 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 18:00:15 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 18:00:15 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 18:00:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:00:15 INFO - Return code: 0 18:00:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:00:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:00:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:00:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:00:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:00:15 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/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:00:15 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/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 18:00:15 INFO - Using env: {'DISPLAY': ':0', 18:00:15 INFO - 'HOME': '/home/cltbld', 18:00:15 INFO - 'LANG': 'en_US.UTF-8', 18:00:15 INFO - 'LANGUAGE': 'en_US:en', 18:00:15 INFO - 'LOGNAME': 'cltbld', 18:00:15 INFO - 'MAIL': '/var/mail/cltbld', 18:00:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:00:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:15 INFO - 'MOZ_NO_REMOTE': '1', 18:00:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:15 INFO - 'NO_EM_RESTART': '1', 18:00:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:15 INFO - 'PWD': '/builds/slave/test', 18:00:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:00:15 INFO - 'SHELL': '/bin/bash', 18:00:15 INFO - 'SHLVL': '1', 18:00:15 INFO - 'TERM': 'linux', 18:00:15 INFO - 'TMOUT': '86400', 18:00:15 INFO - 'USER': 'cltbld', 18:00:15 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397', 18:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:15 INFO - '_': '/tools/buildbot/bin/python'} 18:00:15 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/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:00:16 INFO - mozversion application_buildid: 20160927145221 18:00:16 INFO - mozversion application_changeset: 0c6ccccaee828bc55a32d17ce875f0d6db0f9bb3 18:00:16 INFO - mozversion application_display_name: Firefox 18:00:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:00:16 INFO - mozversion application_name: Firefox 18:00:16 INFO - mozversion application_remotingname: firefox 18:00:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:00:16 INFO - mozversion application_vendor: Mozilla 18:00:16 INFO - mozversion application_version: 50.0 18:00:16 INFO - mozversion platform_buildid: 20160927145221 18:00:16 INFO - mozversion platform_changeset: 0c6ccccaee828bc55a32d17ce875f0d6db0f9bb3 18:00:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:00:16 INFO - mozversion platform_version: 50.0 18:00:16 INFO - using testdate: 1475024416 18:00:16 INFO - actual date: 1475024416 18:00:16 INFO - starting webserver on 'localhost:44580' 18:00:16 INFO - SUITE-START | Running 2 tests 18:00:16 INFO - TEST-START | dromaeo_css 18:00:16 INFO - operating with platform_type : linux_ 18:00:16 INFO - Initialising browser for dromaeo_css test... 18:00:16 INFO - TEST-INFO | started process 6890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7rf51r/profile http://localhost:44580/getInfo.html) 18:00:20 INFO - PROCESS | 6890 | __metrics Screen width/height:1600/1200 18:00:20 INFO - PROCESS | 6890 | colorDepth:24 18:00:20 INFO - PROCESS | 6890 | Browser inner width/height: 1024/697 18:00:20 INFO - PROCESS | 6890 | __metrics 18:00:21 ERROR - PROCESS | 6890 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:00:22 INFO - TEST-INFO | 6890: exit 0 18:00:22 INFO - Browser initialized. 18:00:22 INFO - Running cycle 1/1 for dromaeo_css test... 18:00:22 INFO - TEST-INFO | started process 7016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7rf51r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:00:33 INFO - PROCESS | 7016 | RSS: Main: 150110208 18:00:33 INFO - PROCESS | 7016 | 18:01:23 INFO - PROCESS | 7016 | 1475024483506 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] 18:03:32 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:44580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44580/tests/dromaeo/cssquery-ext.html) 18:03:33 INFO - PROCESS | 7016 | RSS: Main: 158867456 18:03:33 INFO - PROCESS | 7016 | 18:06:35 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:44580/tests/dromaeo/cssquery-ext.html (next: http://localhost:44580/tests/dromaeo/cssquery-jquery.html) 18:06:35 INFO - PROCESS | 7016 | RSS: Main: 155791360 18:06:35 INFO - PROCESS | 7016 | 18:09:37 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:44580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44580/tests/dromaeo/cssquery-mootools.html) 18:09:38 INFO - PROCESS | 7016 | RSS: Main: 154767360 18:09:38 INFO - PROCESS | 7016 | 18:12:39 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:44580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44580/tests/dromaeo/cssquery-prototype.html) 18:12:40 INFO - PROCESS | 7016 | RSS: Main: 156241920 18:12:40 INFO - PROCESS | 7016 | 18:15:42 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:44580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44580/tests/dromaeo/cssquery-yui.html) 18:15:43 INFO - PROCESS | 7016 | RSS: Main: 157216768 18:15:43 INFO - PROCESS | 7016 | 18:18:45 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:44580/tests/dromaeo/cssquery-yui.html (next: http://localhost:44580/tests/dromaeo/cssquery-dojo.html) 18:18:46 INFO - PROCESS | 7016 | RSS: Main: 157257728 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | __start_tp_report 18:18:46 INFO - PROCESS | 7016 | _x_x_mozilla_page_load 18:18:46 INFO - PROCESS | 7016 | _x_x_mozilla_page_load_details 18:18:46 INFO - PROCESS | 7016 | |i|pagename|runs| 18:18:46 INFO - PROCESS | 7016 | |0;dojo.html;3293.4730443129097;3342.732581393488;3359.277755282615;3361.7478689098325;3379.831008449577;5830.795922142721;5898.174255604208;5901.232839730835;5913.14259432382;5917.73370198341;5836.941630583693;5883.499902508282;5885.969955257834;5891.970540147304;5892.793752218662;5310;5342.599305052117;5365.570754339644;5406.968338875234;5424.240606315119;5386.946130538684;5391.892162156754;5399.83800485986;5402.756875940592;5408.540274076709;5201.921971170435;5243.449437809032;5328.973355133219;5359.330083739533;5400.108982017962;5240.03059434004;5301.787928482856;5321.8935621287355;5323.201519772065;5348.946510534884;5187.403448603383;5274.55166310864;5289.127293996486;5299.417064122943;5306.814261500829;5567.8608034799045;5589.832305030855;5699.886002279973;5766.192733017381;5827.650340979555;6014;6113.658745237687;6117.553376797881;6121.045392021996;6128.411459112332;6128.533679014817;6136.746076527064;6140.293866205398;6145.047517634774;6167.352427995085;5690.231818704505;5772;5774.162746401748;5783.537317014629;5808.070708686632;6323.936760632427;6453.1610890583925;6455.61266324022;6458.095866578683;6471.061696054046;6131.785387511416;6137.447629713347;6176.536759743038;6178;6184.134221209034;6020.668863212478;6037.215162028908;6210.689465526705;6251.812445626639;6284;6040.969795151084;6114.510272098727;6129.056396697549;6130.004390691762;6135.385782596045;6118.040554665226;6128.203333566607;6129.301012237645;6138.163647720175;6147.508199344042;4580.0152967112235;4634.6987445816585;4668.299755036772;4670.276107203389;4675.812967481263;4053.3312003519677;4139.317012692933;4150.149219410014;4165.021220013295;4183.5398106208295;5858.355580886099;5894.469497745224;5897.410258974069;5912.586118971631;5921.154008659072;5987.101934709828;6115.602485838495;6178.073289006685;6185.597936134137;6186.350433204539;5962.4633782959745;6026.638401695912;6036.698165091728;6037.305709843425;6075;5384.192371144281;5387.75755091014;5401.945980540223;5402;5410.648307859977;6137.723802428812;6284.811455656338;6376.330485298977;6494.707738151795;6515.934840651533;6290.968545157245;6294.653794041372;6301.590396624205;6306.810795676137;6310.873782524232;6442.35576442352;6494.512911531559;6513.576617519846;6514.73941042353;6517.641529715911;5825.300963884361;5981.551383646157;5991.071383935497;6181.443670069715;6186.1339412483185;6180.103884936749;6183.505319574513;6186.319504854372;6191.938080619136;6192.721327540362;6053.697315134314;6062.727177277121;6063.636181829104;6063.6664983426335;6096.8780624388155;5987.670678112746;6020.488258497901;6035.728392222449;6042.305134909541;6065.302490213506;6129.515066852852;6129.8467538310115;6131.040261761288;6135.9386406137155;6136.23297087864;6131.157172517858;6133.969330153321;6142.938570614237;6150.169727086786;6200.81397558074;5862.237909071964;5906.468417842415;5981.043033114681;6026.096085587022;6061.6666083365835 18:18:46 INFO - PROCESS | 7016 | |1;ext.html;591.1989254560071;644.2591020326624;656.0716586030763;660.5376236634355;691.9446444284458;42952.57047429525;47006.76496617512;47270.58188254358;47523.52476475234;47678.28482572764;46596;47175.764121179345;47195.52804471954;47433;47475.52524474754;9016.41393309436;9139.543022848864;9169.908300917006;9187.448753074803;9213.861792073125;9082.818343633156;9171.908280917172;9186.770330741752;9190.448573085603;9210.125038121401;9183.173514383705;9228.077192280753;9231.492267925261;9242.491662958535;9257.722268331961;9178.173964343208;9215.631374745002;9216.861747073799;9223.262139028895;9232.261419086457;9124.087591240888;9146.2682985361;9148;9163.862542061874;9168.312376571785;44614;44803.32795008078;44915.55084449147;44991.55008449906;45129.77435112836;3989.3816458448987;3993.9201215975518;4054.614811592894;4066.146109317047;4311.073119279338;36235.275294494226;36335.81832090849;36377;36439;37904;4542.734616535367;4546.545345465427;4621.1219868224925;4629.537046295377;4629.583337499607;391084;391521;392872;393056;393702.99999999715;64700;65043;65052;65196;65228;40655.59344406577;69077.30922690709;69118.65440672864;69128;69329.65335173292;15371.769423458658;15726.528204153894;15769.369225230863;15800.92099539495;15978.121203333929;13396.196228226143;13413.731725365438;13475.258860762751;13531.864681353258;13571.524996625269;21353.78646213518;21393.67909481359;21432.78567214339;21547.353579392642;21623.351299461043;7700.499467534592;7753.224677532315;7864.72473463426;7970.362371010306;7971.123176450586;1084.3764835219781;1106.656936349718;1138.2942575603179;1163.7032556697989;1233.0382301804607;34691.82654086764;34694.65305346914;34725.652743472245;34754.478682819776;34886.82556587252;1172.5251273234353;1198.9100817438728;1216.4708351866966;1228.4840367045863;1247.9126461147632;18012.32927353185;18100.909495452437;18447.16987735555;18453.583739450893;18461.907690461463;669416;673954;676538;677946;679784;68119.3188068113;68134.31865681379;68469;68601.31398686049;68627;1478.1131321207404;1480.141517919604;1485.9554213373617;1495.5513345996376;1497.8541415816908;34085;34088;34230;34231.82884085663;34497.82751086329;57639.711801440724;58121.70939145446;58136;58169.4183058164;58200.70899645475;484489;485331;486319;486656;487005;31944.36111277715;32001.872211599635;32371.352572947937;32561.348773023932;32777.67222327746;54502.18246726223;54839;54970.450295496536;55419.44580554143;59357;46748.29877551908;47867.28199076947;47925;49495.50504494909;49560.50439495559;48457;48660;48705.512944871516;48833.51166488432;49223.75388123036;46572.53427465682;47007.52992470168;47786.28320575264;48040.519594803605;49787;39059.41410878782;40986.385204222555;41325.79337103295;41402;41854.79072604617;31114.22214444657;31719.207019824687;31975.200619983756;32248.83875580701;32589.674103258665 18:18:46 INFO - PROCESS | 7016 | |2;jquery.html;407.6616408381044;409.7275311917575;426.1477045908183;428.79632174717005;441.474645172245;18880.52798680032;21037.579248415022;21192.788072119274;21298.254561090365;21904.671429928563;20422.591548169064;20797.16811327545;20940.16239350428;21111.577768444662;21182;5990.1913241712355;6157.2919114301985;6164.044573091156;6203.162573052626;6205.1623030890705;5692.715364231793;5935.64386136831;5966.164736936832;6114.205153330083;6159.3224745277985;5957.672328021957;5965.761369545213;5996.430339117776;6149.569530132892;6567.244766851802;6113.724882380304;6445.774397896074;6547.770828021044;6596.307387724291;6597.60414375139;5925.940740592582;6058.545609079337;6063.605865618721;6065.545084118665;6095.207623009025;14959;15096.320665570076;15289.464868729541;15440.691186176326;15476.458323958608;2419.588669926117;2468.6543883856275;2583.935401614956;2626.9474610507873;2921.737043666059;9715.61137554497;9898.9505052475;10217.846732299022;10239.334443261165;10695.304805187716;2042.3566576528347;2042.867213631124;2100.2649072824543;2127.351157896841;2169.013099039933;90950;91486.5425672874;92500;92748.53625731896;94981;11564.132690048113;11699.532018719327;12114.454849531792;12279.877201227873;12331;16626.6674666506;16688.249028793733;16727.330906763593;16734.49796506107;16737.581560461087;8284.668613255522;8421.410501264852;8512.191341822518;8519.190676885686;8963.462192268486;7875.724349647735;7975.720849770346;8071.031476222891;8183.95908020456;8708.869366959501;4872.269159626085;4884.438289596671;4970.726610036482;5004.344222184486;5116.718580478035;2039.0620314655425;2068.6069646767064;2079.064421010551;2102.1906565971904;2133.328001679497;960.3805545423163;980.5391466010964;1013.0983424751977;1047.1151876664208;1096.550414330121;21164.259250926145;21510;21533.89233053825;21688.457788555097;21883.67174492384;1003.7490627343165;1020.831562792131;1025.8204814157493;1105.0827812915422;1108.229780302682;10765.38768984809;11765;11909.940450297867;11932.403379830974;11952.22310549829;505955;507090;509443;513122;570580;99627;102435;102829;102986;103234;1078.159035951943;1111.899929006377;1116.9497372618252;1125.099920063962;1133.155798929786;18025.639487210443;18861.717074243625;18871.716924245873;19064.4359979646;19246.326378576683;36834.44748328724;40694.59305406908;42623;44075.33886991762;45618;61629.38370616236;66084;66468;66984.66507667431;67352.6632366835;7980.12218655959;8150.673973041012;8496.022957359983;8935.195832375117;8942.597583108905;14016.719665606835;14072.577822665336;14514.419423222953;14577.271136442923;15056.096634201545;12628.179168354027;12679.55621553278;12761.234325940473;13015.804762928754;13036.543720969721;12060.819087713868;12186.086043546593;12215.633530994084;12299.385030748606;12307.138500305251;12661;12688.809667855174;12836.294003829878;12911.677208069874;12913.677158071123;8264.545450000307;8347.666093356198;8405.07544170153;8448.324134069137;8457.773622824532;11243.66269011931;11886.227395219283;11963;12129.75740485203;12525.56160534377 18:18:46 INFO - PROCESS | 7016 | |3;mootools.html;1565.1000674612098;1583.7624356346546;1704.2586474883426;1766.9204885780146;1787.1421717575556;9173.67892123775;9532.952335238315;9879.5554200061;9914.305998580103;9956.352837065595;9929.751756206098;10018.448985305806;10128.797424051514;10156;10156.035176658206;2457.2751038443703;2494.5010997800423;2498.650188973545;2500.1374525788574;2503.5869081601513;2414.6498757680124;2479.119912431088;2488.664030355906;2495.1017633651873;2499;2447.5104979004273;2453.129139155601;2454.4232105455294;2475;2475.4430253192977;2421.382547450398;2423.53952748978;2430.7812296893276;2483.056438553356;2484.9378765531005;2305.896234669427;2351.8588884666806;2354.2937118864443;2362.350353652742;2374.6794182785275;9802.754931126708;9938;9939.204863610894;9948;9971.152452041586;5434.510894019557;5544.251526043973;5573.777048918038;5575.219469274305;5576.191452239443;3491.841283552027;3501.77238479498;3585.713142948584;3637.963620363789;3657.213699054689;1215.4226742297426;1216.7140721930339;1221.3099598726692;1226.5952235762265;1230.7107829660022;13650.385732642055;13722.382492787849;13732.65668358289;13744.175349478963;13767.38046787897;4530.932036019462;4651.744154071491;4742.33607294979;4849.9030019399415;4871.244957031666;10704.411257380763;10704.464776761131;10705.197110216764;10706.197035222389;10727.892721072845;5576.219329293902;5581.2186293918885;5587.7485513152005;5608.158776183605;5610.551155907518;4660.091282199938;5079;5206.71363075027;5216.295800067019;5246.134387826042;4139.586041395836;4159.523369203889;4180.728252663628;4186.539480657125;4195.244855925963;1212.6240865331774;1218.4760552962134;1223.3149436315691;1225.7732319520917;1228.969275768113;1001.4191768774093;1031.3554028732042;1034.1003327105466;1035.1822060572215;1047.1518070363031;6283.59156654816;6352.460040896483;6468.838279043061;6524.217093948757;6634.303398143222;480.1573238965593;488.47732925769793;491.9311296418504;492.1608657239398;493.45226798253907;4217.599328063829;4292.420523229324;4327.805248763813;4335.544767799399;4338.219120558267;11884.286942783461;12069.879301206876;12169.391530423443;12179.695507612203;12191.329476878856;12035.277883327028;12064.57773977924;12126.090543209119;12138.08964327679;12170.330631815157;8454.704085356983;8829.735107946772;8872.955635221782;9043.638254469879;9141.222996045277;6538.150040494896;6550.6069635822005;6707.932920670731;6785.558938668971;6806.65966701653;10784.892151078702;11012.449377531251;11237.943810280896;11323.716907077389;11428.257163284692;11074.169437292074;11336.829947550628;11353.148513861659;11407.372594507382;11469.541218351173;8258.669653214045;8325.417220794487;8403.663853445794;8573.142685731376;8620.61207245663;9589.520523973913;9653.613855445703;9655.710328690151;9674.08096230857;9683.32216744821;8340.29107525867;8432.536210508235;8534.573271336532;8592.183742544448;8666.480011199348;8182.83634327322;8209.179082091743;8244.093149753402;8257.79355516117;8260.380471464545;6905.240423553506;7041.295870412918;7044.401225895651;7064.434845212268;7113.715451382094;5468.507834294933;5520.089185284383;5533.059379905345;5567.053600887778;5648.15277708347;5486.862828429321;5591.189277554813;5609.27079479665;5717.7141142941855;5750.741216645178 18:18:46 INFO - PROCESS | 7016 | |4;prototype.html;342.4366916422485;346.95047481368874;350.3221266848648;355.5289241754676;355.6496850602157;5687.488126068653;5819.894220098178;5912.733926973286;5948.791792287266;5956.702164891754;5781.855453613662;5808.709564521778;5821.970890145543;5831.912521312183;5853.7951171709;4608.493065762764;4624.491305956342;4627.542324167893;4637.489876113625;4640.628749700033;4403.471583409995;4548.021610599383;4563.338315944186;4567.132244873464;4567.497575266718;4510.14307281617;4510.729356238619;4523.231050721369;4525.683202175849;4526.8682829292675;4527.84152554659;4529.365888775574;4537.2059889519205;4542.386777785023;4583.922778147133;3952.980235098806;4029.15387768566;4052.7770972596495;4092.2224777292217;4097.959020409788;5632.211490391349;5646.350669672999;5654.6041777075625;5693.3168019837885;5713.942860571383;5222.529972302511;5278.155495120801;5285.048691235576;5298.258243845865;5323.973380133113;5911.793087241969;6122.897878381889;6141.570090093695;6177.62934223948;6197.946349120661;4449.399331090293;4464.665150113755;4466.4640243171025;4479.619232365253;4501.729896206205;6162.414570615784;6382.936170638327;6424.357564243585;6453.9677301613665;6463.515236357292;4502.549745025472;4530.524294949048;4553.430821147356;4553.838771113345;4563.634909207255;4620.884477888012;4636.11913736389;4654.301854721819;4654.697444666086;4655.2784318430695;5159.226116082617;5200.089984252741;5262.2632831403635;5281.234221037928;5331.866703332447;5912.3496415394275;6075.392460753889;6144.8771024579255;6168.19813424261;6184.226971628546;1535.439564558928;1562.8359022302723;1568.5843251538352;1568.741157708988;1570.5680937742213;951.1582249708919;982.6953644370268;986.225812736998;999.7850462150527;1003.5534187286734;5200.167973124282;5258.763355649005;5268.446813084647;5298.92051619226;5305.249267741636;5547.891801115631;5550.750216240279;5589.217509548666;5597.804076857372;5630.690312032795;4967.801287948441;5183.948160518422;5227.26818245446;5348.251244825728;5382.623216374895;2968.569557414163;2984.925376865552;2988.581598576201;3011.7741169412384;3014.306709456793;5709.3434255060365;5711.7144142792695;5727.427257274239;5741.282339707536;5748.5688573357165;5369.275147855068;5626.943730562642;5667.716614169275;5694.886102277931;5733.369329373849;5803.41747922179;5805.651660900359;5815.5929084963645;5837.737301821428;5840.911362046584;5607.299087614048;5620.662760234399;5647.305808257424;5894.6757928314355;6323.399277068671;6295.653739044214;6297.244330680348;6303.779367722291;6310.463610593151;6311.337309582428;6399;6568.934310656832;6584.275729669636;6647.5014373921185;6688.565243259172;4463.910721785611;4496.370508128799;4510.1656193604285;4510.706804057726;4526.185286648303;6249.78125765596;6357.523185760994;6388.2972872984865;6421.93578064232;6441.3880681335195;6225.28409232944;6227.377262273736;6233.657148856856;6239.1577137085915;6251.99968005117;6114.755409783559;6239.188905442264;6240.438360547572;6245.437910588069;6282.685865706788;6178.536609754196;6185.938140618716;6202.2867370253;6203.379662033761;6222.751089956351;6217.875642487215;6222.386597629097;6254.8123556293385;6296.905546416716;6306.148669929501;5910.261217347832;6052.910476114342;6053.727582258721;6062.484688801501;6133.44798968095 18:18:46 INFO - PROCESS | 7016 | |5;yui.html;816.1185919207253;845.7082306604219;848.2662496940146;851.1190917400492;876.1107475911948;16259.51221463355;17204;17900.37348692796;18072.096395180222;18075.367362142326;15617.92191039046;15625.437456254398;15633.062016279031;15706.450274240404;15740.606484837885;860.6084231674604;886.5257087458227;887.1749273175943;892.9642814287421;902.8645703144548;922.299052719931;930.1210356213381;930.7254359963827;931.8322701913653;933.0203286549096;969.5297780576415;969.8642190093393;971.9854202186973;972.9659461918834;974.055166488505;956.6077908057698;961.7739831139677;963.4026903319951;964.2382517810921;964.8215080210183;712.3624356201171;712.5546533416615;713.0587624335878;713.6075158662715;716.0083284650744;16832.15839208047;16873.071981041037;16926.661466770718;16938.66122677552;16972.23624936881;14325.426982920671;14382;14589.416423343053;15130.167840768754;15229.314680839278;14002.789958150533;14069.437222511087;14183.219922904236;14279.286035698278;14536.273186340746;3986.980065099656;4701.553352431513;4735.195016847144;4793.954539571285;4848.393950756155;84738.57630711868;84792.57603711942;84819;85180;85448.57275713581;11874.28754274729;11951.22317049389;12073.335966521925;12357;12358.382080895919;19863.801361986483;19951.900240498704;19962.401127966183;20020.69968950467;20053.29813456522;7984.9201507985335;8004.479708818908;8327.95836020816;8332.6666933322;8349.457285276438;4623.907521849612;4634.907301853944;4674.976625116853;4796.784144713496;5005.874853128701;3964.940525892114;4079.63283304504;4120.423140760296;4120.690948178899;4127.752334859918;675.270707635762;680.0547239337325;684.9041134241211;700.6671830880393;701.3827831508343;669.6785542939416;684.5105749389211;686.0121425147771;697.9546329488567;710.137183322266;9978.401295922267;10122.342047766871;10662.786744265071;10712.517936692868;10908.945455272673;706.3219309462974;775.8681024225782;787.2403130978519;789.1989630525022;795.4789612803623;5196.662216955886;5227.059129356676;5235.293235413171;5325.334333208349;5333.280007198979;70917.64541177261;81200.34598443084;130915.34542327418;135228;135993;67732;82093;82972.58513707513;111994.44002780097;114689.4265528667;102707.4864625672;102767;103928.99999999849;105522.47238763756;105640;9657.758556035875;9873.456959867277;10081.193504519475;10116.494175291353;10246.692599222035;58108.4189158103;59001.70499147477;59556.40443595508;60142;60440.697796510736;66824.99525014257;81178.5646430608;84058.57970710107;85211.14788852033;89886.55056724674;12587.496500140258;12778.61664150077;12920.418581164058;13018.349082546025;13403.463861445432;13202.471901123847;14092.647683807987;14190.787138193142;14455.566333010027;15386.538403847902;13596.66008349799;13745.24401157946;13844.930775346058;14049.578512644637;14119.01166918347;12887.613371598867;13095.148815326973;13116.540921067717;13140.211587304791;13193.80209296842;12785.36073196355;13219.47122115143;13225.941924646198;13316.933415332862;13463.798043029166;9897.802043958936;10098.687170667767;10330.638427654996;10471.162307015573;10476.738081548023;10634;10803.891961080602;10855.782884342427;10900.291481053706;11020.944895275472 18:18:46 INFO - PROCESS | 7016 | __end_tp_report 18:18:46 INFO - PROCESS | 7016 | __start_cc_report 18:18:46 INFO - PROCESS | 7016 | _x_x_mozilla_cycle_collect,348 18:18:46 INFO - PROCESS | 7016 | __end_cc_report 18:18:46 INFO - PROCESS | 7016 | __startTimestamp1475025526111__endTimestamp 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | ------- Summary: start ------- 18:18:46 INFO - PROCESS | 7016 | Number of tests: 6 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | [#0] dojo.html Cycles:165 Average:5770.69 Median:6026.10 stddev:661.93 (11.0%) stddev-sans-first:634.79 18:18:46 INFO - PROCESS | 7016 | Values: 3293.5 3342.7 3359.3 3361.7 3379.8 5830.8 5898.2 5901.2 5913.1 5917.7 5836.9 5883.5 5886.0 5892.0 5892.8 5310.0 5342.6 5365.6 5407.0 5424.2 5386.9 5391.9 5399.8 5402.8 5408.5 5201.9 5243.4 5329.0 5359.3 5400.1 5240.0 5301.8 5321.9 5323.2 5348.9 5187.4 5274.6 5289.1 5299.4 5306.8 5567.9 5589.8 5699.9 5766.2 5827.7 6014.0 6113.7 6117.6 6121.0 6128.4 6128.5 6136.7 6140.3 6145.0 6167.4 5690.2 5772.0 5774.2 5783.5 5808.1 6323.9 6453.2 6455.6 6458.1 6471.1 6131.8 6137.4 6176.5 6178.0 6184.1 6020.7 6037.2 6210.7 6251.8 6284.0 6041.0 6114.5 6129.1 6130.0 6135.4 6118.0 6128.2 6129.3 6138.2 6147.5 4580.0 4634.7 4668.3 4670.3 4675.8 4053.3 4139.3 4150.1 4165.0 4183.5 5858.4 5894.5 5897.4 5912.6 5921.2 5987.1 6115.6 6178.1 6185.6 6186.4 5962.5 6026.6 6036.7 6037.3 6075.0 5384.2 5387.8 5401.9 5402.0 5410.6 6137.7 6284.8 6376.3 6494.7 6515.9 6291.0 6294.7 6301.6 6306.8 6310.9 6442.4 6494.5 6513.6 6514.7 6517.6 5825.3 5981.6 5991.1 6181.4 6186.1 6180.1 6183.5 6186.3 6191.9 6192.7 6053.7 6062.7 6063.6 6063.7 6096.9 5987.7 6020.5 6035.7 6042.3 6065.3 6129.5 6129.8 6131.0 6135.9 6136.2 6131.2 6134.0 6142.9 6150.2 6200.8 5862.2 5906.5 5981.0 6026.1 6061.7 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | [#1] ext.html Cycles:180 Average:69303.10 Median:47007.15 stddev:141401.50 (300.8%) stddev-sans-first:141704.06 18:18:46 INFO - PROCESS | 7016 | Values: 591.2 644.3 656.1 660.5 691.9 42952.6 47006.8 47270.6 47523.5 47678.3 46596.0 47175.8 47195.5 47433.0 47475.5 9016.4 9139.5 9169.9 9187.4 9213.9 9082.8 9171.9 9186.8 9190.4 9210.1 9183.2 9228.1 9231.5 9242.5 9257.7 9178.2 9215.6 9216.9 9223.3 9232.3 9124.1 9146.3 9148.0 9163.9 9168.3 44614.0 44803.3 44915.6 44991.6 45129.8 3989.4 3993.9 4054.6 4066.1 4311.1 36235.3 36335.8 36377.0 36439.0 37904.0 4542.7 4546.5 4621.1 4629.5 4629.6 391084.0 391521.0 392872.0 393056.0 393703.0 64700.0 65043.0 65052.0 65196.0 65228.0 40655.6 69077.3 69118.7 69128.0 69329.7 15371.8 15726.5 15769.4 15800.9 15978.1 13396.2 13413.7 13475.3 13531.9 13571.5 21353.8 21393.7 21432.8 21547.4 21623.4 7700.5 7753.2 7864.7 7970.4 7971.1 1084.4 1106.7 1138.3 1163.7 1233.0 34691.8 34694.7 34725.7 34754.5 34886.8 1172.5 1198.9 1216.5 1228.5 1247.9 18012.3 18100.9 18447.2 18453.6 18461.9 669416.0 673954.0 676538.0 677946.0 679784.0 68119.3 68134.3 68469.0 68601.3 68627.0 1478.1 1480.1 1486.0 1495.6 1497.9 34085.0 34088.0 34230.0 34231.8 34497.8 57639.7 58121.7 58136.0 58169.4 58200.7 484489.0 485331.0 486319.0 486656.0 487005.0 31944.4 32001.9 32371.4 32561.3 32777.7 54502.2 54839.0 54970.5 55419.4 59357.0 46748.3 47867.3 47925.0 49495.5 49560.5 48457.0 48660.0 48705.5 48833.5 49223.8 46572.5 47007.5 47786.3 48040.5 49787.0 39059.4 40986.4 41325.8 41402.0 41854.8 31114.2 31719.2 31975.2 32248.8 32589.7 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | [#2] jquery.html Cycles:180 Average:30986.03 Median:21611.18 stddev:86324.42 (399.4%) stddev-sans-first:86536.05 18:18:46 INFO - PROCESS | 7016 | Values: 407.7 409.7 426.1 428.8 441.5 18880.5 21037.6 21192.8 21298.3 21904.7 20422.6 20797.2 20940.2 21111.6 21182.0 5990.2 6157.3 6164.0 6203.2 6205.2 5692.7 5935.6 5966.2 6114.2 6159.3 5957.7 5965.8 5996.4 6149.6 6567.2 6113.7 6445.8 6547.8 6596.3 6597.6 5925.9 6058.5 6063.6 6065.5 6095.2 14959.0 15096.3 15289.5 15440.7 15476.5 2419.6 2468.7 2583.9 2626.9 2921.7 9715.6 9899.0 10217.8 10239.3 10695.3 2042.4 2042.9 2100.3 2127.4 2169.0 90950.0 91486.5 92500.0 92748.5 94981.0 11564.1 11699.5 12114.5 12279.9 12331.0 16626.7 16688.2 16727.3 16734.5 16737.6 8284.7 8421.4 8512.2 8519.2 8963.5 7875.7 7975.7 8071.0 8184.0 8708.9 4872.3 4884.4 4970.7 5004.3 5116.7 2039.1 2068.6 2079.1 2102.2 2133.3 960.4 980.5 1013.1 1047.1 1096.6 21164.3 21510.0 21533.9 21688.5 21883.7 1003.7 1020.8 1025.8 1105.1 1108.2 10765.4 11765.0 11909.9 11932.4 11952.2 505955.0 507090.0 509443.0 513122.0 570580.0 99627.0 102435.0 102829.0 102986.0 103234.0 1078.2 1111.9 1116.9 1125.1 1133.2 18025.6 18861.7 18871.7 19064.4 19246.3 36834.4 40694.6 42623.0 44075.3 45618.0 61629.4 66084.0 66468.0 66984.7 67352.7 7980.1 8150.7 8496.0 8935.2 8942.6 14016.7 14072.6 14514.4 14577.3 15056.1 12628.2 12679.6 12761.2 13015.8 13036.5 12060.8 12186.1 12215.6 12299.4 12307.1 12661.0 12688.8 12836.3 12911.7 12913.7 8264.5 8347.7 8405.1 8448.3 8457.8 11243.7 11886.2 11963.0 12129.8 12525.6 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | [#3] mootools.html Cycles:180 Average:6297.80 Median:4310.11 stddev:3709.15 (86.1%) stddev-sans-first:3702.50 18:18:46 INFO - PROCESS | 7016 | Values: 1565.1 1583.8 1704.3 1766.9 1787.1 9173.7 9533.0 9879.6 9914.3 9956.4 9929.8 10018.4 10128.8 10156.0 10156.0 2457.3 2494.5 2498.7 2500.1 2503.6 2414.6 2479.1 2488.7 2495.1 2499.0 2447.5 2453.1 2454.4 2475.0 2475.4 2421.4 2423.5 2430.8 2483.1 2484.9 2305.9 2351.9 2354.3 2362.4 2374.7 9802.8 9938.0 9939.2 9948.0 9971.2 5434.5 5544.3 5573.8 5575.2 5576.2 3491.8 3501.8 3585.7 3638.0 3657.2 1215.4 1216.7 1221.3 1226.6 1230.7 13650.4 13722.4 13732.7 13744.2 13767.4 4530.9 4651.7 4742.3 4849.9 4871.2 10704.4 10704.5 10705.2 10706.2 10727.9 5576.2 5581.2 5587.7 5608.2 5610.6 4660.1 5079.0 5206.7 5216.3 5246.1 4139.6 4159.5 4180.7 4186.5 4195.2 1212.6 1218.5 1223.3 1225.8 1229.0 1001.4 1031.4 1034.1 1035.2 1047.2 6283.6 6352.5 6468.8 6524.2 6634.3 480.2 488.5 491.9 492.2 493.5 4217.6 4292.4 4327.8 4335.5 4338.2 11884.3 12069.9 12169.4 12179.7 12191.3 12035.3 12064.6 12126.1 12138.1 12170.3 8454.7 8829.7 8873.0 9043.6 9141.2 6538.2 6550.6 6707.9 6785.6 6806.7 10784.9 11012.4 11237.9 11323.7 11428.3 11074.2 11336.8 11353.1 11407.4 11469.5 8258.7 8325.4 8403.7 8573.1 8620.6 9589.5 9653.6 9655.7 9674.1 9683.3 8340.3 8432.5 8534.6 8592.2 8666.5 8182.8 8209.2 8244.1 8257.8 8260.4 6905.2 7041.3 7044.4 7064.4 7113.7 5468.5 5520.1 5533.1 5567.1 5648.2 5486.9 5591.2 5609.3 5717.7 5750.7 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | [#4] prototype.html Cycles:180 Average:5057.00 Median:5639.28 stddev:1480.93 (26.3%) stddev-sans-first:1442.19 18:18:46 INFO - PROCESS | 7016 | Values: 342.4 347.0 350.3 355.5 355.6 5687.5 5819.9 5912.7 5948.8 5956.7 5781.9 5808.7 5822.0 5831.9 5853.8 4608.5 4624.5 4627.5 4637.5 4640.6 4403.5 4548.0 4563.3 4567.1 4567.5 4510.1 4510.7 4523.2 4525.7 4526.9 4527.8 4529.4 4537.2 4542.4 4583.9 3953.0 4029.2 4052.8 4092.2 4098.0 5632.2 5646.4 5654.6 5693.3 5713.9 5222.5 5278.2 5285.0 5298.3 5324.0 5911.8 6122.9 6141.6 6177.6 6197.9 4449.4 4464.7 4466.5 4479.6 4501.7 6162.4 6382.9 6424.4 6454.0 6463.5 4502.5 4530.5 4553.4 4553.8 4563.6 4620.9 4636.1 4654.3 4654.7 4655.3 5159.2 5200.1 5262.3 5281.2 5331.9 5912.3 6075.4 6144.9 6168.2 6184.2 1535.4 1562.8 1568.6 1568.7 1570.6 951.2 982.7 986.2 999.8 1003.6 5200.2 5258.8 5268.4 5298.9 5305.2 5547.9 5550.8 5589.2 5597.8 5630.7 4967.8 5183.9 5227.3 5348.3 5382.6 2968.6 2984.9 2988.6 3011.8 3014.3 5709.3 5711.7 5727.4 5741.3 5748.6 5369.3 5626.9 5667.7 5694.9 5733.4 5803.4 5805.7 5815.6 5837.7 5840.9 5607.3 5620.7 5647.3 5894.7 6323.4 6295.7 6297.2 6303.8 6310.5 6311.3 6399.0 6568.9 6584.3 6647.5 6688.6 4463.9 4496.4 4510.2 4510.7 4526.2 6249.8 6357.5 6388.3 6421.9 6441.4 6225.3 6227.4 6233.7 6239.2 6252.0 6114.8 6239.2 6240.4 6245.4 6282.7 6178.5 6185.9 6202.3 6203.4 6222.8 6217.9 6222.4 6254.8 6296.9 6306.1 5910.3 6052.9 6053.7 6062.5 6133.4 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - PROCESS | 7016 | [#5] yui.html Cycles:180 Average:21865.43 Median:4124.22 stddev:31833.51 (771.9%) stddev-sans-first:31883.58 18:18:46 INFO - PROCESS | 7016 | Values: 816.1 845.7 848.3 851.1 876.1 16259.5 17204.0 17900.4 18072.1 18075.4 15617.9 15625.4 15633.1 15706.5 15740.6 860.6 886.5 887.2 893.0 902.9 922.3 930.1 930.7 931.8 933.0 969.5 969.9 972.0 973.0 974.1 956.6 961.8 963.4 964.2 964.8 712.4 712.6 713.1 713.6 716.0 16832.2 16873.1 16926.7 16938.7 16972.2 14325.4 14382.0 14589.4 15130.2 15229.3 14002.8 14069.4 14183.2 14279.3 14536.3 3987.0 4701.6 4735.2 4794.0 4848.4 84738.6 84792.6 84819.0 85180.0 85448.6 11874.3 11951.2 12073.3 12357.0 12358.4 19863.8 19951.9 19962.4 20020.7 20053.3 7984.9 8004.5 8328.0 8332.7 8349.5 4623.9 4634.9 4675.0 4796.8 5005.9 3964.9 4079.6 4120.4 4120.7 4127.8 675.3 680.1 684.9 700.7 701.4 669.7 684.5 686.0 698.0 710.1 9978.4 10122.3 10662.8 10712.5 10908.9 706.3 775.9 787.2 789.2 795.5 5196.7 5227.1 5235.3 5325.3 5333.3 70917.6 81200.3 130915.3 135228.0 135993.0 67732.0 82093.0 82972.6 111994.4 114689.4 102707.5 102767.0 103929.0 105522.5 105640.0 9657.8 9873.5 10081.2 10116.5 10246.7 58108.4 59001.7 59556.4 60142.0 60440.7 66825.0 81178.6 84058.6 85211.1 89886.6 12587.5 12778.6 12920.4 13018.3 13403.5 13202.5 14092.6 14190.8 14455.6 15386.5 13596.7 13745.2 13844.9 14049.6 14119.0 12887.6 13095.1 13116.5 13140.2 13193.8 12785.4 13219.5 13225.9 13316.9 13463.8 9897.8 10098.7 10330.6 10471.2 10476.7 10634.0 10803.9 10855.8 10900.3 11020.9 18:18:46 INFO - PROCESS | 7016 | -------- Summary: end -------- 18:18:46 INFO - PROCESS | 7016 | 18:18:46 INFO - TEST-INFO | 7016: exit 0 18:18:46 INFO - TEST-OK | dromaeo_css | took 1110692ms 18:18:46 INFO - TEST-START | kraken 18:18:46 INFO - operating with platform_type : linux_ 18:18:46 INFO - Initialising browser for kraken test... 18:18:46 INFO - TEST-INFO | started process 7259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEZ1GfY/profile http://localhost:44580/getInfo.html) 18:18:51 INFO - PROCESS | 7259 | __metrics Screen width/height:1600/1200 18:18:51 INFO - PROCESS | 7259 | colorDepth:24 18:18:51 INFO - PROCESS | 7259 | Browser inner width/height: 1024/697 18:18:51 INFO - PROCESS | 7259 | __metrics 18:18:51 ERROR - PROCESS | 7259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:18:52 INFO - TEST-INFO | 7259: exit 0 18:18:52 INFO - Browser initialized. 18:18:52 INFO - Running cycle 1/1 for kraken test... 18:18:52 INFO - TEST-INFO | started process 7385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEZ1GfY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:04 INFO - PROCESS | 7385 | RSS: Main: 149700608 18:19:04 INFO - PROCESS | 7385 | 18:19:06 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44580/tests/kraken/driver.html?testName=audio-beat-detection) 18:19:07 INFO - PROCESS | 7385 | RSS: Main: 156553216 18:19:07 INFO - PROCESS | 7385 | 18:19:10 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44580/tests/kraken/driver.html?testName=audio-dft) 18:19:10 INFO - PROCESS | 7385 | RSS: Main: 155037696 18:19:10 INFO - PROCESS | 7385 | 18:19:13 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44580/tests/kraken/driver.html?testName=audio-fft) 18:19:14 INFO - PROCESS | 7385 | RSS: Main: 155824128 18:19:14 INFO - PROCESS | 7385 | 18:19:16 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44580/tests/kraken/driver.html?testName=audio-oscillator) 18:19:16 INFO - PROCESS | 7385 | RSS: Main: 155828224 18:19:16 INFO - PROCESS | 7385 | 18:19:19 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:19:19 INFO - PROCESS | 7385 | RSS: Main: 155639808 18:19:19 INFO - PROCESS | 7385 | 18:19:22 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44580/tests/kraken/driver.html?testName=imaging-darkroom) 18:19:23 INFO - PROCESS | 7385 | RSS: Main: 155734016 18:19:23 INFO - PROCESS | 7385 | 18:19:26 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44580/tests/kraken/driver.html?testName=imaging-desaturate) 18:19:27 INFO - PROCESS | 7385 | RSS: Main: 156413952 18:19:27 INFO - PROCESS | 7385 | 18:19:30 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44580/tests/kraken/driver.html?testName=json-parse-financial) 18:19:30 INFO - PROCESS | 7385 | RSS: Main: 155955200 18:19:30 INFO - PROCESS | 7385 | 18:19:32 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:19:32 INFO - PROCESS | 7385 | RSS: Main: 155238400 18:19:32 INFO - PROCESS | 7385 | 18:19:34 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:19:35 INFO - PROCESS | 7385 | RSS: Main: 155566080 18:19:35 INFO - PROCESS | 7385 | 18:19:37 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:19:38 INFO - PROCESS | 7385 | RSS: Main: 156119040 18:19:38 INFO - PROCESS | 7385 | 18:19:40 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:19:41 INFO - PROCESS | 7385 | RSS: Main: 156164096 18:19:41 INFO - PROCESS | 7385 | 18:19:43 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:19:44 INFO - PROCESS | 7385 | RSS: Main: 156860416 18:19:44 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:44580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44580/tests/kraken/driver.html?testName=ai-astar) 18:19:46 INFO - PROCESS | 7385 | RSS: Main: 158199808 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | __start_tp_report 18:19:46 INFO - PROCESS | 7385 | _x_x_mozilla_page_load 18:19:46 INFO - PROCESS | 7385 | _x_x_mozilla_page_load_details 18:19:46 INFO - PROCESS | 7385 | |i|pagename|runs| 18:19:46 INFO - PROCESS | 7385 | |0;ai-astar;100;110;104;110;109;110;110;109;110;109 18:19:46 INFO - PROCESS | 7385 | |1;audio-beat-detection;144;117;142;165;120;149;147;117;176;121 18:19:46 INFO - PROCESS | 7385 | |2;audio-dft;163;162;165;162;162;161;161;161;161;160 18:19:46 INFO - PROCESS | 7385 | |3;audio-fft;75;75;77;169;76;76;74;75;156;76 18:19:46 INFO - PROCESS | 7385 | |4;audio-oscillator;85;86;153;83;84;84;134;87;83;149 18:19:46 INFO - PROCESS | 7385 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;122;118 18:19:46 INFO - PROCESS | 7385 | |6;imaging-darkroom;148;148;147;146;146;146;146;147;147;146 18:19:46 INFO - PROCESS | 7385 | |7;imaging-desaturate;100;96;95;96;94;95;96;95;95;95 18:19:46 INFO - PROCESS | 7385 | |8;json-parse-financial;55;52;52;51;52;52;52;51;52;55 18:19:46 INFO - PROCESS | 7385 | |9;json-stringify-tinderbox;63;60;60;61;61;60;60;61;63;60 18:19:46 INFO - PROCESS | 7385 | |10;stanford-crypto-aes;73;79;71;72;78;86;71;73;72;72 18:19:46 INFO - PROCESS | 7385 | |11;stanford-crypto-ccm;131;118;118;126;117;136;132;116;171;116 18:19:46 INFO - PROCESS | 7385 | |12;stanford-crypto-pbkdf2;158;160;152;156;153;154;154;152;151;152 18:19:46 INFO - PROCESS | 7385 | |13;stanford-crypto-sha256-iterative;64;69;63;64;63;67;65;62;61;62 18:19:46 INFO - PROCESS | 7385 | __end_tp_report 18:19:46 INFO - PROCESS | 7385 | __start_cc_report 18:19:46 INFO - PROCESS | 7385 | _x_x_mozilla_cycle_collect,862 18:19:46 INFO - PROCESS | 7385 | __end_cc_report 18:19:46 INFO - PROCESS | 7385 | __startTimestamp1475025586399__endTimestamp 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | ------- Summary: start ------- 18:19:46 INFO - PROCESS | 7385 | Number of tests: 14 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.38 (3.1%) stddev-sans-first:1.94 18:19:46 INFO - PROCESS | 7385 | Values: 100.0 110.0 104.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:145.50 stddev:20.79 (14.3%) stddev-sans-first:21.99 18:19:46 INFO - PROCESS | 7385 | Values: 144.0 117.0 142.0 165.0 120.0 149.0 147.0 117.0 176.0 121.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.41 18:19:46 INFO - PROCESS | 7385 | Values: 163.0 162.0 165.0 162.0 162.0 161.0 161.0 161.0 161.0 160.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:36.82 (48.8%) stddev-sans-first:38.48 18:19:46 INFO - PROCESS | 7385 | Values: 75.0 75.0 77.0 169.0 76.0 76.0 74.0 75.0 156.0 76.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.00 stddev:29.75 (35.4%) stddev-sans-first:30.85 18:19:46 INFO - PROCESS | 7385 | Values: 85.0 86.0 153.0 83.0 84.0 84.0 134.0 87.0 83.0 149.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:1.57 (1.3%) stddev-sans-first:1.64 18:19:46 INFO - PROCESS | 7385 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 122.0 118.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 18:19:46 INFO - PROCESS | 7385 | Values: 148.0 148.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.64 (1.7%) stddev-sans-first:0.67 18:19:46 INFO - PROCESS | 7385 | Values: 100.0 96.0 95.0 96.0 94.0 95.0 96.0 95.0 95.0 95.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:1.43 (2.7%) stddev-sans-first:1.17 18:19:46 INFO - PROCESS | 7385 | Values: 55.0 52.0 52.0 51.0 52.0 52.0 52.0 51.0 52.0 55.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:1.20 (2.0%) stddev-sans-first:1.00 18:19:46 INFO - PROCESS | 7385 | Values: 63.0 60.0 60.0 61.0 61.0 60.0 60.0 61.0 63.0 60.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:73.00 stddev:4.85 (6.7%) stddev-sans-first:5.11 18:19:46 INFO - PROCESS | 7385 | Values: 73.0 79.0 71.0 72.0 78.0 86.0 71.0 73.0 72.0 72.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:128.50 stddev:16.84 (13.1%) stddev-sans-first:17.82 18:19:46 INFO - PROCESS | 7385 | Values: 131.0 118.0 118.0 126.0 117.0 136.0 132.0 116.0 171.0 116.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:154.00 stddev:2.94 (1.9%) stddev-sans-first:2.77 18:19:46 INFO - PROCESS | 7385 | Values: 158.0 160.0 152.0 156.0 153.0 154.0 154.0 152.0 151.0 152.0 18:19:46 INFO - PROCESS | 7385 | 18:19:46 INFO - PROCESS | 7385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.45 (3.8%) stddev-sans-first:2.60 18:19:46 INFO - PROCESS | 7385 | Values: 64.0 69.0 63.0 64.0 63.0 67.0 65.0 62.0 61.0 62.0 18:19:46 INFO - PROCESS | 7385 | -------- Summary: end -------- 18:19:46 INFO - PROCESS | 7385 | 18:19:47 INFO - TEST-INFO | 7385: exit 0 18:19:47 INFO - TEST-OK | kraken | took 60546ms 18:19:47 INFO - SUITE-END | took 1171s 18:19:47 INFO - Completed test suite (00:19:31) 18:19:47 INFO - javascript benchmark 18:19:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7778.193042823849, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.4730443129097, 3342.732581393488, 3359.277755282615, 3361.7478689098325, 3379.831008449577, 5830.795922142721, 5898.174255604208, 5901.232839730835, 5913.14259432382, 5917.73370198341, 5836.941630583693, 5883.499902508282, 5885.969955257834, 5891.970540147304, 5892.793752218662, 5310.0, 5342.599305052117, 5365.570754339644, 5406.968338875234, 5424.240606315119, 5386.946130538684, 5391.892162156754, 5399.83800485986, 5402.756875940592, 5408.540274076709, 5201.921971170435, 5243.449437809032, 5328.973355133219, 5359.330083739533, 5400.108982017962, 5240.03059434004, 5301.787928482856, 5321.8935621287355, 5323.201519772065, 5348.946510534884, 5187.403448603383, 5274.55166310864, 5289.127293996486, 5299.417064122943, 5306.814261500829, 5567.8608034799045, 5589.832305030855, 5699.886002279973, 5766.192733017381, 5827.650340979555, 6014.0, 6113.658745237687, 6117.553376797881, 6121.045392021996, 6128.411459112332, 6128.533679014817, 6136.746076527064, 6140.293866205398, 6145.047517634774, 6167.352427995085, 5690.231818704505, 5772.0, 5774.162746401748, 5783.537317014629, 5808.070708686632, 6323.936760632427, 6453.1610890583925, 6455.61266324022, 6458.095866578683, 6471.061696054046, 6131.785387511416, 6137.447629713347, 6176.536759743038, 6178.0, 6184.134221209034, 6020.668863212478, 6037.215162028908, 6210.689465526705, 6251.812445626639, 6284.0, 6040.969795151084, 6114.510272098727, 6129.056396697549, 6130.004390691762, 6135.385782596045, 6118.040554665226, 6128.203333566607, 6129.301012237645, 6138.163647720175, 6147.508199344042, 4580.0152967112235, 4634.6987445816585, 4668.299755036772, 4670.276107203389, 4675.812967481263, 4053.3312003519677, 4139.317012692933, 4150.149219410014, 4165.021220013295, 4183.5398106208295, 5858.355580886099, 5894.469497745224, 5897.410258974069, 5912.586118971631, 5921.154008659072, 5987.101934709828, 6115.602485838495, 6178.073289006685, 6185.597936134137, 6186.350433204539, 5962.4633782959745, 6026.638401695912, 6036.698165091728, 6037.305709843425, 6075.0, 5384.192371144281, 5387.75755091014, 5401.945980540223, 5402.0, 5410.648307859977, 6137.723802428812, 6284.811455656338, 6376.330485298977, 6494.707738151795, 6515.934840651533, 6290.968545157245, 6294.653794041372, 6301.590396624205, 6306.810795676137, 6310.873782524232, 6442.35576442352, 6494.512911531559, 6513.576617519846, 6514.73941042353, 6517.641529715911, 5825.300963884361, 5981.551383646157, 5991.071383935497, 6181.443670069715, 6186.1339412483185, 6180.103884936749, 6183.505319574513, 6186.319504854372, 6191.938080619136, 6192.721327540362, 6053.697315134314, 6062.727177277121, 6063.636181829104, 6063.6664983426335, 6096.8780624388155, 5987.670678112746, 6020.488258497901, 6035.728392222449, 6042.305134909541, 6065.302490213506, 6129.515066852852, 6129.8467538310115, 6131.040261761288, 6135.9386406137155, 6136.23297087864, 6131.157172517858, 6133.969330153321, 6142.938570614237, 6150.169727086786, 6200.81397558074, 5862.237909071964, 5906.468417842415, 5981.043033114681, 6026.096085587022, 6061.6666083365835], "value": 5725.139722079056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1989254560071, 644.2591020326624, 656.0716586030763, 660.5376236634355, 691.9446444284458, 42952.57047429525, 47006.76496617512, 47270.58188254358, 47523.52476475234, 47678.28482572764, 46596.0, 47175.764121179345, 47195.52804471954, 47433.0, 47475.52524474754, 9016.41393309436, 9139.543022848864, 9169.908300917006, 9187.448753074803, 9213.861792073125, 9082.818343633156, 9171.908280917172, 9186.770330741752, 9190.448573085603, 9210.125038121401, 9183.173514383705, 9228.077192280753, 9231.492267925261, 9242.491662958535, 9257.722268331961, 9178.173964343208, 9215.631374745002, 9216.861747073799, 9223.262139028895, 9232.261419086457, 9124.087591240888, 9146.2682985361, 9148.0, 9163.862542061874, 9168.312376571785, 44614.0, 44803.32795008078, 44915.55084449147, 44991.55008449906, 45129.77435112836, 3989.3816458448987, 3993.9201215975518, 4054.614811592894, 4066.146109317047, 4311.073119279338, 36235.275294494226, 36335.81832090849, 36377.0, 36439.0, 37904.0, 4542.734616535367, 4546.545345465427, 4621.1219868224925, 4629.537046295377, 4629.583337499607, 391084.0, 391521.0, 392872.0, 393056.0, 393702.99999999715, 64700.0, 65043.0, 65052.0, 65196.0, 65228.0, 40655.59344406577, 69077.30922690709, 69118.65440672864, 69128.0, 69329.65335173292, 15371.769423458658, 15726.528204153894, 15769.369225230863, 15800.92099539495, 15978.121203333929, 13396.196228226143, 13413.731725365438, 13475.258860762751, 13531.864681353258, 13571.524996625269, 21353.78646213518, 21393.67909481359, 21432.78567214339, 21547.353579392642, 21623.351299461043, 7700.499467534592, 7753.224677532315, 7864.72473463426, 7970.362371010306, 7971.123176450586, 1084.3764835219781, 1106.656936349718, 1138.2942575603179, 1163.7032556697989, 1233.0382301804607, 34691.82654086764, 34694.65305346914, 34725.652743472245, 34754.478682819776, 34886.82556587252, 1172.5251273234353, 1198.9100817438728, 1216.4708351866966, 1228.4840367045863, 1247.9126461147632, 18012.32927353185, 18100.909495452437, 18447.16987735555, 18453.583739450893, 18461.907690461463, 669416.0, 673954.0, 676538.0, 677946.0, 679784.0, 68119.3188068113, 68134.31865681379, 68469.0, 68601.31398686049, 68627.0, 1478.1131321207404, 1480.141517919604, 1485.9554213373617, 1495.5513345996376, 1497.8541415816908, 34085.0, 34088.0, 34230.0, 34231.82884085663, 34497.82751086329, 57639.711801440724, 58121.70939145446, 58136.0, 58169.4183058164, 58200.70899645475, 484489.0, 485331.0, 486319.0, 486656.0, 487005.0, 31944.36111277715, 32001.872211599635, 32371.352572947937, 32561.348773023932, 32777.67222327746, 54502.18246726223, 54839.0, 54970.450295496536, 55419.44580554143, 59357.0, 46748.29877551908, 47867.28199076947, 47925.0, 49495.50504494909, 49560.50439495559, 48457.0, 48660.0, 48705.512944871516, 48833.51166488432, 49223.75388123036, 46572.53427465682, 47007.52992470168, 47786.28320575264, 48040.519594803605, 49787.0, 39059.41410878782, 40986.385204222555, 41325.79337103295, 41402.0, 41854.79072604617, 31114.22214444657, 31719.207019824687, 31975.200619983756, 32248.83875580701, 32589.674103258665], "value": 22122.586847964365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.6616408381044, 409.7275311917575, 426.1477045908183, 428.79632174717005, 441.474645172245, 18880.52798680032, 21037.579248415022, 21192.788072119274, 21298.254561090365, 21904.671429928563, 20422.591548169064, 20797.16811327545, 20940.16239350428, 21111.577768444662, 21182.0, 5990.1913241712355, 6157.2919114301985, 6164.044573091156, 6203.162573052626, 6205.1623030890705, 5692.715364231793, 5935.64386136831, 5966.164736936832, 6114.205153330083, 6159.3224745277985, 5957.672328021957, 5965.761369545213, 5996.430339117776, 6149.569530132892, 6567.244766851802, 6113.724882380304, 6445.774397896074, 6547.770828021044, 6596.307387724291, 6597.60414375139, 5925.940740592582, 6058.545609079337, 6063.605865618721, 6065.545084118665, 6095.207623009025, 14959.0, 15096.320665570076, 15289.464868729541, 15440.691186176326, 15476.458323958608, 2419.588669926117, 2468.6543883856275, 2583.935401614956, 2626.9474610507873, 2921.737043666059, 9715.61137554497, 9898.9505052475, 10217.846732299022, 10239.334443261165, 10695.304805187716, 2042.3566576528347, 2042.867213631124, 2100.2649072824543, 2127.351157896841, 2169.013099039933, 90950.0, 91486.5425672874, 92500.0, 92748.53625731896, 94981.0, 11564.132690048113, 11699.532018719327, 12114.454849531792, 12279.877201227873, 12331.0, 16626.6674666506, 16688.249028793733, 16727.330906763593, 16734.49796506107, 16737.581560461087, 8284.668613255522, 8421.410501264852, 8512.191341822518, 8519.190676885686, 8963.462192268486, 7875.724349647735, 7975.720849770346, 8071.031476222891, 8183.95908020456, 8708.869366959501, 4872.269159626085, 4884.438289596671, 4970.726610036482, 5004.344222184486, 5116.718580478035, 2039.0620314655425, 2068.6069646767064, 2079.064421010551, 2102.1906565971904, 2133.328001679497, 960.3805545423163, 980.5391466010964, 1013.0983424751977, 1047.1151876664208, 1096.550414330121, 21164.259250926145, 21510.0, 21533.89233053825, 21688.457788555097, 21883.67174492384, 1003.7490627343165, 1020.831562792131, 1025.8204814157493, 1105.0827812915422, 1108.229780302682, 10765.38768984809, 11765.0, 11909.940450297867, 11932.403379830974, 11952.22310549829, 505955.0, 507090.0, 509443.0, 513122.0, 570580.0, 99627.0, 102435.0, 102829.0, 102986.0, 103234.0, 1078.159035951943, 1111.899929006377, 1116.9497372618252, 1125.099920063962, 1133.155798929786, 18025.639487210443, 18861.717074243625, 18871.716924245873, 19064.4359979646, 19246.326378576683, 36834.44748328724, 40694.59305406908, 42623.0, 44075.33886991762, 45618.0, 61629.38370616236, 66084.0, 66468.0, 66984.66507667431, 67352.6632366835, 7980.12218655959, 8150.673973041012, 8496.022957359983, 8935.195832375117, 8942.597583108905, 14016.719665606835, 14072.577822665336, 14514.419423222953, 14577.271136442923, 15056.096634201545, 12628.179168354027, 12679.55621553278, 12761.234325940473, 13015.804762928754, 13036.543720969721, 12060.819087713868, 12186.086043546593, 12215.633530994084, 12299.385030748606, 12307.138500305251, 12661.0, 12688.809667855174, 12836.294003829878, 12911.677208069874, 12913.677158071123, 8264.545450000307, 8347.666093356198, 8405.07544170153, 8448.324134069137, 8457.773622824532, 11243.66269011931, 11886.227395219283, 11963.0, 12129.75740485203, 12525.56160534377], "value": 9732.814897887372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1565.1000674612098, 1583.7624356346546, 1704.2586474883426, 1766.9204885780146, 1787.1421717575556, 9173.67892123775, 9532.952335238315, 9879.5554200061, 9914.305998580103, 9956.352837065595, 9929.751756206098, 10018.448985305806, 10128.797424051514, 10156.0, 10156.035176658206, 2457.2751038443703, 2494.5010997800423, 2498.650188973545, 2500.1374525788574, 2503.5869081601513, 2414.6498757680124, 2479.119912431088, 2488.664030355906, 2495.1017633651873, 2499.0, 2447.5104979004273, 2453.129139155601, 2454.4232105455294, 2475.0, 2475.4430253192977, 2421.382547450398, 2423.53952748978, 2430.7812296893276, 2483.056438553356, 2484.9378765531005, 2305.896234669427, 2351.8588884666806, 2354.2937118864443, 2362.350353652742, 2374.6794182785275, 9802.754931126708, 9938.0, 9939.204863610894, 9948.0, 9971.152452041586, 5434.510894019557, 5544.251526043973, 5573.777048918038, 5575.219469274305, 5576.191452239443, 3491.841283552027, 3501.77238479498, 3585.713142948584, 3637.963620363789, 3657.213699054689, 1215.4226742297426, 1216.7140721930339, 1221.3099598726692, 1226.5952235762265, 1230.7107829660022, 13650.385732642055, 13722.382492787849, 13732.65668358289, 13744.175349478963, 13767.38046787897, 4530.932036019462, 4651.744154071491, 4742.33607294979, 4849.9030019399415, 4871.244957031666, 10704.411257380763, 10704.464776761131, 10705.197110216764, 10706.197035222389, 10727.892721072845, 5576.219329293902, 5581.2186293918885, 5587.7485513152005, 5608.158776183605, 5610.551155907518, 4660.091282199938, 5079.0, 5206.71363075027, 5216.295800067019, 5246.134387826042, 4139.586041395836, 4159.523369203889, 4180.728252663628, 4186.539480657125, 4195.244855925963, 1212.6240865331774, 1218.4760552962134, 1223.3149436315691, 1225.7732319520917, 1228.969275768113, 1001.4191768774093, 1031.3554028732042, 1034.1003327105466, 1035.1822060572215, 1047.1518070363031, 6283.59156654816, 6352.460040896483, 6468.838279043061, 6524.217093948757, 6634.303398143222, 480.1573238965593, 488.47732925769793, 491.9311296418504, 492.1608657239398, 493.45226798253907, 4217.599328063829, 4292.420523229324, 4327.805248763813, 4335.544767799399, 4338.219120558267, 11884.286942783461, 12069.879301206876, 12169.391530423443, 12179.695507612203, 12191.329476878856, 12035.277883327028, 12064.57773977924, 12126.090543209119, 12138.08964327679, 12170.330631815157, 8454.704085356983, 8829.735107946772, 8872.955635221782, 9043.638254469879, 9141.222996045277, 6538.150040494896, 6550.6069635822005, 6707.932920670731, 6785.558938668971, 6806.65966701653, 10784.892151078702, 11012.449377531251, 11237.943810280896, 11323.716907077389, 11428.257163284692, 11074.169437292074, 11336.829947550628, 11353.148513861659, 11407.372594507382, 11469.541218351173, 8258.669653214045, 8325.417220794487, 8403.663853445794, 8573.142685731376, 8620.61207245663, 9589.520523973913, 9653.613855445703, 9655.710328690151, 9674.08096230857, 9683.32216744821, 8340.29107525867, 8432.536210508235, 8534.573271336532, 8592.183742544448, 8666.480011199348, 8182.83634327322, 8209.179082091743, 8244.093149753402, 8257.79355516117, 8260.380471464545, 6905.240423553506, 7041.295870412918, 7044.401225895651, 7064.434845212268, 7113.715451382094, 5468.507834294933, 5520.089185284383, 5533.059379905345, 5567.053600887778, 5648.15277708347, 5486.862828429321, 5591.189277554813, 5609.27079479665, 5717.7141142941855, 5750.741216645178], "value": 4893.23908847953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4366916422485, 346.95047481368874, 350.3221266848648, 355.5289241754676, 355.6496850602157, 5687.488126068653, 5819.894220098178, 5912.733926973286, 5948.791792287266, 5956.702164891754, 5781.855453613662, 5808.709564521778, 5821.970890145543, 5831.912521312183, 5853.7951171709, 4608.493065762764, 4624.491305956342, 4627.542324167893, 4637.489876113625, 4640.628749700033, 4403.471583409995, 4548.021610599383, 4563.338315944186, 4567.132244873464, 4567.497575266718, 4510.14307281617, 4510.729356238619, 4523.231050721369, 4525.683202175849, 4526.8682829292675, 4527.84152554659, 4529.365888775574, 4537.2059889519205, 4542.386777785023, 4583.922778147133, 3952.980235098806, 4029.15387768566, 4052.7770972596495, 4092.2224777292217, 4097.959020409788, 5632.211490391349, 5646.350669672999, 5654.6041777075625, 5693.3168019837885, 5713.942860571383, 5222.529972302511, 5278.155495120801, 5285.048691235576, 5298.258243845865, 5323.973380133113, 5911.793087241969, 6122.897878381889, 6141.570090093695, 6177.62934223948, 6197.946349120661, 4449.399331090293, 4464.665150113755, 4466.4640243171025, 4479.619232365253, 4501.729896206205, 6162.414570615784, 6382.936170638327, 6424.357564243585, 6453.9677301613665, 6463.515236357292, 4502.549745025472, 4530.524294949048, 4553.430821147356, 4553.838771113345, 4563.634909207255, 4620.884477888012, 4636.11913736389, 4654.301854721819, 4654.697444666086, 4655.2784318430695, 5159.226116082617, 5200.089984252741, 5262.2632831403635, 5281.234221037928, 5331.866703332447, 5912.3496415394275, 6075.392460753889, 6144.8771024579255, 6168.19813424261, 6184.226971628546, 1535.439564558928, 1562.8359022302723, 1568.5843251538352, 1568.741157708988, 1570.5680937742213, 951.1582249708919, 982.6953644370268, 986.225812736998, 999.7850462150527, 1003.5534187286734, 5200.167973124282, 5258.763355649005, 5268.446813084647, 5298.92051619226, 5305.249267741636, 5547.891801115631, 5550.750216240279, 5589.217509548666, 5597.804076857372, 5630.690312032795, 4967.801287948441, 5183.948160518422, 5227.26818245446, 5348.251244825728, 5382.623216374895, 2968.569557414163, 2984.925376865552, 2988.581598576201, 3011.7741169412384, 3014.306709456793, 5709.3434255060365, 5711.7144142792695, 5727.427257274239, 5741.282339707536, 5748.5688573357165, 5369.275147855068, 5626.943730562642, 5667.716614169275, 5694.886102277931, 5733.369329373849, 5803.41747922179, 5805.651660900359, 5815.5929084963645, 5837.737301821428, 5840.911362046584, 5607.299087614048, 5620.662760234399, 5647.305808257424, 5894.6757928314355, 6323.399277068671, 6295.653739044214, 6297.244330680348, 6303.779367722291, 6310.463610593151, 6311.337309582428, 6399.0, 6568.934310656832, 6584.275729669636, 6647.5014373921185, 6688.565243259172, 4463.910721785611, 4496.370508128799, 4510.1656193604285, 4510.706804057726, 4526.185286648303, 6249.78125765596, 6357.523185760994, 6388.2972872984865, 6421.93578064232, 6441.3880681335195, 6225.28409232944, 6227.377262273736, 6233.657148856856, 6239.1577137085915, 6251.99968005117, 6114.755409783559, 6239.188905442264, 6240.438360547572, 6245.437910588069, 6282.685865706788, 6178.536609754196, 6185.938140618716, 6202.2867370253, 6203.379662033761, 6222.751089956351, 6217.875642487215, 6222.386597629097, 6254.8123556293385, 6296.905546416716, 6306.148669929501, 5910.261217347832, 6052.910476114342, 6053.727582258721, 6062.484688801501, 6133.44798968095], "value": 4578.7969884622635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.1185919207253, 845.7082306604219, 848.2662496940146, 851.1190917400492, 876.1107475911948, 16259.51221463355, 17204.0, 17900.37348692796, 18072.096395180222, 18075.367362142326, 15617.92191039046, 15625.437456254398, 15633.062016279031, 15706.450274240404, 15740.606484837885, 860.6084231674604, 886.5257087458227, 887.1749273175943, 892.9642814287421, 902.8645703144548, 922.299052719931, 930.1210356213381, 930.7254359963827, 931.8322701913653, 933.0203286549096, 969.5297780576415, 969.8642190093393, 971.9854202186973, 972.9659461918834, 974.055166488505, 956.6077908057698, 961.7739831139677, 963.4026903319951, 964.2382517810921, 964.8215080210183, 712.3624356201171, 712.5546533416615, 713.0587624335878, 713.6075158662715, 716.0083284650744, 16832.15839208047, 16873.071981041037, 16926.661466770718, 16938.66122677552, 16972.23624936881, 14325.426982920671, 14382.0, 14589.416423343053, 15130.167840768754, 15229.314680839278, 14002.789958150533, 14069.437222511087, 14183.219922904236, 14279.286035698278, 14536.273186340746, 3986.980065099656, 4701.553352431513, 4735.195016847144, 4793.954539571285, 4848.393950756155, 84738.57630711868, 84792.57603711942, 84819.0, 85180.0, 85448.57275713581, 11874.28754274729, 11951.22317049389, 12073.335966521925, 12357.0, 12358.382080895919, 19863.801361986483, 19951.900240498704, 19962.401127966183, 20020.69968950467, 20053.29813456522, 7984.9201507985335, 8004.479708818908, 8327.95836020816, 8332.6666933322, 8349.457285276438, 4623.907521849612, 4634.907301853944, 4674.976625116853, 4796.784144713496, 5005.874853128701, 3964.940525892114, 4079.63283304504, 4120.423140760296, 4120.690948178899, 4127.752334859918, 675.270707635762, 680.0547239337325, 684.9041134241211, 700.6671830880393, 701.3827831508343, 669.6785542939416, 684.5105749389211, 686.0121425147771, 697.9546329488567, 710.137183322266, 9978.401295922267, 10122.342047766871, 10662.786744265071, 10712.517936692868, 10908.945455272673, 706.3219309462974, 775.8681024225782, 787.2403130978519, 789.1989630525022, 795.4789612803623, 5196.662216955886, 5227.059129356676, 5235.293235413171, 5325.334333208349, 5333.280007198979, 70917.64541177261, 81200.34598443084, 130915.34542327418, 135228.0, 135993.0, 67732.0, 82093.0, 82972.58513707513, 111994.44002780097, 114689.4265528667, 102707.4864625672, 102767.0, 103928.99999999849, 105522.47238763756, 105640.0, 9657.758556035875, 9873.456959867277, 10081.193504519475, 10116.494175291353, 10246.692599222035, 58108.4189158103, 59001.70499147477, 59556.40443595508, 60142.0, 60440.697796510736, 66824.99525014257, 81178.5646430608, 84058.57970710107, 85211.14788852033, 89886.55056724674, 12587.496500140258, 12778.61664150077, 12920.418581164058, 13018.349082546025, 13403.463861445432, 13202.471901123847, 14092.647683807987, 14190.787138193142, 14455.566333010027, 15386.538403847902, 13596.66008349799, 13745.24401157946, 13844.930775346058, 14049.578512644637, 14119.01166918347, 12887.613371598867, 13095.148815326973, 13116.540921067717, 13140.211587304791, 13193.80209296842, 12785.36073196355, 13219.47122115143, 13225.941924646198, 13316.933415332862, 13463.798043029166, 9897.802043958936, 10098.687170667767, 10330.638427654996, 10471.162307015573, 10476.738081548023, 10634.0, 10803.891961080602, 10855.782884342427, 10900.291481053706, 11020.944895275472], "value": 8017.171117565007, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 104.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 142.0, 165.0, 120.0, 149.0, 147.0, 117.0, 176.0, 121.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 169.0, 76.0, 76.0, 74.0, 75.0, 156.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 153.0, 83.0, 84.0, 84.0, 134.0, 87.0, 83.0, 149.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 122.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0, 51.0, 52.0, 55.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 63.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 71.0, 72.0, 78.0, 86.0, 71.0, 73.0, 72.0, 72.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 118.0, 118.0, 126.0, 117.0, 136.0, 132.0, 116.0, 171.0, 116.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 152.0, 156.0, 153.0, 154.0, 154.0, 152.0, 151.0, 152.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 63.0, 64.0, 63.0, 67.0, 65.0, 62.0, 61.0, 62.0], "value": 64.0, "unit": "score"}]}]} 18:19:47 INFO - Return code: 0 18:19:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:19:47 ERROR - # TBPL SUCCESS # 18:19:47 INFO - Running post-action listener: _resource_record_post_action 18:19:47 INFO - [mozharness: 2016-09-28 01:19:47.705762Z] Finished run-tests step (success) 18:19:47 INFO - Running post-run listener: _resource_record_post_run 18:19:47 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291381248; Read time: 12; Write time: 224032 18:19:47 INFO - TinderboxPrint: CPU usage
13.2% 18:19:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:19:47 INFO - TinderboxPrint: I/O write bytes / time
291,381,248 / 224,032 18:19:47 INFO - TinderboxPrint: CPU idle
8,213.1 (86.8%) 18:19:47 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 18:19:47 INFO - TinderboxPrint: Swap in / out
0 / 0 18:19:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 70082560; Read time: 0; Write time: 76124 18:19:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 221298688; Read time: 0; Write time: 147908 18:19:48 INFO - Running post-run listener: _upload_blobber_files 18:19:48 INFO - Blob upload gear active. 18:19:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:19:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:19:48 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'] 18:19:48 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 18:19:48 INFO - (blobuploader) - INFO - Open directory for files ... 18:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:49 INFO - (blobuploader) - INFO - Done attempting. 18:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:50 INFO - (blobuploader) - INFO - Done attempting. 18:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:53 INFO - (blobuploader) - INFO - Done attempting. 18:19:53 INFO - (blobuploader) - INFO - Iteration through files over. 18:19:53 INFO - Return code: 0 18:19:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:19:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:19:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34af38d1c79256008e1bc282a39f662a863f50a147b3eef9c9adf685fafbe30294e612ac6b224c86943c1c9cc5a4352469523328f667a30c303b60681102abbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/069853dcf9b2d2e57a81697e1e220c355114730f310a173155523da81438dd0e9b6729aeb82667baff348aea583cca75ded6668be06b15f7346de634d7e6c029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ff5c6721381b73dbf80b221456f916c4f571cf6e5411be5576a1283a4088d8f3657914dbe1287f9a3555d05e231d544bcea24cdca4f60d33d2ad0d108aa393b"} 18:19:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:19:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:19:53 INFO - Contents: 18:19:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34af38d1c79256008e1bc282a39f662a863f50a147b3eef9c9adf685fafbe30294e612ac6b224c86943c1c9cc5a4352469523328f667a30c303b60681102abbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/069853dcf9b2d2e57a81697e1e220c355114730f310a173155523da81438dd0e9b6729aeb82667baff348aea583cca75ded6668be06b15f7346de634d7e6c029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ff5c6721381b73dbf80b221456f916c4f571cf6e5411be5576a1283a4088d8f3657914dbe1287f9a3555d05e231d544bcea24cdca4f60d33d2ad0d108aa393b"} 18:19:53 INFO - Running post-run listener: copy_logs_to_upload_dir 18:19:53 INFO - Copying logs to upload dir... 18:19:53 INFO - mkdir: /builds/slave/test/build/upload/logs 18:19:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.363840 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-09-27 18:19:53.628484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 18:19:53.631609) ========= 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=4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397 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/34af38d1c79256008e1bc282a39f662a863f50a147b3eef9c9adf685fafbe30294e612ac6b224c86943c1c9cc5a4352469523328f667a30c303b60681102abbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/069853dcf9b2d2e57a81697e1e220c355114730f310a173155523da81438dd0e9b6729aeb82667baff348aea583cca75ded6668be06b15f7346de634d7e6c029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ff5c6721381b73dbf80b221456f916c4f571cf6e5411be5576a1283a4088d8f3657914dbe1287f9a3555d05e231d544bcea24cdca4f60d33d2ad0d108aa393b"} build_url:https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/GFB3fyXgSrGj6knX0OTjxg/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/34af38d1c79256008e1bc282a39f662a863f50a147b3eef9c9adf685fafbe30294e612ac6b224c86943c1c9cc5a4352469523328f667a30c303b60681102abbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/069853dcf9b2d2e57a81697e1e220c355114730f310a173155523da81438dd0e9b6729aeb82667baff348aea583cca75ded6668be06b15f7346de634d7e6c029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ff5c6721381b73dbf80b221456f916c4f571cf6e5411be5576a1283a4088d8f3657914dbe1287f9a3555d05e231d544bcea24cdca4f60d33d2ad0d108aa393b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 18:19:53.662200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:19:53.662546) ========= 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=4ac8d263c7293b36a1be1aed000001be-1475022738.203461-102065397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:19:53.741196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 18:19:53.741518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 18:19:53.741842) ========= ========= Total master_lag: 0.18 =========