builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0066 starttime: 1467939544.63 results: success (0) buildid: 20160707160225 builduid: b259f09cfe554dbfbceaf327b01025b6 revision: dc8af4e3e45455e09796b30d3e24cbd697fbc4c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:04.633699) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:04.634122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:04.634400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:04.891974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:04.892234) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZdmPjfd66s/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-07 17:59:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.52M=0.002s 2016-07-07 17:59:05 (7.52 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.594606 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:05.524840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:05.525129) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZdmPjfd66s/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020590 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:05.596796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 17:59:05.597179) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev dc8af4e3e45455e09796b30d3e24cbd697fbc4c7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev dc8af4e3e45455e09796b30d3e24cbd697fbc4c7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZdmPjfd66s/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-07 17:59:05,671 truncating revision to first 12 chars 2016-07-07 17:59:05,671 Setting DEBUG logging. 2016-07-07 17:59:05,671 attempt 1/10 2016-07-07 17:59:05,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/dc8af4e3e454?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 17:59:06,956 unpacking tar archive at: autoland-dc8af4e3e454/testing/mozharness/ program finished with exit code 0 elapsedTime=1.545062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 17:59:07.164181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:07.164454) ========= script_repo_revision: dc8af4e3e45455e09796b30d3e24cbd697fbc4c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:07.164807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:07.165099) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 17:59:07.183591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-07-07 17:59:07.183981) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZdmPjfd66s/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:59:07 INFO - MultiFileLogger online at 20160707 17:59:07 in /builds/slave/test 17:59:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 17:59:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:59:07 INFO - {'append_to_log': False, 17:59:07 INFO - 'base_work_dir': '/builds/slave/test', 17:59:07 INFO - 'blob_upload_branch': 'Autoland', 17:59:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:59:07 INFO - 'branch': 'Autoland', 17:59:07 INFO - 'buildbot_json_path': 'buildprops.json', 17:59:07 INFO - 'config_files': ('talos/mac_config.py',), 17:59:07 INFO - 'default_actions': ('clobber', 17:59:07 INFO - 'read-buildbot-config', 17:59:07 INFO - 'download-and-extract', 17:59:07 INFO - 'populate-webroot', 17:59:07 INFO - 'create-virtualenv', 17:59:07 INFO - 'install', 17:59:07 INFO - 'run-tests'), 17:59:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:59:07 INFO - 'download_minidump_stackwalk': True, 17:59:07 INFO - 'download_symbols': 'ondemand', 17:59:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:59:07 INFO - 'tooltool.py': '/tools/tooltool.py', 17:59:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:59:07 INFO - '/tools/misc-python/virtualenv.py')}, 17:59:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:59:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:59:07 INFO - 'installer_path': 'installer.exe', 17:59:07 INFO - 'log_level': 'info', 17:59:07 INFO - 'log_name': 'talos', 17:59:07 INFO - 'log_to_console': True, 17:59:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:59:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:59:07 INFO - 'opt_config_files': (), 17:59:07 INFO - 'pip_index': False, 17:59:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:59:07 INFO - 'cmd': ('bash', 17:59:07 INFO - '-c', 17:59:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:59:07 INFO - 'enabled': True, 17:59:07 INFO - 'halt_on_failure': False, 17:59:07 INFO - 'name': 'check_screen_resolution'},), 17:59:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:59:07 INFO - 'cmd': ('bash', 17:59:07 INFO - '-c', 17:59:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:59:07 INFO - 'enabled': True, 17:59:07 INFO - 'halt_on_failure': False, 17:59:07 INFO - 'name': 'check_screen_resolution'},), 17:59:07 INFO - 'run_cmd_checks_enabled': True, 17:59:07 INFO - 'sps_profile': False, 17:59:07 INFO - 'sps_profile_interval': 0, 17:59:07 INFO - 'suite': 'dromaeojs-e10s', 17:59:07 INFO - 'system_bits': '32', 17:59:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:59:07 INFO - 'title': 't-yosemite-r7-0066', 17:59:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:59:07 INFO - 'use_talos_json': True, 17:59:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:59:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:59:07 INFO - 'work_dir': 'build'} 17:59:07 INFO - ##### 17:59:07 INFO - ##### Running clobber step. 17:59:07 INFO - ##### 17:59:07 INFO - Running pre-action listener: _resource_record_pre_action 17:59:07 INFO - Running main action method: clobber 17:59:07 INFO - rmtree: /builds/slave/test/build 17:59:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:59:08 INFO - Running post-action listener: _resource_record_post_action 17:59:08 INFO - ##### 17:59:08 INFO - ##### Finished clobber step (success) 17:59:08 INFO - ##### 17:59:08 INFO - ##### 17:59:08 INFO - ##### Running read-buildbot-config step. 17:59:08 INFO - ##### 17:59:08 INFO - Running pre-action listener: _resource_record_pre_action 17:59:08 INFO - Running main action method: read_buildbot_config 17:59:08 INFO - Using buildbot properties: 17:59:08 INFO - { 17:59:08 INFO - "project": "", 17:59:08 INFO - "product": "firefox", 17:59:08 INFO - "script_repo_revision": "production", 17:59:08 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 17:59:08 INFO - "repository": "", 17:59:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 17:59:08 INFO - "buildid": "20160707160225", 17:59:08 INFO - "pgo_build": "False", 17:59:08 INFO - "basedir": "/builds/slave/test", 17:59:08 INFO - "buildnumber": 34, 17:59:08 INFO - "slavename": "t-yosemite-r7-0066", 17:59:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:59:08 INFO - "platform": "yosemite_r7", 17:59:08 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:59:08 INFO - "branch": "autoland", 17:59:08 INFO - "repo_path": "integration/autoland", 17:59:08 INFO - "revision": "dc8af4e3e45455e09796b30d3e24cbd697fbc4c7", 17:59:08 INFO - "stage_platform": "macosx64", 17:59:08 INFO - "builduid": "b259f09cfe554dbfbceaf327b01025b6", 17:59:08 INFO - "slavebuilddir": "test" 17:59:08 INFO - } 17:59:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 17:59:08 INFO - Running post-action listener: _resource_record_post_action 17:59:08 INFO - ##### 17:59:08 INFO - ##### Finished read-buildbot-config step (success) 17:59:08 INFO - ##### 17:59:08 INFO - ##### 17:59:08 INFO - ##### Running download-and-extract step. 17:59:08 INFO - ##### 17:59:08 INFO - Running pre-action listener: _resource_record_pre_action 17:59:08 INFO - Running main action method: download_and_extract 17:59:08 INFO - mkdir: /builds/slave/test/build/tests 17:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:08 INFO - https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:59:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:59:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:59:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 17:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 17:59:16 INFO - Downloaded 1199 bytes. 17:59:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 17:59:16 INFO - Using the following test package requirements: 17:59:16 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:59:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 17:59:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 17:59:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'jsshell-mac.zip'], 17:59:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 17:59:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:59:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 17:59:16 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 17:59:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 17:59:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:59:16 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 17:59:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:59:16 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:16 INFO - https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:59:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:59:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:59:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:59:34 INFO - Downloaded 18806423 bytes. 17:59:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:59:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:59:37 INFO - Return code: 0 17:59:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:59:37 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:37 INFO - https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:59:47 INFO - Downloaded 18806423 bytes. 17:59:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:59:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:59:51 INFO - Return code: 0 17:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:51 INFO - https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:59:52 INFO - Downloaded 14403333 bytes. 17:59:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:59:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:59:52 INFO - Return code: 0 17:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:52 INFO - https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:59:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:59:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:59:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 17:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 18:00:00 INFO - Downloaded 112431494 bytes. 18:00:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:00:00 INFO - mkdir: /builds/slave/test/properties 18:00:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:00 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:00 INFO - Contents: 18:00:00 INFO - build_url:https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:00:02 INFO - Running post-action listener: _resource_record_post_action 18:00:02 INFO - Running post-action listener: set_extra_try_arguments 18:00:02 INFO - ##### 18:00:02 INFO - ##### Finished download-and-extract step (success) 18:00:02 INFO - ##### 18:00:02 INFO - ##### 18:00:02 INFO - ##### Running populate-webroot step. 18:00:02 INFO - ##### 18:00:02 INFO - Running pre-action listener: _resource_record_pre_action 18:00:02 INFO - Running main action method: populate_webroot 18:00:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:00:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:00:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:00:02 INFO - '--tppagecycles', 18:00:02 INFO - '7'], 18:00:02 INFO - 'tests': ['tsvgm']}}, 18:00:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:00:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:00:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:00:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:00:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['damp', 'tps']}, 18:00:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'tests': ['damp', 'tps']}, 18:00:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['dromaeo_dom']}, 18:00:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['basic_compositor_video']}, 18:00:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:00:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['a11yr', 18:00:02 INFO - 'ts_paint', 18:00:02 INFO - 'tpaint', 18:00:02 INFO - 'sessionrestore', 18:00:02 INFO - 'sessionrestore_no_auto_restore', 18:00:02 INFO - 'tabpaint']}, 18:00:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:00:02 INFO - 'ts_paint', 18:00:02 INFO - 'tpaint', 18:00:02 INFO - 'sessionrestore', 18:00:02 INFO - 'sessionrestore_no_auto_restore', 18:00:02 INFO - 'tabpaint']}, 18:00:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:00:02 INFO - 'ts_paint', 18:00:02 INFO - 'tpaint', 18:00:02 INFO - 'sessionrestore', 18:00:02 INFO - 'sessionrestore_no_auto_restore', 18:00:02 INFO - 'tabpaint']}, 18:00:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:00:02 INFO - 'ts_paint', 18:00:02 INFO - 'tpaint', 18:00:02 INFO - 'sessionrestore', 18:00:02 INFO - 'sessionrestore_no_auto_restore', 18:00:02 INFO - 'tabpaint']}, 18:00:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['a11yr', 18:00:02 INFO - 'ts_paint', 18:00:02 INFO - 'tpaint', 18:00:02 INFO - 'sessionrestore', 18:00:02 INFO - 'sessionrestore_no_auto_restore', 18:00:02 INFO - 'tabpaint']}, 18:00:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['a11yr', 18:00:02 INFO - 'ts_paint', 18:00:02 INFO - 'tpaint', 18:00:02 INFO - 'sessionrestore', 18:00:02 INFO - 'sessionrestore_no_auto_restore', 18:00:02 INFO - 'tabpaint']}, 18:00:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['tsvgx', 18:00:02 INFO - 'tsvgr_opacity', 18:00:02 INFO - 'tart', 18:00:02 INFO - 'tscrollx', 18:00:02 INFO - 'cart']}, 18:00:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:00:02 INFO - 'tsvgr_opacity', 18:00:02 INFO - 'tart', 18:00:02 INFO - 'tscrollx', 18:00:02 INFO - 'cart']}, 18:00:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'talos_options': ['--disable-e10s'], 18:00:02 INFO - 'tests': ['tp5o']}, 18:00:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'tests': ['tp5o']}, 18:00:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'talos_options': ['--disable-e10s', 18:00:02 INFO - '--xperf_path', 18:00:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:02 INFO - 'tests': ['tp5n']}, 18:00:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:02 INFO - 'talos_options': ['--xperf_path', 18:00:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:02 INFO - 'tests': ['tp5n']}}, 18:00:02 INFO - 'talos.zip': {'path': '', 18:00:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:00:02 INFO - Running post-action listener: _resource_record_post_action 18:00:02 INFO - ##### 18:00:02 INFO - ##### Finished populate-webroot step (success) 18:00:02 INFO - ##### 18:00:02 INFO - ##### 18:00:02 INFO - ##### Running create-virtualenv step. 18:00:02 INFO - ##### 18:00:02 INFO - Running pre-action listener: _resource_record_pre_action 18:00:02 INFO - Running main action method: create_virtualenv 18:00:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:02 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 18:00:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:00:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:02 INFO - Using real prefix '/tools/python27' 18:00:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:02 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:05 INFO - Installing pip.................done. 18:00:05 INFO - Return code: 0 18:00:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:05 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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:05 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 18:00:05 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 18:00:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:05 INFO - 'HOME': '/Users/cltbld', 18:00:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:05 INFO - 'LOGNAME': 'cltbld', 18:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:05 INFO - 'MOZ_NO_REMOTE': '1', 18:00:05 INFO - 'NO_EM_RESTART': '1', 18:00:05 INFO - 'PAGER': '/bin/cat', 18:00:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:05 INFO - 'PWD': '/builds/slave/test', 18:00:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:05 INFO - 'SHELL': '/bin/bash', 18:00:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:05 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:05 INFO - 'USER': 'cltbld', 18:00:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:05 INFO - 'XPC_FLAGS': '0x0', 18:00:05 INFO - 'XPC_SERVICE_NAME': '0', 18:00:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:06 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 18:00:06 INFO - Cleaning up... 18:00:06 INFO - Return code: 0 18:00:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:06 INFO - 'HOME': '/Users/cltbld', 18:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:06 INFO - 'LOGNAME': 'cltbld', 18:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:06 INFO - 'MOZ_NO_REMOTE': '1', 18:00:06 INFO - 'NO_EM_RESTART': '1', 18:00:06 INFO - 'PAGER': '/bin/cat', 18:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:06 INFO - 'PWD': '/builds/slave/test', 18:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:06 INFO - 'SHELL': '/bin/bash', 18:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:06 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:06 INFO - 'USER': 'cltbld', 18:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:06 INFO - 'XPC_FLAGS': '0x0', 18:00:06 INFO - 'XPC_SERVICE_NAME': '0', 18:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:06 INFO - Downloading/unpacking psutil>=3.1.1 18:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:09 INFO - Installing collected packages: psutil 18:00:09 INFO - Running setup.py install for psutil 18:00:09 INFO - building 'psutil._psutil_osx' extension 18:00:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:00:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:00:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:00:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:00:09 INFO - building 'psutil._psutil_posix' extension 18:00:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:00:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:00:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:00:10 INFO - ^ 18:00:10 INFO - 1 warning generated. 18:00:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:10 INFO - Successfully installed psutil 18:00:10 INFO - Cleaning up... 18:00:10 INFO - Return code: 0 18:00:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:10 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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:10 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 18:00:10 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 18:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:10 INFO - 'HOME': '/Users/cltbld', 18:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:10 INFO - 'LOGNAME': 'cltbld', 18:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:10 INFO - 'MOZ_NO_REMOTE': '1', 18:00:10 INFO - 'NO_EM_RESTART': '1', 18:00:10 INFO - 'PAGER': '/bin/cat', 18:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:10 INFO - 'PWD': '/builds/slave/test', 18:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:10 INFO - 'SHELL': '/bin/bash', 18:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:10 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:10 INFO - 'USER': 'cltbld', 18:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:10 INFO - 'XPC_FLAGS': '0x0', 18:00:10 INFO - 'XPC_SERVICE_NAME': '0', 18:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:00:11 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 18:00:11 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:11 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 18:00:11 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 18:00:11 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 18:00:11 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:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:13 INFO - Installing collected packages: mozsystemmonitor 18:00:13 INFO - Running setup.py install for mozsystemmonitor 18:00:13 INFO - Successfully installed mozsystemmonitor 18:00:13 INFO - Cleaning up... 18:00:13 INFO - Return code: 0 18:00:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:13 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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:13 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 18:00:13 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 18:00:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:13 INFO - 'HOME': '/Users/cltbld', 18:00:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:13 INFO - 'LOGNAME': 'cltbld', 18:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:13 INFO - 'MOZ_NO_REMOTE': '1', 18:00:13 INFO - 'NO_EM_RESTART': '1', 18:00:13 INFO - 'PAGER': '/bin/cat', 18:00:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:13 INFO - 'PWD': '/builds/slave/test', 18:00:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:13 INFO - 'SHELL': '/bin/bash', 18:00:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:13 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:13 INFO - 'USER': 'cltbld', 18:00:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:13 INFO - 'XPC_FLAGS': '0x0', 18:00:13 INFO - 'XPC_SERVICE_NAME': '0', 18:00:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:16 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 18:00:16 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:16 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 18:00:16 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 18:00:16 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 18:00:16 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:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:16 INFO - warning: no files found matching '*.txt' 18:00:16 INFO - no previously-included directories found matching 'build' 18:00:16 INFO - no previously-included directories found matching 'dist' 18:00:16 INFO - no previously-included directories found matching '.git*' 18:00:16 INFO - Installing collected packages: jsonschema, functools32 18:00:16 INFO - Running setup.py install for functools32 18:00:17 INFO - warning: no files found matching '*.txt' 18:00:17 INFO - no previously-included directories found matching 'build' 18:00:17 INFO - no previously-included directories found matching 'dist' 18:00:17 INFO - no previously-included directories found matching '.git*' 18:00:17 INFO - Successfully installed jsonschema functools32 18:00:17 INFO - Cleaning up... 18:00:17 INFO - Return code: 0 18:00:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:00:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:17 INFO - 'HOME': '/Users/cltbld', 18:00:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:17 INFO - 'LOGNAME': 'cltbld', 18:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:17 INFO - 'MOZ_NO_REMOTE': '1', 18:00:17 INFO - 'NO_EM_RESTART': '1', 18:00:17 INFO - 'PAGER': '/bin/cat', 18:00:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:17 INFO - 'PWD': '/builds/slave/test', 18:00:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:17 INFO - 'SHELL': '/bin/bash', 18:00:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:17 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:17 INFO - 'USER': 'cltbld', 18:00:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:17 INFO - 'XPC_FLAGS': '0x0', 18:00:17 INFO - 'XPC_SERVICE_NAME': '0', 18:00:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:17 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:17 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 18:00:17 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:17 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 18:00:17 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 18:00:17 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 18:00:17 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:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:21 INFO - Downloading docopt-0.6.1.tar.gz 18:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:21 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:21 INFO - Running setup.py install for blobuploader 18:00:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:21 INFO - Running setup.py install for requests 18:00:21 INFO - Running setup.py install for docopt 18:00:22 INFO - Successfully installed blobuploader requests docopt 18:00:22 INFO - Cleaning up... 18:00:22 INFO - Return code: 0 18:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:22 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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:22 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 18:00:22 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 18:00:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:22 INFO - 'HOME': '/Users/cltbld', 18:00:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:22 INFO - 'LOGNAME': 'cltbld', 18:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:22 INFO - 'MOZ_NO_REMOTE': '1', 18:00:22 INFO - 'NO_EM_RESTART': '1', 18:00:22 INFO - 'PAGER': '/bin/cat', 18:00:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:22 INFO - 'PWD': '/builds/slave/test', 18:00:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:22 INFO - 'SHELL': '/bin/bash', 18:00:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:22 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:22 INFO - 'USER': 'cltbld', 18:00:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:22 INFO - 'XPC_FLAGS': '0x0', 18:00:22 INFO - 'XPC_SERVICE_NAME': '0', 18:00:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Fh2H10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-JpiYJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-OOvOLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-0YHaBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Gylxn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Hrozyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-0newq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-FLOpTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-O1JBFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-DSEeAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-2CEbnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PycB_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-GKrmce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-WtwEqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-_KzBcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-2hfdQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:24 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-7BIdv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:24 INFO - Running setup.py install for manifestparser 18:00:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:24 INFO - Running setup.py install for mozcrash 18:00:24 INFO - Running setup.py install for mozdebug 18:00:24 INFO - Running setup.py install for mozdevice 18:00:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:00:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:24 INFO - Running setup.py install for mozfile 18:00:24 INFO - Running setup.py install for mozhttpd 18:00:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozinfo 18:00:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozInstall 18:00:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozleak 18:00:25 INFO - Running setup.py install for mozlog 18:00:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for moznetwork 18:00:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozprocess 18:00:25 INFO - Running setup.py install for mozprofile 18:00:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Running setup.py install for mozrunner 18:00:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Running setup.py install for mozscreenshot 18:00:26 INFO - Running setup.py install for moztest 18:00:26 INFO - Running setup.py install for mozversion 18:00:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:26 INFO - Cleaning up... 18:00:26 INFO - Return code: 0 18:00:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:26 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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:26 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 18:00:26 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 18:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:26 INFO - 'HOME': '/Users/cltbld', 18:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:26 INFO - 'LOGNAME': 'cltbld', 18:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:26 INFO - 'MOZ_NO_REMOTE': '1', 18:00:26 INFO - 'NO_EM_RESTART': '1', 18:00:26 INFO - 'PAGER': '/bin/cat', 18:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:26 INFO - 'PWD': '/builds/slave/test', 18:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:26 INFO - 'SHELL': '/bin/bash', 18:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:26 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:26 INFO - 'USER': 'cltbld', 18:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:26 INFO - 'XPC_FLAGS': '0x0', 18:00:26 INFO - 'XPC_SERVICE_NAME': '0', 18:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-GeyMb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ZvmXIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-s1QmgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ipVKZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jc82Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-scuBGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-kuToTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-qVjEtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-r7YEA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-MkHZLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 18:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-6nEcWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:28 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)) 18:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-b5st0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:28 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)) 18:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-DiPxhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:28 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)) 18:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-JvpBL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:28 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)) 18:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-g1c3Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:28 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)) 18:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-dzSgp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:28 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)) 18:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-K10m7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:28 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)) 18:00:28 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)) 18:00:28 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)) 18:00:28 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)) 18:00:28 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)) 18:00:28 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)) 18:00:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00:28 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 18:00:28 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:28 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 18:00:28 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 18:00:28 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 18:00:28 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:31 INFO - Downloading blessings-1.6.tar.gz 18:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:31 INFO - Installing collected packages: blessings 18:00:31 INFO - Running setup.py install for blessings 18:00:31 INFO - Successfully installed blessings 18:00:31 INFO - Cleaning up... 18:00:31 INFO - Return code: 0 18:00:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:31 INFO - Reading from file tmpfile_stdout 18:00:31 INFO - Current package versions: 18:00:31 INFO - blessings == 1.6 18:00:31 INFO - blobuploader == 1.2.4 18:00:31 INFO - docopt == 0.6.1 18:00:31 INFO - functools32 == 3.2.3-2 18:00:31 INFO - jsonschema == 2.5.1 18:00:31 INFO - manifestparser == 1.1 18:00:31 INFO - mozInstall == 1.12 18:00:31 INFO - mozcrash == 0.17 18:00:31 INFO - mozdebug == 0.1 18:00:31 INFO - mozdevice == 0.48 18:00:31 INFO - mozfile == 1.2 18:00:31 INFO - mozhttpd == 0.7 18:00:31 INFO - mozinfo == 0.9 18:00:31 INFO - mozleak == 0.1 18:00:31 INFO - mozlog == 3.2 18:00:31 INFO - moznetwork == 0.27 18:00:31 INFO - mozprocess == 0.23 18:00:31 INFO - mozprofile == 0.28 18:00:31 INFO - mozrunner == 6.12 18:00:31 INFO - mozscreenshot == 0.1 18:00:31 INFO - mozsystemmonitor == 0.3 18:00:31 INFO - moztest == 0.7 18:00:31 INFO - mozversion == 1.4 18:00:31 INFO - psutil == 3.1.1 18:00:31 INFO - requests == 1.2.3 18:00:31 INFO - wsgiref == 0.1.2 18:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:31 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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:31 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:31 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:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:31 INFO - 'HOME': '/Users/cltbld', 18:00:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:31 INFO - 'LOGNAME': 'cltbld', 18:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:31 INFO - 'MOZ_NO_REMOTE': '1', 18:00:31 INFO - 'NO_EM_RESTART': '1', 18:00:31 INFO - 'PAGER': '/bin/cat', 18:00:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:31 INFO - 'PWD': '/builds/slave/test', 18:00:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:31 INFO - 'SHELL': '/bin/bash', 18:00:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:31 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:31 INFO - 'USER': 'cltbld', 18:00:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:31 INFO - 'XPC_FLAGS': '0x0', 18:00:31 INFO - 'XPC_SERVICE_NAME': '0', 18:00:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Cleaning up... 18:00:32 INFO - Return code: 0 18:00:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00: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')]} 18:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:32 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 0x1034c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103557618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef158cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:32 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:32 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:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:00:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:32 INFO - 'HOME': '/Users/cltbld', 18:00:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:32 INFO - 'LOGNAME': 'cltbld', 18:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:32 INFO - 'MOZ_NO_REMOTE': '1', 18:00:32 INFO - 'NO_EM_RESTART': '1', 18:00:32 INFO - 'PAGER': '/bin/cat', 18:00:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:32 INFO - 'PWD': '/builds/slave/test', 18:00:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:32 INFO - 'SHELL': '/bin/bash', 18:00:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:00:32 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:00:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:32 INFO - 'USER': 'cltbld', 18:00:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:32 INFO - 'XPC_FLAGS': '0x0', 18:00:32 INFO - 'XPC_SERVICE_NAME': '0', 18:00:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:00:32 INFO - Cleaning up... 18:00:32 INFO - Return code: 0 18:00:32 INFO - Running post-action listener: _resource_record_post_action 18:00:32 INFO - Running post-action listener: _start_resource_monitoring 18:00:32 INFO - Starting resource monitoring. 18:00:32 INFO - ##### 18:00:32 INFO - ##### Finished create-virtualenv step (success) 18:00:32 INFO - ##### 18:00:32 INFO - ##### 18:00:32 INFO - ##### Running install step. 18:00:32 INFO - ##### 18:00:32 INFO - Running pre-action listener: _resource_record_pre_action 18:00:32 INFO - Running main action method: install 18:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:32 INFO - Reading from file tmpfile_stdout 18:00:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:32 INFO - Reading from file tmpfile_stdout 18:00:32 INFO - Output received: 18:00:32 INFO - Usage: mozinstall [options] installer 18:00:32 INFO - Options: 18:00:32 INFO - -h, --help show this help message and exit 18:00:32 INFO - -d DEST, --destination=DEST 18:00:32 INFO - Directory to install application into. [default: 18:00:32 INFO - "/builds/slave/test"] 18:00:32 INFO - --app=APP Application being installed. [default: firefox] 18:00:32 INFO - mkdir: /builds/slave/test/build/application 18:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:01:07 INFO - Reading from file tmpfile_stdout 18:01:07 INFO - Output received: 18:01:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:01:07 INFO - Running post-action listener: _resource_record_post_action 18:01:07 INFO - ##### 18:01:07 INFO - ##### Finished install step (success) 18:01:07 INFO - ##### 18:01:07 INFO - ##### 18:01:07 INFO - ##### Running run-tests step. 18:01:07 INFO - ##### 18:01:07 INFO - Running pre-action listener: _resource_record_pre_action 18:01:07 INFO - Running main action method: run_tests 18:01:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:01:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:01:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:01:07 INFO - 2016-07-07 18:01:07.618 screenresolution[2026:16288] starting screenresolution argv=screenresolution get 18:01:07 INFO - 2016-07-07 18:01:07.620 screenresolution[2026:16288] Display 0: 1600x1200x32@60 18:01:07 INFO - 2016-07-07 18:01:07.627 screenresolution[2027:16290] starting screenresolution argv=screenresolution list 18:01:07 INFO - Available Modes on Display 0 18:01:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:01:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:01:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:01:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:01:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:01:07 INFO - Intel Iris: 18:01:07 INFO - Chipset Model: Intel Iris 18:01:07 INFO - Type: GPU 18:01:07 INFO - Bus: Built-In 18:01:07 INFO - VRAM (Dynamic, Max): 1536 MB 18:01:07 INFO - Vendor: Intel (0x8086) 18:01:07 INFO - Device ID: 0x0a2e 18:01:07 INFO - Revision ID: 0x0009 18:01:07 INFO - Displays: 18:01:07 INFO - Display: 18:01:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:01:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:01:07 INFO - Display Serial Number: 1600x1200 60 18:01:07 INFO - Main Display: Yes 18:01:07 INFO - Mirror: Off 18:01:07 INFO - Online: Yes 18:01:07 INFO - Rotation: Supported 18:01:07 INFO - Return code: 0 18:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:07 INFO - Python 2.7.3 18:01:07 INFO - Return code: 0 18:01:07 INFO - grabbing minidump binary from tooltool 18:01: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')]} 18:01:07 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/macosx64/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 0x103426d30>, '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 0x10318bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10341eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:07 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:01:07 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:01:07 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:01:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:07 INFO - Return code: 0 18:01:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:01:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:01:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZdmPjfd66s/Render', 18:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:07 INFO - 'HOME': '/Users/cltbld', 18:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:07 INFO - 'LOGNAME': 'cltbld', 18:01:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:07 INFO - 'MOZ_NO_REMOTE': '1', 18:01:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:07 INFO - 'NO_EM_RESTART': '1', 18:01:07 INFO - 'PAGER': '/bin/cat', 18:01:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:07 INFO - 'PWD': '/builds/slave/test', 18:01:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:07 INFO - 'SHELL': '/bin/bash', 18:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners', 18:01:07 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 18:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:07 INFO - 'USER': 'cltbld', 18:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:07 INFO - 'XPC_FLAGS': '0x0', 18:01:07 INFO - 'XPC_SERVICE_NAME': '0', 18:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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:01:08 INFO - mozversion application_buildid: 20160707160225 18:01:08 INFO - mozversion application_changeset: dc8af4e3e45455e09796b30d3e24cbd697fbc4c7 18:01:08 INFO - mozversion application_display_name: Nightly 18:01:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:08 INFO - mozversion application_name: Firefox 18:01:08 INFO - mozversion application_remotingname: firefox 18:01:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:01:08 INFO - mozversion application_vendor: Mozilla 18:01:08 INFO - mozversion application_version: 50.0a1 18:01:08 INFO - mozversion platform_buildid: 20160707160225 18:01:08 INFO - mozversion platform_changeset: dc8af4e3e45455e09796b30d3e24cbd697fbc4c7 18:01:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:01:08 INFO - mozversion platform_version: 50.0a1 18:01:08 INFO - using testdate: 1467939668 18:01:08 INFO - actual date: 1467939668 18:01:08 INFO - starting webserver on 'localhost:51336' 18:01:08 INFO - SUITE-START | Running 2 tests 18:01:08 INFO - TEST-START | dromaeo_css 18:01:08 INFO - operating with platform_type : mac_ 18:01:08 INFO - Initialising browser for dromaeo_css test... 18:01:08 INFO - TEST-INFO | started process 2037 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpXREwv7/profile http://localhost:51336/getInfo.html) 18:01:11 INFO - PROCESS | 2037 | __metrics Screen width/height:1600/1200 18:01:11 INFO - PROCESS | 2037 | colorDepth:24 18:01:11 INFO - PROCESS | 2037 | Browser inner width/height: 1024/689 18:01:11 INFO - PROCESS | 2037 | __metrics 18:01:11 ERROR - PROCESS | 2037 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:01:11 INFO - TEST-INFO | 2037: exit 0 18:01:11 INFO - Browser initialized. 18:01:11 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:11 INFO - TEST-INFO | started process 2040 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpXREwv7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:23 INFO - PROCESS | 2040 | RSS: Main: 254152704 18:01:23 INFO - PROCESS | 2040 | 18:02:13 INFO - PROCESS | 2040 | 1467939733587 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:04:25 INFO - PROCESS | 2040 | Cycle 1(1): loaded http://localhost:51336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51336/tests/dromaeo/cssquery-ext.html) 18:04:26 INFO - PROCESS | 2040 | RSS: Main: 266575872 18:04:26 INFO - PROCESS | 2040 | 18:07:28 INFO - PROCESS | 2040 | Cycle 1(1): loaded http://localhost:51336/tests/dromaeo/cssquery-ext.html (next: http://localhost:51336/tests/dromaeo/cssquery-jquery.html) 18:07:29 INFO - PROCESS | 2040 | RSS: Main: 275230720 18:07:29 INFO - PROCESS | 2040 | 18:10:31 INFO - PROCESS | 2040 | Cycle 1(1): loaded http://localhost:51336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51336/tests/dromaeo/cssquery-mootools.html) 18:10:32 INFO - PROCESS | 2040 | RSS: Main: 279891968 18:10:32 INFO - PROCESS | 2040 | 18:13:33 INFO - PROCESS | 2040 | Cycle 1(1): loaded http://localhost:51336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51336/tests/dromaeo/cssquery-prototype.html) 18:13:34 INFO - PROCESS | 2040 | RSS: Main: 279367680 18:13:34 INFO - PROCESS | 2040 | 18:16:37 INFO - PROCESS | 2040 | Cycle 1(1): loaded http://localhost:51336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51336/tests/dromaeo/cssquery-yui.html) 18:16:37 INFO - PROCESS | 2040 | RSS: Main: 282505216 18:16:37 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | Cycle 1(1): loaded http://localhost:51336/tests/dromaeo/cssquery-yui.html (next: http://localhost:51336/tests/dromaeo/cssquery-dojo.html) 18:19:40 INFO - PROCESS | 2040 | RSS: Main: 282578944 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | __start_tp_report 18:19:40 INFO - PROCESS | 2040 | _x_x_mozilla_page_load 18:19:40 INFO - PROCESS | 2040 | _x_x_mozilla_page_load_details 18:19:40 INFO - PROCESS | 2040 | |i|pagename|runs| 18:19:40 INFO - PROCESS | 2040 | |0;dojo.html;3431.210821511054;3438.6045604755454;3463.4804779283104;3465.5494785677856;3477.947830782539;4598.563136502027;5855.063189889618;5907.793227237037;5936.970315148429;5944.970275148624;4741.573258406743;4755.833545825897;5684.829455116343;5923.466887980081;5956.374580669032;5309.469053094688;5334.306540149775;5364.1149210380245;5432.103702889039;5482.424345443731;5400.135978243482;5410.08028635133;5485.753141108639;5507.311586051744;5552.555795536367;5262;5334.626576139672;5366.409694933554;5374.811881584164;5379.327584051994;5351.117065684158;5367.731613419313;5370.167624018283;5371.462853714636;5382.542483888874;5226.372835259755;5346;5363.302770639831;5367.516923476866;5416.83749487516;5689.089745640719;5741.8277451676095;5860.736266868002;5883.646981181143;5906.291245050621;6236.719347629368;6276.4308922769305;6322.083297921776;6325.335839736807;6328.968355158195;6252.468540174091;6263.34234905333;6285.685715714196;6298.811035668938;6301.52738544611;5334.5732341412595;5884.382139875252;5885.941140588625;5897.6166549174595;5940.584159108864;6351.587146835441;6353.174087368612;6361.777337793155;6389.9361006389345;6403.231612206565;6135.263289243823;6142.928535732134;6160.476359509402;6240.687965601702;6279.277883043417;6242.438180563771;6282.340354262828;6289.40250676185;6294.150289710922;6308.905366419507;5289.942011597619;6208.037754148114;6244.188255526843;6304.873902521924;6358.109864618957;6125.479643195349;6234.407731265523;6297.4647154992335;6303.810885673345;6343.746250149942;5013.974930125326;5027.999999999927;5031.943291908667;5035.093683137071;5038.949610503848;4455.331700244924;4517.186906356822;4529;4530.252508336088;4582.358469814229;5610.298712660918;5904.380040095728;5930.584859059911;5964.135200395918;6039.607425517327;6216.017854200637;6244.562880598314;6272.3100458949475;6302.243730752339;6319.715612797435;5953.880922381528;5986.6707331097205;5993.782011678696;5999.430054144849;6049.18336024631;5404;5524.309461317335;5538.75075621598;5574.470425309589;5576.665400075927;6480.773172938924;6490.4807615390655;6491.188601424822;6512.47900167976;6518.022296655539;5055.747212639427;6265.216847894013;6289.056641503811;6292.779752708633;6318.462930650762;5662.943370566406;6388.872222555616;6446.645434501147;6480.546361754632;6494.220693516808;6157.9384206157365;6231.189945307262;6276.968615156895;6299.244090709144;6304.148939893055;6128.014278093809;6165;6288.905666415099;6295.244570651551;6307.463865571478;4812.302216178705;6141.140240366263;6144.893919094606;6167.629942203482;6193.783217587363;6171.444569988723;6223.751049958132;6228.34602366745;6266.937330626635;6291.811245662638;5939.812037592413;5999.5800293979;6031.728572214349;6067.453929146398;6109;6109.829807539466;6175.197224360804;6181.84545386351;6208.1308616792785;6292.874142517216;6075;6126.724297406717;6134.938650613437;6145.539084568586;6148.631082135086 18:19:40 INFO - PROCESS | 2040 | |1;ext.html;459.4991459309352;473.4886322771405;477.9675900055879;506.5947242206234;514.6320380927638;37972.620273797256;38722.80638596806;40218.59781402189;40223.19553608926;40306.59693403065;39909.600903990955;40647.983800405;40695;40717.185656286856;40733;9281.443113413183;9451.810963780721;9491.477968711719;9507.23942084635;9514.191293740041;9663.371880827759;9787.36382135159;9802.558884850163;9805.460699661517;9817.165540928994;9695.951520242388;9768.169705575036;9832.803343933118;9839.45882976436;9850.950745246264;9619.230461563058;9733;9759.024097590254;9770.36492627977;9803.41179529227;9605.607186957852;9694.563744631438;9740.512974351324;9783.657571985017;9788.070133337322;39356.40965385522;39482.407763883566;39716.60283397187;39792.801035994635;40025.59974400248;2730.317420644839;3322.1362445764034;3523.2777280657406;3793.5827059023486;4259.10558782656;30115.397692046037;30542;30568.388632227452;30804.691953080408;31137;3124.875004999797;3132.8120312781307;3147.291859331655;3166.335069635379;3254.983725081383;469241;470528.6473567645;475202;475630;476120.61939690425;32257.35485290328;32728.181795455304;32765.180870478427;32827.17932051718;33460.83269583636;28600;33404.99785006454;34271.31457370838;34507.827460862536;34574.481382779275;14451.78322325166;14557.490487832874;14704.852951470348;14713.632159196106;14725.55823325302;12341.568045118378;12441.440135193938;12460.81308780369;12543.874561254454;12558;6420.7752728655205;6422.678866056678;7588.430867684946;7672.424568157299;7684.116326622398;2764.156932135678;2781.3741908070524;3197.1048106529743;3263.575735154415;3264.579907740093;889.9866502002475;961.7595601099725;991.5686676295834;1073.983890241647;1138.8007098757685;25340.873295633774;27256.59115113275;30069.39861202764;30345.24136896595;30410;1010.9039641234071;1085.1861104171871;1093.5243169221415;1094.6497120921388;1152.3604399558326;14884.404623814926;15000.69998600022;15020.248987550578;15233.847661523243;15406.768898466533;714276;1008559;1024206;1031872;1033948;56512.717436413375;56738;57199;57233;57293.427065729644;1401.7897315402772;1435.253668092586;1442.8845692344796;1448.1455940994863;1453.5203382883624;29715.405691886474;29730.108096757132;29828.955986540368;30335.848320758254;30396.240093997825;41790.58209417989;56547;57345;57580.71209643925;58908;661674;663714.7699830483;672156;674070;674379;43764.781176093915;43951.560484396025;44226.778866105466;44344.778276108416;44378.77810610926;47989.280160796916;48142.75928620334;48341.75829120973;49074.773130672016;49298;29818;38523.614763853126;39475;40466.79766601148;41188.794056029525;39349.01627459222;40225.39661905015;40459;40521.98695032648;40944.385834213106;38261.234775304896;38797;38846.80576597099;39009.6099039006;40167.799161004004;32386.83806580952;34728;34863.825680871436;35250.294994100484;35433.64566354406;21234.893825530773;24971.50056998886;26242.868785655948;26362;26439.867800661643 18:19:40 INFO - PROCESS | 2040 | |2;jquery.html;304.28644827878617;382.5944498831239;386.85492940147435;396.5558574396676;403.48757078510295;20130.6980395294;20688.793112068874;20716.68924966125;21177.152913883463;21370;20251.08870100845;20520.589588208226;20976.05607747651;21418.785812141872;21801;5631.239782629334;6077.331493535729;6078.39216078393;6273.5922165059355;6277.435030847223;6117.66352850593;6123.908141377883;6169.722362493676;6207.131001659771;6226.221722284715;5731.971340143315;6079.908801367983;6083.117947897552;6133.877322453548;6136.9079463808075;6079.784043191357;6406.391392817675;6776.2546119926765;6795.898061529081;6797.150356205474;5938.584299099065;5983.222181116427;5991.460768530809;6064.302605200414;6085.087236914498;10629.574817007311;13223.735525289536;13225.933870330588;26163.476730465474;27059.917603295846;2124.4476436126565;2132.2323963373174;2475.4306509502735;2608.543504886637;2910.941781164386;8678.392512524126;10082.294239403245;14495.202763847985;14992.250387480583;15109.244537773176;1760.709482935314;1803.8196180381988;1833.7982821889582;1862.6181632765251;1874.0348720409;108948.455257724;119526;120141.39929300298;121058.3947080259;121546;9405.388649737744;10551.103156231806;10729.731756706145;10939;10966.945165274123;13066.934665326613;13128.081034327697;13189.538366157138;13192.868071319355;13230.073894827463;7384.778456646309;7741.8838717419285;7808.297253247121;7843.568603726736;7858.803529911684;6869.725210991504;7017.017617533447;7712.537247765152;7819.726309579138;7886.763397098096;3597.568291805;3637.2907283080076;3846.74996125251;3913.804309784556;4248.915021699549;1909.875858069221;1949.951251218731;1983.1457587155767;1999.1403696410391;2004.9899750501445;808.8058865872148;848.6944699908029;887.7159309021051;940.5955439161089;1055.757175849559;17695.46913592594;21456.356309310744;22153;22332.995015224355;22473.213437529936;959.4099628728281;965.8840939087354;974.5858010345574;1010.6311196413403;1039.194624166262;10957.780844383067;11148.2753621016;11690.76618467643;11730.589429369931;11735.765284694258;542772;544585;546731;555030;591098;116003;117405;117570.41214793871;119327;123034;1015.2690063154517;1022.8772547294373;1063.0963680871198;1083.0685610375072;1086.364476781076;13908.582742517741;15503.069815811088;18844.434666960013;19198.71201932;19859.205631774566;55880;56070.71964640151;56675.14987275111;57502.7124864373;59594.10608840784;67332;75338;82286.58856705678;83060;83306.58346708228;8122.147174546824;8183.468074575134;8212.219839115274;8245.13426090252;8255.463394879314;12325.890669839398;12400.689982750504;12746.936265318614;13057.21656700563;13234.404451799885;10130.493475326351;11228.943855280671;11265.493052812479;11560.075193984292;11569.537218511501;8783.91216087831;9126.269898407978;11139.108871290115;11197;11262.38056906878;9402;11224.326540407601;11424.771504570028;11563.6530904073;11598;7989.880151797844;8165.469244499089;8183.427160098736;8201.671933122847;8289.41974061834;9658.517074146404;11184.440777960906;11437;11489.827652585385;11535.134864885335 18:19:40 INFO - PROCESS | 2040 | |3;mootools.html;1511.6749898771766;1566.9736322708627;1794.4347530527882;1897.430770768769;1904.4477101640525;7984.481008734443;8444;8526.36052296078;8970.775730606738;8980.326475514337;7294.416446684266;8645.481271123721;8773.736787896358;8778.034416214212;8786.824263514725;1981.5145289404115;2336.778006089419;2356.1988923765916;2365.2549446924163;2371.8102551795814;2334.7431782503995;2339.4736184358553;2358.6697862299293;2376.66726658268;2389.940251493709;2343.94140146496;2349.0955981946986;2350.7766762157567;2391.7727815857465;2394.8443351182204;2314.884255787212;2315.583195024895;2326.499802542453;2345.3081341004445;2348.9177878774244;2320.9439704934216;2324.140068174769;2327.2552783109413;2329;2334.0663734506165;8837;8845.027047024822;8915.019347871794;8929.955350223207;8940.8658870117;5202.479752024805;5317.760700768475;5350.036993341197;5353;5353.437889021636;3482.9303413931834;3563.572371315459;3642.05306620278;3675.1363429594026;3683.37382644951;1055.8996895294936;1083.7453198498347;1101.4767985206963;1111.555377848867;1116.3190453823242;9836.95081524595;10721.249512534127;10736.516856741544;11388.259763115453;11400.885991140065;4435.489918659331;4549.840755573539;4556.134334476439;4763.976180119077;4779.091972525209;8440.366972477088;9803.705888823346;9889.109980101824;9895.554700038516;9899.703008909744;5090.541851233407;5125.15434953236;5144.511271429208;5150.871228219325;5155.510226528474;4004.379321205218;4458.866234012985;4636.698614590041;4699.107169637758;4848.10310092634;3368.444206705915;3563.4476656118345;3883.3980732986433;3931.567527571965;3994.1612261425425;1129.4239937631867;1135.840982262484;1300.8048792681172;1305.4973835073565;1318.4198952460886;931.9487428191379;933.9673111441067;939.9765005874908;952.6618050592078;1015.5227043289642;5850.531957443394;5853.502452291603;6030.758769649165;6082.0876868469195;6114.2357205349335;441.05393930019926;444.2048732768373;456.0081822037056;458.7820785127038;459.370662192798;3612.0608641753333;3856.3444214483607;3917.3928041153667;4087.734297270668;4146.0464093258115;10261.179105671677;10623.575056997634;10721.35671859691;10746.892531074589;10769.407682577377;9793.922668506459;10289.125424338865;10705.250632455809;10725.03474687282;10737.731556711145;7574.469787114959;8217.055038670509;8255.669773209005;8331.708390206313;8331.708390206435;5778.219940308005;5806.042003069446;5857.941420585739;5863.618864773946;5937.19847820556;9953.601855925972;9965.35225210388;9988.550515226978;10021.298509104292;10096.69709908704;9949.801003979735;10068.69793906184;10220.131288840234;10227.386356818317;10241.027102425258;6921;7343.522671026366;7486.850262994601;7565.810854728676;7587.62061896914;7164.534305270141;8479.406441549032;8537.445066070686;8544.700935467228;8548.444351117158;7411.370033547209;7546.962265188639;7575.886361704469;7613.428992825449;7652.349550288065;7381.224971377928;7429.219931907072;7555.6977720890545;7563.584002879895;7567.01628788254;7014.333638304353;7022.367986881205;7049.577025378494;7082.610456424946;7085.929140708527;4880.902381952412;5035.219540971156;5062.468440813809;5106.719130447861;5112.948870511247;4962.751862406793;4993.126202914403;5020;5051.267566202953;5125.1799712045895 18:19:40 INFO - PROCESS | 2040 | |4;prototype.html;305.9434004709128;306.14127372719514;312.3409605731905;312.6154829559642;315.6244069557228;5847.596576821564;5861.238039054922;5886.146508756233;5897.882042359151;5924.200232968548;5714.485696287334;5726.3128424589;5733.595269159052;5807.651540907548;5866.442687944649;4196.978175713497;4252.936205956913;4285.8071386787515;4404.647628189737;4410.76498580398;3721.5720192177973;4036.7889633110094;4174.582541745832;4328.567143285678;4396.648268138557;3791.905202369935;4106.850081977052;4349.521552629209;4391.604755571998;4418.160549495602;3800.638939300762;4119.979400102995;4378.408914796525;4391.780410979454;4395.033092719628;3759.030366010848;3765.811709414546;3804.8478060877533;3809.904752381185;3810.3712887373827;5181.326427564392;5654.915176272318;5686.687232202227;5696.914546281809;5704.34400043992;4775.594074503637;4912.877178070541;5022.573081288095;5044.83968687204;5081.136206844845;4775.304766807768;4992.355580426309;6070;6084.939150608481;6102.96948515259;4158.877103182124;4166.041960278664;4173.290540608104;4199.4120823084795;4212.810423530917;5022.773975171126;5300.337457817773;5840.269966254218;6364.649944253064;6392.328805475405;3395.830208489566;3519.6128425873135;3971.72197946141;3996.800159991989;4240.957590424056;3774.3960966245268;4210.242156411875;4317.050248945227;4333.111712099012;4335.501417336984;4272.594103560157;4866.367372241657;5002.399712034579;5033.924491132636;5047.848564543069;5397.839464515148;5675.3757086720425;6093.482054025458;6151.585135418789;6171.346321081888;1295.2552282437637;1403.4245959156697;1453.5276035288573;1466.0397439677029;1489.8063251777417;913.7207908927554;917.179124683418;918.7427520294328;952.6284748947916;997.3666721631671;5222.686638801684;5365.973170134124;5642.830715078554;5668.7165641718575;5703.74333155009;4641.025384669189;5199.844004679866;6270.2789179244055;6277.623342599459;6324.272708638474;4921.9507804922205;5303.003802851376;5606.6920516895225;5657.434256574392;5683.374828768832;3295.7857739246874;3296.2583418731074;3302.9504557431655;3325.1687078230443;3338.5326054351926;5576.414476479911;5701.574606348413;6132.938670613236;6339.144215530844;6579.605223686594;5667.40492248308;5916.9941110011405;6273.843153921189;6359.554831161867;6464.416218026614;5529.474699903502;6000.939990600213;6188.597741146811;6555.8361040973405;6560.311167327457;5151.484851514819;5879.529637629065;6050.697465126638;6190.690465476799;6259.467945224706;5378.682222855426;5893.381194974466;6088.360722124113;6132.754689812357;6142.6314421134875;5323.281357016908;6220.582369365848;6279.591826531444;6401.8719625608155;6484.967575162283;4032.1532478178738;4239.236937351307;4246.702730808814;4246.978765106154;4253.48958125027;6048.101038159105;6293.622382657055;6299.748010079546;6304.243490781136;6314.55798094129;5030.145909197642;5272.657277276965;6180.289266734203;6213.844653883689;6256.217972753406;6189.84525386869;6192.690365481618;6202.953025501663;6232.937670623236;6272.341404152681;5791.739371728198;5966.343702192668;6006.789762358297;6082.2093127893095;6107.404353149982;5357.598180136428;6204.534659900435;6212.254529456494;6249.25008998923;6250.968745156245;4875.0493653737185;5313.521783039545;6012.436766440669;6124.5712800103565;6131.785387511416 18:19:40 INFO - PROCESS | 2040 | |5;yui.html;664.2759392262434;678.7239988821016;736.5212611802331;786.3434032582793;843.0726201178702;15086.547403577883;15289.464868729598;15858.603534911634;15872.444464443746;15893.523194304174;14296.35666395012;14408.703216710494;14415.621422465281;14417.639559011004;14461.34923928423;714.4605822603927;884.5709830732106;887.3477993674644;904.9276057915384;909.5679552212679;892.451142547332;898.2589363774879;901.3195037746492;901.6168128545374;903.9096090390941;920.3281604428771;920.8756817829608;940.3652534539193;958.1424624960656;959.2278216036088;792.2948575767572;838.7106448275335;840.4663038970267;921.4749589429472;946.1626460582365;584.220066211608;696.9059177011089;698.322627051759;700.9369156775864;703.9897746733454;12428.813567796491;12610.621681349574;13191.208527488381;15391.461298854598;15529.611759705986;12743.235405875677;14078.944079194102;14139.434422623082;14948.850511494855;15093.094414335064;11569.479373428216;12115.757684846341;12117.212381195282;12123.33321667308;12229.571964981184;3921.9803900980596;3924.529056513208;3940.763554186758;4081.4081958116203;4092.3043082675717;117578.41210793977;122297;123501;126648.10027849498;126897.73102269044;9439.575219115157;9447.622095116256;11577.594784182513;11580.47887845049;12078.094142939315;23456.413589660395;24522.50954980926;24602.630960535607;24624.50750985006;24636.260912172664;6855.280195579492;8266.173382661686;8277.089520152778;8346.207110324509;8346.749597512084;4514.864554063383;4559.566841150086;4563.338315944169;4580.473245576802;4752.1683705351425;3683.9631603684156;3746.606606306353;3781.716371272111;3782.791946442917;3790.65884070435;654.6235914349268;663.5255792108666;669.4443611802193;685.0409426802516;685.4413652872893;648.6108334998963;680.2143524229424;691.9273476284917;698.7344808972558;716.9964150179215;9057.818843623223;9444.291678124167;9522.578335537628;9573.712788616353;9661.227101831837;558.4527163379829;576.7952376906222;601.380578004656;677.0588881454781;678.6742363665468;4249.532551419341;4382.364557139197;4460.888477788017;4748.525147485224;4759.405074365704;147476.78784818237;156620.4337956606;162686.37313626712;163711.181444092;171636;102704;144509;145039.54960450472;146590.26704866407;147580;99327;124957;127106.36446817707;128933.99999999812;129608.35195824149;8951.283897288331;8961.103889610988;8970.147835955573;9014.459132452073;9127.954360228156;69013.30986690069;69680;69927;71067;71261.28738712547;102830;108087;108624;111459;112718;11850;11860.466279017637;11860.76278474443;11870;11890.524379024742;14849.480268190993;15454.609085182388;15503;15954.282057307217;15981.520554383387;10715.773189742542;13938.72122557523;14621.780673290123;15088.54734357971;15206.239688015776;13969.720605588034;14620.780688289897;14659.193744344164;14735.484258051345;15121.697566048837;13830.930845345709;13860.930695346458;14200.786988195392;14534.77629009627;14916.552503424915;11264.831027534758;11603.941980290045;11627.302361858316;11792.882071179178;11927.105467090176;11448.141389395661;11576.826347604625;11649.650510484698;11803.173777835813;11846.170768046499 18:19:40 INFO - PROCESS | 2040 | __end_tp_report 18:19:40 INFO - PROCESS | 2040 | __start_cc_report 18:19:40 INFO - PROCESS | 2040 | _x_x_mozilla_cycle_collect,449 18:19:40 INFO - PROCESS | 2040 | __end_cc_report 18:19:40 INFO - PROCESS | 2040 | __startTimestamp1467940780868__endTimestamp 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | ------- Summary: start ------- 18:19:40 INFO - PROCESS | 2040 | Number of tests: 6 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | [#0] dojo.html Cycles:165 Average:5813.33 Median:6067.45 stddev:648.94 (10.7%) stddev-sans-first:623.44 18:19:40 INFO - PROCESS | 2040 | Values: 3431.2 3438.6 3463.5 3465.5 3477.9 4598.6 5855.1 5907.8 5937.0 5945.0 4741.6 4755.8 5684.8 5923.5 5956.4 5309.5 5334.3 5364.1 5432.1 5482.4 5400.1 5410.1 5485.8 5507.3 5552.6 5262.0 5334.6 5366.4 5374.8 5379.3 5351.1 5367.7 5370.2 5371.5 5382.5 5226.4 5346.0 5363.3 5367.5 5416.8 5689.1 5741.8 5860.7 5883.6 5906.3 6236.7 6276.4 6322.1 6325.3 6329.0 6252.5 6263.3 6285.7 6298.8 6301.5 5334.6 5884.4 5885.9 5897.6 5940.6 6351.6 6353.2 6361.8 6389.9 6403.2 6135.3 6142.9 6160.5 6240.7 6279.3 6242.4 6282.3 6289.4 6294.2 6308.9 5289.9 6208.0 6244.2 6304.9 6358.1 6125.5 6234.4 6297.5 6303.8 6343.7 5014.0 5028.0 5031.9 5035.1 5038.9 4455.3 4517.2 4529.0 4530.3 4582.4 5610.3 5904.4 5930.6 5964.1 6039.6 6216.0 6244.6 6272.3 6302.2 6319.7 5953.9 5986.7 5993.8 5999.4 6049.2 5404.0 5524.3 5538.8 5574.5 5576.7 6480.8 6490.5 6491.2 6512.5 6518.0 5055.7 6265.2 6289.1 6292.8 6318.5 5662.9 6388.9 6446.6 6480.5 6494.2 6157.9 6231.2 6277.0 6299.2 6304.1 6128.0 6165.0 6288.9 6295.2 6307.5 4812.3 6141.1 6144.9 6167.6 6193.8 6171.4 6223.8 6228.3 6266.9 6291.8 5939.8 5999.6 6031.7 6067.5 6109.0 6109.8 6175.2 6181.8 6208.1 6292.9 6075.0 6126.7 6134.9 6145.5 6148.6 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | [#1] ext.html Cycles:180 Average:79793.29 Median:39478.70 stddev:198634.02 (503.1%) stddev-sans-first:199101.93 18:19:40 INFO - PROCESS | 2040 | Values: 459.5 473.5 478.0 506.6 514.6 37972.6 38722.8 40218.6 40223.2 40306.6 39909.6 40648.0 40695.0 40717.2 40733.0 9281.4 9451.8 9491.5 9507.2 9514.2 9663.4 9787.4 9802.6 9805.5 9817.2 9696.0 9768.2 9832.8 9839.5 9851.0 9619.2 9733.0 9759.0 9770.4 9803.4 9605.6 9694.6 9740.5 9783.7 9788.1 39356.4 39482.4 39716.6 39792.8 40025.6 2730.3 3322.1 3523.3 3793.6 4259.1 30115.4 30542.0 30568.4 30804.7 31137.0 3124.9 3132.8 3147.3 3166.3 3255.0 469241.0 470528.6 475202.0 475630.0 476120.6 32257.4 32728.2 32765.2 32827.2 33460.8 28600.0 33405.0 34271.3 34507.8 34574.5 14451.8 14557.5 14704.9 14713.6 14725.6 12341.6 12441.4 12460.8 12543.9 12558.0 6420.8 6422.7 7588.4 7672.4 7684.1 2764.2 2781.4 3197.1 3263.6 3264.6 890.0 961.8 991.6 1074.0 1138.8 25340.9 27256.6 30069.4 30345.2 30410.0 1010.9 1085.2 1093.5 1094.6 1152.4 14884.4 15000.7 15020.2 15233.8 15406.8 714276.0 1008559.0 1024206.0 1031872.0 1033948.0 56512.7 56738.0 57199.0 57233.0 57293.4 1401.8 1435.3 1442.9 1448.1 1453.5 29715.4 29730.1 29829.0 30335.8 30396.2 41790.6 56547.0 57345.0 57580.7 58908.0 661674.0 663714.8 672156.0 674070.0 674379.0 43764.8 43951.6 44226.8 44344.8 44378.8 47989.3 48142.8 48341.8 49074.8 49298.0 29818.0 38523.6 39475.0 40466.8 41188.8 39349.0 40225.4 40459.0 40522.0 40944.4 38261.2 38797.0 38846.8 39009.6 40167.8 32386.8 34728.0 34863.8 35250.3 35433.6 21234.9 24971.5 26242.9 26362.0 26439.9 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | [#2] jquery.html Cycles:180 Average:33524.10 Median:22403.10 stddev:93097.29 (415.6%) stddev-sans-first:93325.04 18:19:40 INFO - PROCESS | 2040 | Values: 304.3 382.6 386.9 396.6 403.5 20130.7 20688.8 20716.7 21177.2 21370.0 20251.1 20520.6 20976.1 21418.8 21801.0 5631.2 6077.3 6078.4 6273.6 6277.4 6117.7 6123.9 6169.7 6207.1 6226.2 5732.0 6079.9 6083.1 6133.9 6136.9 6079.8 6406.4 6776.3 6795.9 6797.2 5938.6 5983.2 5991.5 6064.3 6085.1 10629.6 13223.7 13225.9 26163.5 27059.9 2124.4 2132.2 2475.4 2608.5 2910.9 8678.4 10082.3 14495.2 14992.3 15109.2 1760.7 1803.8 1833.8 1862.6 1874.0 108948.5 119526.0 120141.4 121058.4 121546.0 9405.4 10551.1 10729.7 10939.0 10966.9 13066.9 13128.1 13189.5 13192.9 13230.1 7384.8 7741.9 7808.3 7843.6 7858.8 6869.7 7017.0 7712.5 7819.7 7886.8 3597.6 3637.3 3846.7 3913.8 4248.9 1909.9 1950.0 1983.1 1999.1 2005.0 808.8 848.7 887.7 940.6 1055.8 17695.5 21456.4 22153.0 22333.0 22473.2 959.4 965.9 974.6 1010.6 1039.2 10957.8 11148.3 11690.8 11730.6 11735.8 542772.0 544585.0 546731.0 555030.0 591098.0 116003.0 117405.0 117570.4 119327.0 123034.0 1015.3 1022.9 1063.1 1083.1 1086.4 13908.6 15503.1 18844.4 19198.7 19859.2 55880.0 56070.7 56675.1 57502.7 59594.1 67332.0 75338.0 82286.6 83060.0 83306.6 8122.1 8183.5 8212.2 8245.1 8255.5 12325.9 12400.7 12746.9 13057.2 13234.4 10130.5 11228.9 11265.5 11560.1 11569.5 8783.9 9126.3 11139.1 11197.0 11262.4 9402.0 11224.3 11424.8 11563.7 11598.0 7989.9 8165.5 8183.4 8201.7 8289.4 9658.5 11184.4 11437.0 11489.8 11535.1 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | [#3] mootools.html Cycles:180 Average:5648.97 Median:4921.83 stddev:3158.71 (64.2%) stddev-sans-first:3152.27 18:19:40 INFO - PROCESS | 2040 | Values: 1511.7 1567.0 1794.4 1897.4 1904.4 7984.5 8444.0 8526.4 8970.8 8980.3 7294.4 8645.5 8773.7 8778.0 8786.8 1981.5 2336.8 2356.2 2365.3 2371.8 2334.7 2339.5 2358.7 2376.7 2389.9 2343.9 2349.1 2350.8 2391.8 2394.8 2314.9 2315.6 2326.5 2345.3 2348.9 2320.9 2324.1 2327.3 2329.0 2334.1 8837.0 8845.0 8915.0 8930.0 8940.9 5202.5 5317.8 5350.0 5353.0 5353.4 3482.9 3563.6 3642.1 3675.1 3683.4 1055.9 1083.7 1101.5 1111.6 1116.3 9837.0 10721.2 10736.5 11388.3 11400.9 4435.5 4549.8 4556.1 4764.0 4779.1 8440.4 9803.7 9889.1 9895.6 9899.7 5090.5 5125.2 5144.5 5150.9 5155.5 4004.4 4458.9 4636.7 4699.1 4848.1 3368.4 3563.4 3883.4 3931.6 3994.2 1129.4 1135.8 1300.8 1305.5 1318.4 931.9 934.0 940.0 952.7 1015.5 5850.5 5853.5 6030.8 6082.1 6114.2 441.1 444.2 456.0 458.8 459.4 3612.1 3856.3 3917.4 4087.7 4146.0 10261.2 10623.6 10721.4 10746.9 10769.4 9793.9 10289.1 10705.3 10725.0 10737.7 7574.5 8217.1 8255.7 8331.7 8331.7 5778.2 5806.0 5857.9 5863.6 5937.2 9953.6 9965.4 9988.6 10021.3 10096.7 9949.8 10068.7 10220.1 10227.4 10241.0 6921.0 7343.5 7486.9 7565.8 7587.6 7164.5 8479.4 8537.4 8544.7 8548.4 7411.4 7547.0 7575.9 7613.4 7652.3 7381.2 7429.2 7555.7 7563.6 7567.0 7014.3 7022.4 7049.6 7082.6 7085.9 4880.9 5035.2 5062.5 5106.7 5112.9 4962.8 4993.1 5020.0 5051.3 5125.2 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | [#4] prototype.html Cycles:180 Average:4900.76 Median:5552.94 stddev:1512.68 (27.2%) stddev-sans-first:1477.09 18:19:40 INFO - PROCESS | 2040 | Values: 305.9 306.1 312.3 312.6 315.6 5847.6 5861.2 5886.1 5897.9 5924.2 5714.5 5726.3 5733.6 5807.7 5866.4 4197.0 4252.9 4285.8 4404.6 4410.8 3721.6 4036.8 4174.6 4328.6 4396.6 3791.9 4106.9 4349.5 4391.6 4418.2 3800.6 4120.0 4378.4 4391.8 4395.0 3759.0 3765.8 3804.8 3809.9 3810.4 5181.3 5654.9 5686.7 5696.9 5704.3 4775.6 4912.9 5022.6 5044.8 5081.1 4775.3 4992.4 6070.0 6084.9 6103.0 4158.9 4166.0 4173.3 4199.4 4212.8 5022.8 5300.3 5840.3 6364.6 6392.3 3395.8 3519.6 3971.7 3996.8 4241.0 3774.4 4210.2 4317.1 4333.1 4335.5 4272.6 4866.4 5002.4 5033.9 5047.8 5397.8 5675.4 6093.5 6151.6 6171.3 1295.3 1403.4 1453.5 1466.0 1489.8 913.7 917.2 918.7 952.6 997.4 5222.7 5366.0 5642.8 5668.7 5703.7 4641.0 5199.8 6270.3 6277.6 6324.3 4922.0 5303.0 5606.7 5657.4 5683.4 3295.8 3296.3 3303.0 3325.2 3338.5 5576.4 5701.6 6132.9 6339.1 6579.6 5667.4 5917.0 6273.8 6359.6 6464.4 5529.5 6000.9 6188.6 6555.8 6560.3 5151.5 5879.5 6050.7 6190.7 6259.5 5378.7 5893.4 6088.4 6132.8 6142.6 5323.3 6220.6 6279.6 6401.9 6485.0 4032.2 4239.2 4246.7 4247.0 4253.5 6048.1 6293.6 6299.7 6304.2 6314.6 5030.1 5272.7 6180.3 6213.8 6256.2 6189.8 6192.7 6203.0 6232.9 6272.3 5791.7 5966.3 6006.8 6082.2 6107.4 5357.6 6204.5 6212.3 6249.3 6251.0 4875.0 5313.5 6012.4 6124.6 6131.8 18:19:40 INFO - PROCESS | 2040 | 18:19:40 INFO - PROCESS | 2040 | [#5] yui.html Cycles:180 Average:26974.99 Median:24630.38 stddev:43917.36 (178.3%) stddev-sans-first:43996.12 18:19:40 INFO - PROCESS | 2040 | Values: 664.3 678.7 736.5 786.3 843.1 15086.5 15289.5 15858.6 15872.4 15893.5 14296.4 14408.7 14415.6 14417.6 14461.3 714.5 884.6 887.3 904.9 909.6 892.5 898.3 901.3 901.6 903.9 920.3 920.9 940.4 958.1 959.2 792.3 838.7 840.5 921.5 946.2 584.2 696.9 698.3 700.9 704.0 12428.8 12610.6 13191.2 15391.5 15529.6 12743.2 14078.9 14139.4 14948.9 15093.1 11569.5 12115.8 12117.2 12123.3 12229.6 3922.0 3924.5 3940.8 4081.4 4092.3 117578.4 122297.0 123501.0 126648.1 126897.7 9439.6 9447.6 11577.6 11580.5 12078.1 23456.4 24522.5 24602.6 24624.5 24636.3 6855.3 8266.2 8277.1 8346.2 8346.7 4514.9 4559.6 4563.3 4580.5 4752.2 3684.0 3746.6 3781.7 3782.8 3790.7 654.6 663.5 669.4 685.0 685.4 648.6 680.2 691.9 698.7 717.0 9057.8 9444.3 9522.6 9573.7 9661.2 558.5 576.8 601.4 677.1 678.7 4249.5 4382.4 4460.9 4748.5 4759.4 147476.8 156620.4 162686.4 163711.2 171636.0 102704.0 144509.0 145039.5 146590.3 147580.0 99327.0 124957.0 127106.4 128934.0 129608.4 8951.3 8961.1 8970.1 9014.5 9128.0 69013.3 69680.0 69927.0 71067.0 71261.3 102830.0 108087.0 108624.0 111459.0 112718.0 11850.0 11860.5 11860.8 11870.0 11890.5 14849.5 15454.6 15503.0 15954.3 15981.5 10715.8 13938.7 14621.8 15088.5 15206.2 13969.7 14620.8 14659.2 14735.5 15121.7 13830.9 13860.9 14200.8 14534.8 14916.6 11264.8 11603.9 11627.3 11792.9 11927.1 11448.1 11576.8 11649.7 11803.2 11846.2 18:19:40 INFO - PROCESS | 2040 | -------- Summary: end -------- 18:19:40 INFO - PROCESS | 2040 | 18:19:41 INFO - TEST-INFO | 2040: exit 0 18:19:41 INFO - TEST-OK | dromaeo_css | took 1113253ms 18:19:41 INFO - TEST-START | kraken 18:19:41 INFO - operating with platform_type : mac_ 18:19:41 INFO - Initialising browser for kraken test... 18:19:41 INFO - TEST-INFO | started process 2044 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpm0wQAw/profile http://localhost:51336/getInfo.html) 18:19:44 INFO - PROCESS | 2044 | __metrics Screen width/height:1600/1200 18:19:44 INFO - PROCESS | 2044 | colorDepth:24 18:19:44 INFO - PROCESS | 2044 | Browser inner width/height: 1024/689 18:19:44 INFO - PROCESS | 2044 | __metrics 18:19:44 ERROR - PROCESS | 2044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:19:45 INFO - TEST-INFO | 2044: exit 0 18:19:45 INFO - Browser initialized. 18:19:45 INFO - Running cycle 1/1 for kraken test... 18:19:45 INFO - TEST-INFO | started process 2046 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpm0wQAw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:57 INFO - PROCESS | 2046 | RSS: Main: 254439424 18:19:57 INFO - PROCESS | 2046 | 18:20:00 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51336/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:00 INFO - PROCESS | 2046 | RSS: Main: 267522048 18:20:00 INFO - PROCESS | 2046 | 18:20:03 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51336/tests/kraken/driver.html?testName=audio-dft) 18:20:04 INFO - PROCESS | 2046 | RSS: Main: 271581184 18:20:04 INFO - PROCESS | 2046 | 18:20:07 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51336/tests/kraken/driver.html?testName=audio-fft) 18:20:08 INFO - PROCESS | 2046 | RSS: Main: 271958016 18:20:08 INFO - PROCESS | 2046 | 18:20:10 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51336/tests/kraken/driver.html?testName=audio-oscillator) 18:20:11 INFO - PROCESS | 2046 | RSS: Main: 272887808 18:20:11 INFO - PROCESS | 2046 | 18:20:13 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:13 INFO - PROCESS | 2046 | RSS: Main: 273584128 18:20:13 INFO - PROCESS | 2046 | 18:20:16 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51336/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:17 INFO - PROCESS | 2046 | RSS: Main: 274079744 18:20:17 INFO - PROCESS | 2046 | 18:20:20 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51336/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:20 INFO - PROCESS | 2046 | RSS: Main: 274432000 18:20:20 INFO - PROCESS | 2046 | 18:20:23 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51336/tests/kraken/driver.html?testName=json-parse-financial) 18:20:24 INFO - PROCESS | 2046 | RSS: Main: 274628608 18:20:24 INFO - PROCESS | 2046 | 18:20:26 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:26 INFO - PROCESS | 2046 | RSS: Main: 274001920 18:20:26 INFO - PROCESS | 2046 | 18:20:28 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:29 INFO - PROCESS | 2046 | RSS: Main: 273989632 18:20:29 INFO - PROCESS | 2046 | 18:20:31 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:32 INFO - PROCESS | 2046 | RSS: Main: 274067456 18:20:32 INFO - PROCESS | 2046 | 18:20:35 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:36 INFO - PROCESS | 2046 | RSS: Main: 274235392 18:20:36 INFO - PROCESS | 2046 | 18:20:38 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:20:39 INFO - PROCESS | 2046 | RSS: Main: 274108416 18:20:39 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:51336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51336/tests/kraken/driver.html?testName=ai-astar) 18:20:41 INFO - PROCESS | 2046 | RSS: Main: 274812928 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | __start_tp_report 18:20:41 INFO - PROCESS | 2046 | _x_x_mozilla_page_load 18:20:41 INFO - PROCESS | 2046 | _x_x_mozilla_page_load_details 18:20:41 INFO - PROCESS | 2046 | |i|pagename|runs| 18:20:41 INFO - PROCESS | 2046 | |0;ai-astar;104;119;109;94;99;140;166;171;150;117 18:20:41 INFO - PROCESS | 2046 | |1;audio-beat-detection;149;111;133;157;98;135;133;142;163;142 18:20:41 INFO - PROCESS | 2046 | |2;audio-dft;279;191;253;253;271;230;197;199;194;196 18:20:41 INFO - PROCESS | 2046 | |3;audio-fft;63;116;108;143;59;60;59;55;146;78 18:20:41 INFO - PROCESS | 2046 | |4;audio-oscillator;70;71;138;79;70;92;115;73;73;116 18:20:41 INFO - PROCESS | 2046 | |5;imaging-gaussian-blur;91;87;90;74;135;130;93;110;116;88 18:20:41 INFO - PROCESS | 2046 | |6;imaging-darkroom;97;96;151;99;96;96;97;99;96;96 18:20:41 INFO - PROCESS | 2046 | |7;imaging-desaturate;92;100;104;124;93;120;148;91;90;93 18:20:41 INFO - PROCESS | 2046 | |8;json-parse-financial;57;64;75;68;56;57;55;62;70;88 18:20:41 INFO - PROCESS | 2046 | |9;json-stringify-tinderbox;58;86;101;110;100;76;81;88;59;88 18:20:41 INFO - PROCESS | 2046 | |10;stanford-crypto-aes;84;86;83;87;85;82;86;94;97;79 18:20:41 INFO - PROCESS | 2046 | |11;stanford-crypto-ccm;137;155;135;127;135;150;126;150;244;157 18:20:41 INFO - PROCESS | 2046 | |12;stanford-crypto-pbkdf2;173;172;165;169;168;170;166;174;181;169 18:20:41 INFO - PROCESS | 2046 | |13;stanford-crypto-sha256-iterative;66;68;67;68;66;69;66;67;61;62 18:20:41 INFO - PROCESS | 2046 | __end_tp_report 18:20:41 INFO - PROCESS | 2046 | __start_cc_report 18:20:41 INFO - PROCESS | 2046 | _x_x_mozilla_cycle_collect,1131 18:20:41 INFO - PROCESS | 2046 | __end_cc_report 18:20:41 INFO - PROCESS | 2046 | __startTimestamp1467940841477__endTimestamp 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | ------- Summary: start ------- 18:20:41 INFO - PROCESS | 2046 | Number of tests: 14 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#0] ai-astar Cycles:10 Average:126.90 Median:158.00 stddev:27.98 (17.7%) stddev-sans-first:28.42 18:20:41 INFO - PROCESS | 2046 | Values: 104.0 119.0 109.0 94.0 99.0 140.0 166.0 171.0 150.0 117.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:145.50 stddev:19.71 (13.5%) stddev-sans-first:20.37 18:20:41 INFO - PROCESS | 2046 | Values: 149.0 111.0 133.0 157.0 98.0 135.0 133.0 142.0 163.0 142.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#2] audio-dft Cycles:10 Average:226.30 Median:241.50 stddev:35.00 (14.5%) stddev-sans-first:31.50 18:20:41 INFO - PROCESS | 2046 | Values: 279.0 191.0 253.0 253.0 271.0 230.0 197.0 199.0 194.0 196.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#3] audio-fft Cycles:10 Average:88.70 Median:59.00 stddev:36.28 (61.5%) stddev-sans-first:37.27 18:20:41 INFO - PROCESS | 2046 | Values: 63.0 116.0 108.0 143.0 59.0 60.0 59.0 55.0 146.0 78.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:72.00 stddev:24.65 (34.2%) stddev-sans-first:25.09 18:20:41 INFO - PROCESS | 2046 | Values: 70.0 71.0 138.0 79.0 70.0 92.0 115.0 73.0 73.0 116.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:87.50 stddev:20.22 (23.1%) stddev-sans-first:21.10 18:20:41 INFO - PROCESS | 2046 | Values: 91.0 87.0 90.0 74.0 135.0 130.0 93.0 110.0 116.0 88.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:96.50 stddev:17.15 (17.8%) stddev-sans-first:18.09 18:20:41 INFO - PROCESS | 2046 | Values: 97.0 96.0 151.0 99.0 96.0 96.0 97.0 99.0 96.0 96.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:90.50 stddev:19.25 (21.3%) stddev-sans-first:19.79 18:20:41 INFO - PROCESS | 2046 | Values: 92.0 100.0 104.0 124.0 93.0 120.0 148.0 91.0 90.0 93.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:66.00 stddev:10.44 (15.8%) stddev-sans-first:10.65 18:20:41 INFO - PROCESS | 2046 | Values: 57.0 64.0 75.0 68.0 56.0 57.0 55.0 62.0 70.0 88.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#9] json-stringify-tinderbox Cycles:10 Average:84.70 Median:78.50 stddev:17.08 (21.8%) stddev-sans-first:15.14 18:20:41 INFO - PROCESS | 2046 | Values: 58.0 86.0 101.0 110.0 100.0 76.0 81.0 88.0 59.0 88.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:5.42 (6.3%) stddev-sans-first:5.68 18:20:41 INFO - PROCESS | 2046 | Values: 84.0 86.0 83.0 87.0 85.0 82.0 86.0 94.0 97.0 79.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:150.00 stddev:34.33 (22.9%) stddev-sans-first:36.01 18:20:41 INFO - PROCESS | 2046 | Values: 137.0 155.0 135.0 127.0 135.0 150.0 126.0 150.0 244.0 157.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.00 stddev:4.62 (2.7%) stddev-sans-first:4.82 18:20:41 INFO - PROCESS | 2046 | Values: 173.0 172.0 165.0 169.0 168.0 170.0 166.0 174.0 181.0 169.0 18:20:41 INFO - PROCESS | 2046 | 18:20:41 INFO - PROCESS | 2046 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:67.00 stddev:2.58 (3.9%) stddev-sans-first:2.74 18:20:41 INFO - PROCESS | 2046 | Values: 66.0 68.0 67.0 68.0 66.0 69.0 66.0 67.0 61.0 62.0 18:20:41 INFO - PROCESS | 2046 | -------- Summary: end -------- 18:20:41 INFO - PROCESS | 2046 | 18:20:42 INFO - TEST-INFO | 2046: exit 0 18:20:42 INFO - TEST-OK | kraken | took 60980ms 18:20:42 INFO - SUITE-END | took 1174s 18:20:42 INFO - Completed test suite (00:19:34) 18:20:42 INFO - javascript benchmark 18:20:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7410.436715751746, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3431.210821511054, 3438.6045604755454, 3463.4804779283104, 3465.5494785677856, 3477.947830782539, 4598.563136502027, 5855.063189889618, 5907.793227237037, 5936.970315148429, 5944.970275148624, 4741.573258406743, 4755.833545825897, 5684.829455116343, 5923.466887980081, 5956.374580669032, 5309.469053094688, 5334.306540149775, 5364.1149210380245, 5432.103702889039, 5482.424345443731, 5400.135978243482, 5410.08028635133, 5485.753141108639, 5507.311586051744, 5552.555795536367, 5262.0, 5334.626576139672, 5366.409694933554, 5374.811881584164, 5379.327584051994, 5351.117065684158, 5367.731613419313, 5370.167624018283, 5371.462853714636, 5382.542483888874, 5226.372835259755, 5346.0, 5363.302770639831, 5367.516923476866, 5416.83749487516, 5689.089745640719, 5741.8277451676095, 5860.736266868002, 5883.646981181143, 5906.291245050621, 6236.719347629368, 6276.4308922769305, 6322.083297921776, 6325.335839736807, 6328.968355158195, 6252.468540174091, 6263.34234905333, 6285.685715714196, 6298.811035668938, 6301.52738544611, 5334.5732341412595, 5884.382139875252, 5885.941140588625, 5897.6166549174595, 5940.584159108864, 6351.587146835441, 6353.174087368612, 6361.777337793155, 6389.9361006389345, 6403.231612206565, 6135.263289243823, 6142.928535732134, 6160.476359509402, 6240.687965601702, 6279.277883043417, 6242.438180563771, 6282.340354262828, 6289.40250676185, 6294.150289710922, 6308.905366419507, 5289.942011597619, 6208.037754148114, 6244.188255526843, 6304.873902521924, 6358.109864618957, 6125.479643195349, 6234.407731265523, 6297.4647154992335, 6303.810885673345, 6343.746250149942, 5013.974930125326, 5027.999999999927, 5031.943291908667, 5035.093683137071, 5038.949610503848, 4455.331700244924, 4517.186906356822, 4529.0, 4530.252508336088, 4582.358469814229, 5610.298712660918, 5904.380040095728, 5930.584859059911, 5964.135200395918, 6039.607425517327, 6216.017854200637, 6244.562880598314, 6272.3100458949475, 6302.243730752339, 6319.715612797435, 5953.880922381528, 5986.6707331097205, 5993.782011678696, 5999.430054144849, 6049.18336024631, 5404.0, 5524.309461317335, 5538.75075621598, 5574.470425309589, 5576.665400075927, 6480.773172938924, 6490.4807615390655, 6491.188601424822, 6512.47900167976, 6518.022296655539, 5055.747212639427, 6265.216847894013, 6289.056641503811, 6292.779752708633, 6318.462930650762, 5662.943370566406, 6388.872222555616, 6446.645434501147, 6480.546361754632, 6494.220693516808, 6157.9384206157365, 6231.189945307262, 6276.968615156895, 6299.244090709144, 6304.148939893055, 6128.014278093809, 6165.0, 6288.905666415099, 6295.244570651551, 6307.463865571478, 4812.302216178705, 6141.140240366263, 6144.893919094606, 6167.629942203482, 6193.783217587363, 6171.444569988723, 6223.751049958132, 6228.34602366745, 6266.937330626635, 6291.811245662638, 5939.812037592413, 5999.5800293979, 6031.728572214349, 6067.453929146398, 6109.0, 6109.829807539466, 6175.197224360804, 6181.84545386351, 6208.1308616792785, 6292.874142517216, 6075.0, 6126.724297406717, 6134.938650613437, 6145.539084568586, 6148.631082135086], "value": 5775.034390786404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.4991459309352, 473.4886322771405, 477.9675900055879, 506.5947242206234, 514.6320380927638, 37972.620273797256, 38722.80638596806, 40218.59781402189, 40223.19553608926, 40306.59693403065, 39909.600903990955, 40647.983800405, 40695.0, 40717.185656286856, 40733.0, 9281.443113413183, 9451.810963780721, 9491.477968711719, 9507.23942084635, 9514.191293740041, 9663.371880827759, 9787.36382135159, 9802.558884850163, 9805.460699661517, 9817.165540928994, 9695.951520242388, 9768.169705575036, 9832.803343933118, 9839.45882976436, 9850.950745246264, 9619.230461563058, 9733.0, 9759.024097590254, 9770.36492627977, 9803.41179529227, 9605.607186957852, 9694.563744631438, 9740.512974351324, 9783.657571985017, 9788.070133337322, 39356.40965385522, 39482.407763883566, 39716.60283397187, 39792.801035994635, 40025.59974400248, 2730.317420644839, 3322.1362445764034, 3523.2777280657406, 3793.5827059023486, 4259.10558782656, 30115.397692046037, 30542.0, 30568.388632227452, 30804.691953080408, 31137.0, 3124.875004999797, 3132.8120312781307, 3147.291859331655, 3166.335069635379, 3254.983725081383, 469241.0, 470528.6473567645, 475202.0, 475630.0, 476120.61939690425, 32257.35485290328, 32728.181795455304, 32765.180870478427, 32827.17932051718, 33460.83269583636, 28600.0, 33404.99785006454, 34271.31457370838, 34507.827460862536, 34574.481382779275, 14451.78322325166, 14557.490487832874, 14704.852951470348, 14713.632159196106, 14725.55823325302, 12341.568045118378, 12441.440135193938, 12460.81308780369, 12543.874561254454, 12558.0, 6420.7752728655205, 6422.678866056678, 7588.430867684946, 7672.424568157299, 7684.116326622398, 2764.156932135678, 2781.3741908070524, 3197.1048106529743, 3263.575735154415, 3264.579907740093, 889.9866502002475, 961.7595601099725, 991.5686676295834, 1073.983890241647, 1138.8007098757685, 25340.873295633774, 27256.59115113275, 30069.39861202764, 30345.24136896595, 30410.0, 1010.9039641234071, 1085.1861104171871, 1093.5243169221415, 1094.6497120921388, 1152.3604399558326, 14884.404623814926, 15000.69998600022, 15020.248987550578, 15233.847661523243, 15406.768898466533, 714276.0, 1008559.0, 1024206.0, 1031872.0, 1033948.0, 56512.717436413375, 56738.0, 57199.0, 57233.0, 57293.427065729644, 1401.7897315402772, 1435.253668092586, 1442.8845692344796, 1448.1455940994863, 1453.5203382883624, 29715.405691886474, 29730.108096757132, 29828.955986540368, 30335.848320758254, 30396.240093997825, 41790.58209417989, 56547.0, 57345.0, 57580.71209643925, 58908.0, 661674.0, 663714.7699830483, 672156.0, 674070.0, 674379.0, 43764.781176093915, 43951.560484396025, 44226.778866105466, 44344.778276108416, 44378.77810610926, 47989.280160796916, 48142.75928620334, 48341.75829120973, 49074.773130672016, 49298.0, 29818.0, 38523.614763853126, 39475.0, 40466.79766601148, 41188.794056029525, 39349.01627459222, 40225.39661905015, 40459.0, 40521.98695032648, 40944.385834213106, 38261.234775304896, 38797.0, 38846.80576597099, 39009.6099039006, 40167.799161004004, 32386.83806580952, 34728.0, 34863.825680871436, 35250.294994100484, 35433.64566354406, 21234.893825530773, 24971.50056998886, 26242.868785655948, 26362.0, 26439.867800661643], "value": 18868.59295276518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.28644827878617, 382.5944498831239, 386.85492940147435, 396.5558574396676, 403.48757078510295, 20130.6980395294, 20688.793112068874, 20716.68924966125, 21177.152913883463, 21370.0, 20251.08870100845, 20520.589588208226, 20976.05607747651, 21418.785812141872, 21801.0, 5631.239782629334, 6077.331493535729, 6078.39216078393, 6273.5922165059355, 6277.435030847223, 6117.66352850593, 6123.908141377883, 6169.722362493676, 6207.131001659771, 6226.221722284715, 5731.971340143315, 6079.908801367983, 6083.117947897552, 6133.877322453548, 6136.9079463808075, 6079.784043191357, 6406.391392817675, 6776.2546119926765, 6795.898061529081, 6797.150356205474, 5938.584299099065, 5983.222181116427, 5991.460768530809, 6064.302605200414, 6085.087236914498, 10629.574817007311, 13223.735525289536, 13225.933870330588, 26163.476730465474, 27059.917603295846, 2124.4476436126565, 2132.2323963373174, 2475.4306509502735, 2608.543504886637, 2910.941781164386, 8678.392512524126, 10082.294239403245, 14495.202763847985, 14992.250387480583, 15109.244537773176, 1760.709482935314, 1803.8196180381988, 1833.7982821889582, 1862.6181632765251, 1874.0348720409, 108948.455257724, 119526.0, 120141.39929300298, 121058.3947080259, 121546.0, 9405.388649737744, 10551.103156231806, 10729.731756706145, 10939.0, 10966.945165274123, 13066.934665326613, 13128.081034327697, 13189.538366157138, 13192.868071319355, 13230.073894827463, 7384.778456646309, 7741.8838717419285, 7808.297253247121, 7843.568603726736, 7858.803529911684, 6869.725210991504, 7017.017617533447, 7712.537247765152, 7819.726309579138, 7886.763397098096, 3597.568291805, 3637.2907283080076, 3846.74996125251, 3913.804309784556, 4248.915021699549, 1909.875858069221, 1949.951251218731, 1983.1457587155767, 1999.1403696410391, 2004.9899750501445, 808.8058865872148, 848.6944699908029, 887.7159309021051, 940.5955439161089, 1055.757175849559, 17695.46913592594, 21456.356309310744, 22153.0, 22332.995015224355, 22473.213437529936, 959.4099628728281, 965.8840939087354, 974.5858010345574, 1010.6311196413403, 1039.194624166262, 10957.780844383067, 11148.2753621016, 11690.76618467643, 11730.589429369931, 11735.765284694258, 542772.0, 544585.0, 546731.0, 555030.0, 591098.0, 116003.0, 117405.0, 117570.41214793871, 119327.0, 123034.0, 1015.2690063154517, 1022.8772547294373, 1063.0963680871198, 1083.0685610375072, 1086.364476781076, 13908.582742517741, 15503.069815811088, 18844.434666960013, 19198.71201932, 19859.205631774566, 55880.0, 56070.71964640151, 56675.14987275111, 57502.7124864373, 59594.10608840784, 67332.0, 75338.0, 82286.58856705678, 83060.0, 83306.58346708228, 8122.147174546824, 8183.468074575134, 8212.219839115274, 8245.13426090252, 8255.463394879314, 12325.890669839398, 12400.689982750504, 12746.936265318614, 13057.21656700563, 13234.404451799885, 10130.493475326351, 11228.943855280671, 11265.493052812479, 11560.075193984292, 11569.537218511501, 8783.91216087831, 9126.269898407978, 11139.108871290115, 11197.0, 11262.38056906878, 9402.0, 11224.326540407601, 11424.771504570028, 11563.6530904073, 11598.0, 7989.880151797844, 8165.469244499089, 8183.427160098736, 8201.671933122847, 8289.41974061834, 9658.517074146404, 11184.440777960906, 11437.0, 11489.827652585385, 11535.134864885335], "value": 9492.47359400914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.6749898771766, 1566.9736322708627, 1794.4347530527882, 1897.430770768769, 1904.4477101640525, 7984.481008734443, 8444.0, 8526.36052296078, 8970.775730606738, 8980.326475514337, 7294.416446684266, 8645.481271123721, 8773.736787896358, 8778.034416214212, 8786.824263514725, 1981.5145289404115, 2336.778006089419, 2356.1988923765916, 2365.2549446924163, 2371.8102551795814, 2334.7431782503995, 2339.4736184358553, 2358.6697862299293, 2376.66726658268, 2389.940251493709, 2343.94140146496, 2349.0955981946986, 2350.7766762157567, 2391.7727815857465, 2394.8443351182204, 2314.884255787212, 2315.583195024895, 2326.499802542453, 2345.3081341004445, 2348.9177878774244, 2320.9439704934216, 2324.140068174769, 2327.2552783109413, 2329.0, 2334.0663734506165, 8837.0, 8845.027047024822, 8915.019347871794, 8929.955350223207, 8940.8658870117, 5202.479752024805, 5317.760700768475, 5350.036993341197, 5353.0, 5353.437889021636, 3482.9303413931834, 3563.572371315459, 3642.05306620278, 3675.1363429594026, 3683.37382644951, 1055.8996895294936, 1083.7453198498347, 1101.4767985206963, 1111.555377848867, 1116.3190453823242, 9836.95081524595, 10721.249512534127, 10736.516856741544, 11388.259763115453, 11400.885991140065, 4435.489918659331, 4549.840755573539, 4556.134334476439, 4763.976180119077, 4779.091972525209, 8440.366972477088, 9803.705888823346, 9889.109980101824, 9895.554700038516, 9899.703008909744, 5090.541851233407, 5125.15434953236, 5144.511271429208, 5150.871228219325, 5155.510226528474, 4004.379321205218, 4458.866234012985, 4636.698614590041, 4699.107169637758, 4848.10310092634, 3368.444206705915, 3563.4476656118345, 3883.3980732986433, 3931.567527571965, 3994.1612261425425, 1129.4239937631867, 1135.840982262484, 1300.8048792681172, 1305.4973835073565, 1318.4198952460886, 931.9487428191379, 933.9673111441067, 939.9765005874908, 952.6618050592078, 1015.5227043289642, 5850.531957443394, 5853.502452291603, 6030.758769649165, 6082.0876868469195, 6114.2357205349335, 441.05393930019926, 444.2048732768373, 456.0081822037056, 458.7820785127038, 459.370662192798, 3612.0608641753333, 3856.3444214483607, 3917.3928041153667, 4087.734297270668, 4146.0464093258115, 10261.179105671677, 10623.575056997634, 10721.35671859691, 10746.892531074589, 10769.407682577377, 9793.922668506459, 10289.125424338865, 10705.250632455809, 10725.03474687282, 10737.731556711145, 7574.469787114959, 8217.055038670509, 8255.669773209005, 8331.708390206313, 8331.708390206435, 5778.219940308005, 5806.042003069446, 5857.941420585739, 5863.618864773946, 5937.19847820556, 9953.601855925972, 9965.35225210388, 9988.550515226978, 10021.298509104292, 10096.69709908704, 9949.801003979735, 10068.69793906184, 10220.131288840234, 10227.386356818317, 10241.027102425258, 6921.0, 7343.522671026366, 7486.850262994601, 7565.810854728676, 7587.62061896914, 7164.534305270141, 8479.406441549032, 8537.445066070686, 8544.700935467228, 8548.444351117158, 7411.370033547209, 7546.962265188639, 7575.886361704469, 7613.428992825449, 7652.349550288065, 7381.224971377928, 7429.219931907072, 7555.6977720890545, 7563.584002879895, 7567.01628788254, 7014.333638304353, 7022.367986881205, 7049.577025378494, 7082.610456424946, 7085.929140708527, 4880.902381952412, 5035.219540971156, 5062.468440813809, 5106.719130447861, 5112.948870511247, 4962.751862406793, 4993.126202914403, 5020.0, 5051.267566202953, 5125.1799712045895], "value": 4481.475365188036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.9434004709128, 306.14127372719514, 312.3409605731905, 312.6154829559642, 315.6244069557228, 5847.596576821564, 5861.238039054922, 5886.146508756233, 5897.882042359151, 5924.200232968548, 5714.485696287334, 5726.3128424589, 5733.595269159052, 5807.651540907548, 5866.442687944649, 4196.978175713497, 4252.936205956913, 4285.8071386787515, 4404.647628189737, 4410.76498580398, 3721.5720192177973, 4036.7889633110094, 4174.582541745832, 4328.567143285678, 4396.648268138557, 3791.905202369935, 4106.850081977052, 4349.521552629209, 4391.604755571998, 4418.160549495602, 3800.638939300762, 4119.979400102995, 4378.408914796525, 4391.780410979454, 4395.033092719628, 3759.030366010848, 3765.811709414546, 3804.8478060877533, 3809.904752381185, 3810.3712887373827, 5181.326427564392, 5654.915176272318, 5686.687232202227, 5696.914546281809, 5704.34400043992, 4775.594074503637, 4912.877178070541, 5022.573081288095, 5044.83968687204, 5081.136206844845, 4775.304766807768, 4992.355580426309, 6070.0, 6084.939150608481, 6102.96948515259, 4158.877103182124, 4166.041960278664, 4173.290540608104, 4199.4120823084795, 4212.810423530917, 5022.773975171126, 5300.337457817773, 5840.269966254218, 6364.649944253064, 6392.328805475405, 3395.830208489566, 3519.6128425873135, 3971.72197946141, 3996.800159991989, 4240.957590424056, 3774.3960966245268, 4210.242156411875, 4317.050248945227, 4333.111712099012, 4335.501417336984, 4272.594103560157, 4866.367372241657, 5002.399712034579, 5033.924491132636, 5047.848564543069, 5397.839464515148, 5675.3757086720425, 6093.482054025458, 6151.585135418789, 6171.346321081888, 1295.2552282437637, 1403.4245959156697, 1453.5276035288573, 1466.0397439677029, 1489.8063251777417, 913.7207908927554, 917.179124683418, 918.7427520294328, 952.6284748947916, 997.3666721631671, 5222.686638801684, 5365.973170134124, 5642.830715078554, 5668.7165641718575, 5703.74333155009, 4641.025384669189, 5199.844004679866, 6270.2789179244055, 6277.623342599459, 6324.272708638474, 4921.9507804922205, 5303.003802851376, 5606.6920516895225, 5657.434256574392, 5683.374828768832, 3295.7857739246874, 3296.2583418731074, 3302.9504557431655, 3325.1687078230443, 3338.5326054351926, 5576.414476479911, 5701.574606348413, 6132.938670613236, 6339.144215530844, 6579.605223686594, 5667.40492248308, 5916.9941110011405, 6273.843153921189, 6359.554831161867, 6464.416218026614, 5529.474699903502, 6000.939990600213, 6188.597741146811, 6555.8361040973405, 6560.311167327457, 5151.484851514819, 5879.529637629065, 6050.697465126638, 6190.690465476799, 6259.467945224706, 5378.682222855426, 5893.381194974466, 6088.360722124113, 6132.754689812357, 6142.6314421134875, 5323.281357016908, 6220.582369365848, 6279.591826531444, 6401.8719625608155, 6484.967575162283, 4032.1532478178738, 4239.236937351307, 4246.702730808814, 4246.978765106154, 4253.48958125027, 6048.101038159105, 6293.622382657055, 6299.748010079546, 6304.243490781136, 6314.55798094129, 5030.145909197642, 5272.657277276965, 6180.289266734203, 6213.844653883689, 6256.217972753406, 6189.84525386869, 6192.690365481618, 6202.953025501663, 6232.937670623236, 6272.341404152681, 5791.739371728198, 5966.343702192668, 6006.789762358297, 6082.2093127893095, 6107.404353149982, 5357.598180136428, 6204.534659900435, 6212.254529456494, 6249.25008998923, 6250.968745156245, 4875.0493653737185, 5313.521783039545, 6012.436766440669, 6124.5712800103565, 6131.785387511416], "value": 4411.771034653908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.2759392262434, 678.7239988821016, 736.5212611802331, 786.3434032582793, 843.0726201178702, 15086.547403577883, 15289.464868729598, 15858.603534911634, 15872.444464443746, 15893.523194304174, 14296.35666395012, 14408.703216710494, 14415.621422465281, 14417.639559011004, 14461.34923928423, 714.4605822603927, 884.5709830732106, 887.3477993674644, 904.9276057915384, 909.5679552212679, 892.451142547332, 898.2589363774879, 901.3195037746492, 901.6168128545374, 903.9096090390941, 920.3281604428771, 920.8756817829608, 940.3652534539193, 958.1424624960656, 959.2278216036088, 792.2948575767572, 838.7106448275335, 840.4663038970267, 921.4749589429472, 946.1626460582365, 584.220066211608, 696.9059177011089, 698.322627051759, 700.9369156775864, 703.9897746733454, 12428.813567796491, 12610.621681349574, 13191.208527488381, 15391.461298854598, 15529.611759705986, 12743.235405875677, 14078.944079194102, 14139.434422623082, 14948.850511494855, 15093.094414335064, 11569.479373428216, 12115.757684846341, 12117.212381195282, 12123.33321667308, 12229.571964981184, 3921.9803900980596, 3924.529056513208, 3940.763554186758, 4081.4081958116203, 4092.3043082675717, 117578.41210793977, 122297.0, 123501.0, 126648.10027849498, 126897.73102269044, 9439.575219115157, 9447.622095116256, 11577.594784182513, 11580.47887845049, 12078.094142939315, 23456.413589660395, 24522.50954980926, 24602.630960535607, 24624.50750985006, 24636.260912172664, 6855.280195579492, 8266.173382661686, 8277.089520152778, 8346.207110324509, 8346.749597512084, 4514.864554063383, 4559.566841150086, 4563.338315944169, 4580.473245576802, 4752.1683705351425, 3683.9631603684156, 3746.606606306353, 3781.716371272111, 3782.791946442917, 3790.65884070435, 654.6235914349268, 663.5255792108666, 669.4443611802193, 685.0409426802516, 685.4413652872893, 648.6108334998963, 680.2143524229424, 691.9273476284917, 698.7344808972558, 716.9964150179215, 9057.818843623223, 9444.291678124167, 9522.578335537628, 9573.712788616353, 9661.227101831837, 558.4527163379829, 576.7952376906222, 601.380578004656, 677.0588881454781, 678.6742363665468, 4249.532551419341, 4382.364557139197, 4460.888477788017, 4748.525147485224, 4759.405074365704, 147476.78784818237, 156620.4337956606, 162686.37313626712, 163711.181444092, 171636.0, 102704.0, 144509.0, 145039.54960450472, 146590.26704866407, 147580.0, 99327.0, 124957.0, 127106.36446817707, 128933.99999999812, 129608.35195824149, 8951.283897288331, 8961.103889610988, 8970.147835955573, 9014.459132452073, 9127.954360228156, 69013.30986690069, 69680.0, 69927.0, 71067.0, 71261.28738712547, 102830.0, 108087.0, 108624.0, 111459.0, 112718.0, 11850.0, 11860.466279017637, 11860.76278474443, 11870.0, 11890.524379024742, 14849.480268190993, 15454.609085182388, 15503.0, 15954.282057307217, 15981.520554383387, 10715.773189742542, 13938.72122557523, 14621.780673290123, 15088.54734357971, 15206.239688015776, 13969.720605588034, 14620.780688289897, 14659.193744344164, 14735.484258051345, 15121.697566048837, 13830.930845345709, 13860.930695346458, 14200.786988195392, 14534.77629009627, 14916.552503424915, 11264.831027534758, 11603.941980290045, 11627.302361858316, 11792.882071179178, 11927.105467090176, 11448.141389395661, 11576.826347604625, 11649.650510484698, 11803.173777835813, 11846.170768046499], "value": 8096.811696257782, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 109.0, 94.0, 99.0, 140.0, 166.0, 171.0, 150.0, 117.0], "value": 126.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 133.0, 157.0, 98.0, 135.0, 133.0, 142.0, 163.0, 142.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [279.0, 191.0, 253.0, 253.0, 271.0, 230.0, 197.0, 199.0, 194.0, 196.0], "value": 226.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 116.0, 108.0, 143.0, 59.0, 60.0, 59.0, 55.0, 146.0, 78.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 138.0, 79.0, 70.0, 92.0, 115.0, 73.0, 73.0, 116.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 74.0, 135.0, 130.0, 93.0, 110.0, 116.0, 88.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 151.0, 99.0, 96.0, 96.0, 97.0, 99.0, 96.0, 96.0], "value": 102.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 100.0, 104.0, 124.0, 93.0, 120.0, 148.0, 91.0, 90.0, 93.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 75.0, 68.0, 56.0, 57.0, 55.0, 62.0, 70.0, 88.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 86.0, 101.0, 110.0, 100.0, 76.0, 81.0, 88.0, 59.0, 88.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 87.0, 85.0, 82.0, 86.0, 94.0, 97.0, 79.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 155.0, 135.0, 127.0, 135.0, 150.0, 126.0, 150.0, 244.0, 157.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 165.0, 169.0, 168.0, 170.0, 166.0, 174.0, 181.0, 169.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 68.0, 66.0, 69.0, 66.0, 67.0, 61.0, 62.0], "value": 66.0, "unit": "score"}]}]} 18:20:42 INFO - Return code: 0 18:20:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:20:42 ERROR - # TBPL SUCCESS # 18:20:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:20:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:20:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:20:42 INFO - 2016-07-07 18:20:42.830 screenresolution[2051:18794] starting screenresolution argv=screenresolution get 18:20:42 INFO - 2016-07-07 18:20:42.834 screenresolution[2051:18794] Display 0: 1600x1200x32@60 18:20:42 INFO - 2016-07-07 18:20:42.840 screenresolution[2052:18798] starting screenresolution argv=screenresolution list 18:20:42 INFO - Available Modes on Display 0 18:20:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:20:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:20:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:20:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:20:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:20:43 INFO - Intel Iris: 18:20:43 INFO - Chipset Model: Intel Iris 18:20:43 INFO - Type: GPU 18:20:43 INFO - Bus: Built-In 18:20:43 INFO - VRAM (Dynamic, Max): 1536 MB 18:20:43 INFO - Vendor: Intel (0x8086) 18:20:43 INFO - Device ID: 0x0a2e 18:20:43 INFO - Revision ID: 0x0009 18:20:43 INFO - Displays: 18:20:43 INFO - Display: 18:20:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:20:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:20:43 INFO - Display Serial Number: 1600x1200 60 18:20:43 INFO - Main Display: Yes 18:20:43 INFO - Mirror: Off 18:20:43 INFO - Online: Yes 18:20:43 INFO - Rotation: Supported 18:20:43 INFO - Return code: 0 18:20:43 INFO - Running post-action listener: _resource_record_post_action 18:20:43 INFO - ##### 18:20:43 INFO - ##### Finished run-tests step (success) 18:20:43 INFO - ##### 18:20:43 INFO - Running post-run listener: _resource_record_post_run 18:20:43 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 655872; Write bytes: 711829504; Read time: 6; Write time: 2192 18:20:43 INFO - TinderboxPrint: CPU usage
54.2% 18:20:43 INFO - TinderboxPrint: I/O read bytes / time
655,872 / 6 18:20:43 INFO - TinderboxPrint: I/O write bytes / time
711,829,504 / 2,192 18:20:43 INFO - TinderboxPrint: CPU idle
2,219.2 (45.8%) 18:20:43 INFO - TinderboxPrint: CPU system
978.0 (20.2%) 18:20:43 INFO - TinderboxPrint: CPU user
1,644.4 (34.0%) 18:20:43 INFO - TinderboxPrint: Swap in / out
406,994,944 / 0 18:20:43 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 407843328; Write bytes: 415520256; Read time: 31263; Write time: 813 18:20:43 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 655872; Write bytes: 294851072; Read time: 6; Write time: 1372 18:20:43 INFO - Running post-run listener: _upload_blobber_files 18:20:43 INFO - Blob upload gear active. 18:20:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:20:43 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:20:43 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:20:43 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:20:43 INFO - (blobuploader) - INFO - Open directory for files ... 18:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:45 INFO - (blobuploader) - INFO - Done attempting. 18:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:45 INFO - (blobuploader) - INFO - Done attempting. 18:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:48 INFO - (blobuploader) - INFO - Done attempting. 18:20:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:20:48 INFO - Return code: 0 18:20:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:20:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:20:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/32500b755ddc9301ce878c8abe48d109ac6e37155d72e9796afdbbd86607932768a8e6f19eb8e51098b85325a73d30e0960e750586b79c1b90109e1b0e6c0b64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a838c52bb1b147df5baeb25a5e02399249f58f25d4d55fa9ea051fd6845c7286543d64d9f9c49146c5de92a94c1de0273ad586626b39dbfe70b3d5b742136119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfc45679cc7676c43c0893e771a450a6f1a617f194bd95ec6ddd5988375cec224946b448f23a04038adc46d3ce852aab8cefec9f94408ea6c7e40a1e09fc40d1"} 18:20:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:20:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:20:48 INFO - Contents: 18:20:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/32500b755ddc9301ce878c8abe48d109ac6e37155d72e9796afdbbd86607932768a8e6f19eb8e51098b85325a73d30e0960e750586b79c1b90109e1b0e6c0b64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a838c52bb1b147df5baeb25a5e02399249f58f25d4d55fa9ea051fd6845c7286543d64d9f9c49146c5de92a94c1de0273ad586626b39dbfe70b3d5b742136119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfc45679cc7676c43c0893e771a450a6f1a617f194bd95ec6ddd5988375cec224946b448f23a04038adc46d3ce852aab8cefec9f94408ea6c7e40a1e09fc40d1"} 18:20:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:20:48 INFO - Copying logs to upload dir... 18:20:48 INFO - mkdir: /builds/slave/test/build/upload/logs 18:20:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1301.141498 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-07-07 18:20:48.363107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:20:48.366406) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZdmPjfd66s/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/32500b755ddc9301ce878c8abe48d109ac6e37155d72e9796afdbbd86607932768a8e6f19eb8e51098b85325a73d30e0960e750586b79c1b90109e1b0e6c0b64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a838c52bb1b147df5baeb25a5e02399249f58f25d4d55fa9ea051fd6845c7286543d64d9f9c49146c5de92a94c1de0273ad586626b39dbfe70b3d5b742136119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfc45679cc7676c43c0893e771a450a6f1a617f194bd95ec6ddd5988375cec224946b448f23a04038adc46d3ce852aab8cefec9f94408ea6c7e40a1e09fc40d1"} build_url:https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/WTRSAN1kRVWL96idCU3htw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/32500b755ddc9301ce878c8abe48d109ac6e37155d72e9796afdbbd86607932768a8e6f19eb8e51098b85325a73d30e0960e750586b79c1b90109e1b0e6c0b64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a838c52bb1b147df5baeb25a5e02399249f58f25d4d55fa9ea051fd6845c7286543d64d9f9c49146c5de92a94c1de0273ad586626b39dbfe70b3d5b742136119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfc45679cc7676c43c0893e771a450a6f1a617f194bd95ec6ddd5988375cec224946b448f23a04038adc46d3ce852aab8cefec9f94408ea6c7e40a1e09fc40d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:20:48.399965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:20:48.400281) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZdmPjfd66s/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pwrnk1wfQK/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005107 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:20:48.449417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:20:48.449781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:20:48.450179) ========= ========= Total master_lag: 0.21 =========