builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0385 starttime: 1467735194.4 results: success (0) buildid: 20160705070128 builduid: dddabf17a2214e01aedc59bd7a97a602 revision: f47a1bc057ff5a6084e776040425da258a2851ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.402760) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.403191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.403466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.428016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.428413) ========= 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.sPoPWw8c4m/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.SARbA5wM49/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-05 09:13:14-- 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% 19.0M=0.001s 2016-07-05 09:13:14 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081888 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.532593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.535967) ========= 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.sPoPWw8c4m/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.SARbA5wM49/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.026689 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.584848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:14.585209) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f47a1bc057ff5a6084e776040425da258a2851ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f47a1bc057ff5a6084e776040425da258a2851ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sPoPWw8c4m/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.SARbA5wM49/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-05 09:13:14,679 truncating revision to first 12 chars 2016-07-05 09:13:14,679 Setting DEBUG logging. 2016-07-05 09:13:14,680 attempt 1/10 2016-07-05 09:13:14,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f47a1bc057ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 09:13:15,019 unpacking tar archive at: mozilla-central-f47a1bc057ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594539 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:15.201665) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:15.201979) ========= script_repo_revision: f47a1bc057ff5a6084e776040425da258a2851ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:15.202355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:15.202620) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:13:15.220654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-05 09:13:15.221076) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sPoPWw8c4m/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.SARbA5wM49/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:15 INFO - MultiFileLogger online at 20160705 09:13:15 in /builds/slave/test 09:13:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:13:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:13:15 INFO - {'append_to_log': False, 09:13:15 INFO - 'base_work_dir': '/builds/slave/test', 09:13:15 INFO - 'blob_upload_branch': 'Firefox', 09:13:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:13:15 INFO - 'branch': 'Firefox', 09:13:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:13:15 INFO - 'config_files': ('talos/mac_config.py',), 09:13:15 INFO - 'default_actions': ('clobber', 09:13:15 INFO - 'read-buildbot-config', 09:13:15 INFO - 'download-and-extract', 09:13:15 INFO - 'populate-webroot', 09:13:15 INFO - 'create-virtualenv', 09:13:15 INFO - 'install', 09:13:15 INFO - 'run-tests'), 09:13:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:13:15 INFO - 'download_minidump_stackwalk': True, 09:13:15 INFO - 'download_symbols': 'ondemand', 09:13:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:13:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:13:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:13:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:13:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:13:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:13:15 INFO - 'installer_path': 'installer.exe', 09:13:15 INFO - 'log_level': 'info', 09:13:15 INFO - 'log_name': 'talos', 09:13:15 INFO - 'log_to_console': True, 09:13:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:13:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:13:15 INFO - 'opt_config_files': (), 09:13:15 INFO - 'pip_index': False, 09:13:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:13:15 INFO - 'cmd': ('bash', 09:13:15 INFO - '-c', 09:13:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:13:15 INFO - 'enabled': True, 09:13:15 INFO - 'halt_on_failure': False, 09:13:15 INFO - 'name': 'check_screen_resolution'},), 09:13:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:13:15 INFO - 'cmd': ('bash', 09:13:15 INFO - '-c', 09:13:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:13:15 INFO - 'enabled': True, 09:13:15 INFO - 'halt_on_failure': False, 09:13:15 INFO - 'name': 'check_screen_resolution'},), 09:13:15 INFO - 'run_cmd_checks_enabled': True, 09:13:15 INFO - 'sps_profile': False, 09:13:15 INFO - 'sps_profile_interval': 0, 09:13:15 INFO - 'suite': 'dromaeojs-e10s', 09:13:15 INFO - 'system_bits': '32', 09:13:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:13:15 INFO - 'title': 't-yosemite-r7-0385', 09:13:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:13:15 INFO - 'use_talos_json': True, 09:13:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:13:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:13:15 INFO - 'work_dir': 'build'} 09:13:15 INFO - ##### 09:13:15 INFO - ##### Running clobber step. 09:13:15 INFO - ##### 09:13:15 INFO - Running pre-action listener: _resource_record_pre_action 09:13:15 INFO - Running main action method: clobber 09:13:15 INFO - rmtree: /builds/slave/test/build 09:13:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:13:17 INFO - Running post-action listener: _resource_record_post_action 09:13:17 INFO - ##### 09:13:17 INFO - ##### Finished clobber step (success) 09:13:17 INFO - ##### 09:13:17 INFO - ##### 09:13:17 INFO - ##### Running read-buildbot-config step. 09:13:17 INFO - ##### 09:13:17 INFO - Running pre-action listener: _resource_record_pre_action 09:13:17 INFO - Running main action method: read_buildbot_config 09:13:17 INFO - Using buildbot properties: 09:13:17 INFO - { 09:13:17 INFO - "project": "", 09:13:17 INFO - "product": "firefox", 09:13:17 INFO - "script_repo_revision": "production", 09:13:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:13:17 INFO - "repository": "", 09:13:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:13:17 INFO - "buildid": "20160705070128", 09:13:17 INFO - "pgo_build": "False", 09:13:17 INFO - "basedir": "/builds/slave/test", 09:13:17 INFO - "buildnumber": 38, 09:13:17 INFO - "slavename": "t-yosemite-r7-0385", 09:13:17 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:13:17 INFO - "platform": "yosemite_r7", 09:13:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:13:17 INFO - "branch": "mozilla-central", 09:13:17 INFO - "repo_path": "mozilla-central", 09:13:17 INFO - "revision": "f47a1bc057ff5a6084e776040425da258a2851ca", 09:13:17 INFO - "stage_platform": "macosx64", 09:13:17 INFO - "builduid": "dddabf17a2214e01aedc59bd7a97a602", 09:13:17 INFO - "slavebuilddir": "test" 09:13:17 INFO - } 09:13:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 09:13:17 INFO - Running post-action listener: _resource_record_post_action 09:13:17 INFO - ##### 09:13:17 INFO - ##### Finished read-buildbot-config step (success) 09:13:17 INFO - ##### 09:13:17 INFO - ##### 09:13:17 INFO - ##### Running download-and-extract step. 09:13:17 INFO - ##### 09:13:17 INFO - Running pre-action listener: _resource_record_pre_action 09:13:17 INFO - Running main action method: download_and_extract 09:13:17 INFO - mkdir: /builds/slave/test/build/tests 09:13: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')]} 09:13:17 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:18 INFO - Downloaded 1199 bytes. 09:13:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:13:18 INFO - Using the following test package requirements: 09:13:18 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:13:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:13:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:13:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'jsshell-mac.zip'], 09:13:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:13:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:13:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:13:18 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:13:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:13:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:13:18 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:13:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:13:18 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')]} 09:13:18 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:19 INFO - Downloaded 18800215 bytes. 09:13:19 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'] 09:13:19 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 09:13:22 INFO - Return code: 0 09:13:22 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 09:13: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')]} 09:13:22 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:23 INFO - Downloaded 18800215 bytes. 09:13:23 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'] 09:13:23 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 09:13:27 INFO - Return code: 0 09:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:27 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:28 INFO - Downloaded 14403333 bytes. 09:13:28 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'] 09:13:28 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 09:13:28 INFO - Return code: 0 09:13:28 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')]} 09:13:28 INFO - https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:13:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:13:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:13:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/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 09:13:31 INFO - Downloaded 112443925 bytes. 09:13:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:13:31 INFO - mkdir: /builds/slave/test/properties 09:13:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:13:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:13:31 INFO - Contents: 09:13:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:13:32 INFO - Running post-action listener: _resource_record_post_action 09:13:32 INFO - Running post-action listener: set_extra_try_arguments 09:13:32 INFO - ##### 09:13:32 INFO - ##### Finished download-and-extract step (success) 09:13:32 INFO - ##### 09:13:32 INFO - ##### 09:13:32 INFO - ##### Running populate-webroot step. 09:13:32 INFO - ##### 09:13:32 INFO - Running pre-action listener: _resource_record_pre_action 09:13:32 INFO - Running main action method: populate_webroot 09:13:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:13:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:13:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:13:32 INFO - '--tppagecycles', 09:13:32 INFO - '7'], 09:13:32 INFO - 'tests': ['tsvgm']}}, 09:13:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:13:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:13:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:13:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:13:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['damp', 'tps']}, 09:13:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'tests': ['damp', 'tps']}, 09:13:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['dromaeo_dom']}, 09:13:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:13:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['basic_compositor_video']}, 09:13:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:13:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['a11yr', 09:13:32 INFO - 'ts_paint', 09:13:32 INFO - 'tpaint', 09:13:32 INFO - 'sessionrestore', 09:13:32 INFO - 'sessionrestore_no_auto_restore', 09:13:32 INFO - 'tabpaint']}, 09:13:32 INFO - 'other-e10s': {'tests': ['a11yr', 09:13:32 INFO - 'ts_paint', 09:13:32 INFO - 'tpaint', 09:13:32 INFO - 'sessionrestore', 09:13:32 INFO - 'sessionrestore_no_auto_restore', 09:13:32 INFO - 'tabpaint']}, 09:13:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:13:32 INFO - 'ts_paint', 09:13:32 INFO - 'tpaint', 09:13:32 INFO - 'sessionrestore', 09:13:32 INFO - 'sessionrestore_no_auto_restore', 09:13:32 INFO - 'tabpaint']}, 09:13:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:13:32 INFO - 'ts_paint', 09:13:32 INFO - 'tpaint', 09:13:32 INFO - 'sessionrestore', 09:13:32 INFO - 'sessionrestore_no_auto_restore', 09:13:32 INFO - 'tabpaint']}, 09:13:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['a11yr', 09:13:32 INFO - 'ts_paint', 09:13:32 INFO - 'tpaint', 09:13:32 INFO - 'sessionrestore', 09:13:32 INFO - 'sessionrestore_no_auto_restore', 09:13:32 INFO - 'tabpaint']}, 09:13:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['a11yr', 09:13:32 INFO - 'ts_paint', 09:13:32 INFO - 'tpaint', 09:13:32 INFO - 'sessionrestore', 09:13:32 INFO - 'sessionrestore_no_auto_restore', 09:13:32 INFO - 'tabpaint']}, 09:13:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['tsvgx', 09:13:32 INFO - 'tsvgr_opacity', 09:13:32 INFO - 'tart', 09:13:32 INFO - 'tscrollx', 09:13:32 INFO - 'cart']}, 09:13:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:13:32 INFO - 'tsvgr_opacity', 09:13:32 INFO - 'tart', 09:13:32 INFO - 'tscrollx', 09:13:32 INFO - 'cart']}, 09:13:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'talos_options': ['--disable-e10s'], 09:13:32 INFO - 'tests': ['tp5o']}, 09:13:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'tests': ['tp5o']}, 09:13:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'talos_options': ['--disable-e10s', 09:13:32 INFO - '--xperf_path', 09:13:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:32 INFO - 'tests': ['tp5n']}, 09:13:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:32 INFO - 'talos_options': ['--xperf_path', 09:13:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:32 INFO - 'tests': ['tp5n']}}, 09:13:32 INFO - 'talos.zip': {'path': '', 09:13:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:13:32 INFO - Running post-action listener: _resource_record_post_action 09:13:32 INFO - ##### 09:13:32 INFO - ##### Finished populate-webroot step (success) 09:13:32 INFO - ##### 09:13:32 INFO - ##### 09:13:32 INFO - ##### Running create-virtualenv step. 09:13:32 INFO - ##### 09:13:32 INFO - Running pre-action listener: _resource_record_pre_action 09:13:32 INFO - Running main action method: create_virtualenv 09:13:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:13:32 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 09:13:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:13:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:13:33 INFO - Using real prefix '/tools/python27' 09:13:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:13:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:36 INFO - Installing pip.................done. 09:13:36 INFO - Return code: 0 09:13:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:36 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 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:36 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 09:13:36 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 09:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:36 INFO - 'HOME': '/Users/cltbld', 09:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:36 INFO - 'LOGNAME': 'cltbld', 09:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:36 INFO - 'MOZ_NO_REMOTE': '1', 09:13:36 INFO - 'NO_EM_RESTART': '1', 09:13:36 INFO - 'PAGER': '/bin/cat', 09:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:36 INFO - 'PWD': '/builds/slave/test', 09:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:36 INFO - 'SHELL': '/bin/bash', 09:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:13:36 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:36 INFO - 'USER': 'cltbld', 09:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:36 INFO - 'XPC_FLAGS': '0x0', 09:13:36 INFO - 'XPC_SERVICE_NAME': '0', 09:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:36 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 09:13:36 INFO - Cleaning up... 09:13:36 INFO - Return code: 0 09:13:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:36 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 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:36 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 09:13:36 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 09:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:36 INFO - 'HOME': '/Users/cltbld', 09:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:36 INFO - 'LOGNAME': 'cltbld', 09:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:36 INFO - 'MOZ_NO_REMOTE': '1', 09:13:36 INFO - 'NO_EM_RESTART': '1', 09:13:36 INFO - 'PAGER': '/bin/cat', 09:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:36 INFO - 'PWD': '/builds/slave/test', 09:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:36 INFO - 'SHELL': '/bin/bash', 09:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:13:36 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:36 INFO - 'USER': 'cltbld', 09:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:36 INFO - 'XPC_FLAGS': '0x0', 09:13:36 INFO - 'XPC_SERVICE_NAME': '0', 09:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:37 INFO - Downloading/unpacking psutil>=3.1.1 09:13:37 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 09:13:37 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 09:13:37 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 09:13:37 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 09:13:37 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 09:13:37 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 09:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:40 INFO - Installing collected packages: psutil 09:13:40 INFO - Running setup.py install for psutil 09:13:40 INFO - building 'psutil._psutil_osx' extension 09:13:40 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 09:13:40 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 09:13:40 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 09:13:40 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 09:13:41 INFO - building 'psutil._psutil_posix' extension 09:13:41 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 09:13:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:13:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:13:41 INFO - ^ 09:13:41 INFO - 1 warning generated. 09:13:41 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 09:13:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:41 INFO - Successfully installed psutil 09:13:41 INFO - Cleaning up... 09:13:41 INFO - Return code: 0 09:13:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:13:41 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')]} 09:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:41 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')]} 09:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:41 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 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:41 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 09:13:41 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 09:13:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:13:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:41 INFO - 'HOME': '/Users/cltbld', 09:13:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:41 INFO - 'LOGNAME': 'cltbld', 09:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:41 INFO - 'MOZ_NO_REMOTE': '1', 09:13:41 INFO - 'NO_EM_RESTART': '1', 09:13:41 INFO - 'PAGER': '/bin/cat', 09:13:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:41 INFO - 'PWD': '/builds/slave/test', 09:13:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:41 INFO - 'SHELL': '/bin/bash', 09:13:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:13:41 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:13:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:41 INFO - 'USER': 'cltbld', 09:13:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:41 INFO - 'XPC_FLAGS': '0x0', 09:13:41 INFO - 'XPC_SERVICE_NAME': '0', 09:13:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:13:41 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 09:13:41 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 09:13:41 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 09:13:41 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 09:13:41 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 09:13:41 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 09:13:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:13:44 INFO - Installing collected packages: mozsystemmonitor 09:13:44 INFO - Running setup.py install for mozsystemmonitor 09:13:44 INFO - Successfully installed mozsystemmonitor 09:13:44 INFO - Cleaning up... 09:13:44 INFO - Return code: 0 09:13:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:13:44 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')]} 09:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:44 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')]} 09:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:44 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 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:44 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 09:13:44 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 09:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:44 INFO - 'HOME': '/Users/cltbld', 09:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:44 INFO - 'LOGNAME': 'cltbld', 09:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:44 INFO - 'MOZ_NO_REMOTE': '1', 09:13:44 INFO - 'NO_EM_RESTART': '1', 09:13:44 INFO - 'PAGER': '/bin/cat', 09:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:44 INFO - 'PWD': '/builds/slave/test', 09:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:44 INFO - 'SHELL': '/bin/bash', 09:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:13:44 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:44 INFO - 'USER': 'cltbld', 09:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:44 INFO - 'XPC_FLAGS': '0x0', 09:13:44 INFO - 'XPC_SERVICE_NAME': '0', 09:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:44 INFO - Downloading/unpacking jsonschema==2.5.1 09:13:44 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 09:13:44 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 09:13:44 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 09:13:44 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 09:13:44 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 09:13:44 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 09:13:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:13:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:13:47 INFO - warning: no files found matching '*.txt' 09:13:47 INFO - no previously-included directories found matching 'build' 09:13:47 INFO - no previously-included directories found matching 'dist' 09:13:47 INFO - no previously-included directories found matching '.git*' 09:13:47 INFO - Installing collected packages: jsonschema, functools32 09:13:47 INFO - Running setup.py install for functools32 09:13:47 INFO - warning: no files found matching '*.txt' 09:13:47 INFO - no previously-included directories found matching 'build' 09:13:47 INFO - no previously-included directories found matching 'dist' 09:13:47 INFO - no previously-included directories found matching '.git*' 09:13:47 INFO - Successfully installed jsonschema functools32 09:13:47 INFO - Cleaning up... 09:13:47 INFO - Return code: 0 09:13:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:13:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:13:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:47 INFO - 'HOME': '/Users/cltbld', 09:13:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:47 INFO - 'LOGNAME': 'cltbld', 09:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:47 INFO - 'MOZ_NO_REMOTE': '1', 09:13:47 INFO - 'NO_EM_RESTART': '1', 09:13:47 INFO - 'PAGER': '/bin/cat', 09:13:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:47 INFO - 'PWD': '/builds/slave/test', 09:13:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:47 INFO - 'SHELL': '/bin/bash', 09:13:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:13:47 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:13:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:47 INFO - 'USER': 'cltbld', 09:13:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:47 INFO - 'XPC_FLAGS': '0x0', 09:13:47 INFO - 'XPC_SERVICE_NAME': '0', 09:13:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:13:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:13:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:13:51 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 09:13:51 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 09:13:51 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 09:13:51 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 09:13:51 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 09:13:51 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 09:13:51 INFO - Downloading docopt-0.6.1.tar.gz 09:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:13:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:13:51 INFO - Running setup.py install for blobuploader 09:13:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:13:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:13:51 INFO - Running setup.py install for requests 09:13:52 INFO - Running setup.py install for docopt 09:13:52 INFO - Successfully installed blobuploader requests docopt 09:13:52 INFO - Cleaning up... 09:13:52 INFO - Return code: 0 09:13:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:52 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 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:52 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 09:13:52 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 09:13:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:13:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:52 INFO - 'HOME': '/Users/cltbld', 09:13:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:52 INFO - 'LOGNAME': 'cltbld', 09:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:52 INFO - 'MOZ_NO_REMOTE': '1', 09:13:52 INFO - 'NO_EM_RESTART': '1', 09:13:52 INFO - 'PAGER': '/bin/cat', 09:13:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:52 INFO - 'PWD': '/builds/slave/test', 09:13:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:52 INFO - 'SHELL': '/bin/bash', 09:13:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:13:52 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:13:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:52 INFO - 'USER': 'cltbld', 09:13:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:52 INFO - 'XPC_FLAGS': '0x0', 09:13:52 INFO - 'XPC_SERVICE_NAME': '0', 09:13:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:52 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-1KO0l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-gonG4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-LKPOI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Ex5EmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-edGnAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-2fAYrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-AS7mi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Ldd2Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-5gISAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-XNPQvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:53 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-HBq6FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-qWSjSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-LGtLSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-DN27A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-LtfuFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-EcG1kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-6Wds6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:13:54 INFO - Running setup.py install for manifestparser 09:13:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:13:54 INFO - Running setup.py install for mozcrash 09:13:54 INFO - Running setup.py install for mozdebug 09:13:55 INFO - Running setup.py install for mozdevice 09:13:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Running setup.py install for mozfile 09:13:55 INFO - Running setup.py install for mozhttpd 09:13:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Running setup.py install for mozinfo 09:13:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Running setup.py install for mozInstall 09:13:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:13:55 INFO - Running setup.py install for mozleak 09:13:56 INFO - Running setup.py install for mozlog 09:13:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:13:56 INFO - Running setup.py install for moznetwork 09:13:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:13:56 INFO - Running setup.py install for mozprocess 09:13:56 INFO - Running setup.py install for mozprofile 09:13:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:13:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:13:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:13:56 INFO - Running setup.py install for mozrunner 09:13:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:13:56 INFO - Running setup.py install for mozscreenshot 09:13:56 INFO - Running setup.py install for moztest 09:13:57 INFO - Running setup.py install for mozversion 09:13:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:13:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:13:57 INFO - Cleaning up... 09:13:57 INFO - Return code: 0 09:13:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:57 INFO - 'HOME': '/Users/cltbld', 09:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:57 INFO - 'LOGNAME': 'cltbld', 09:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:57 INFO - 'MOZ_NO_REMOTE': '1', 09:13:57 INFO - 'NO_EM_RESTART': '1', 09:13:57 INFO - 'PAGER': '/bin/cat', 09:13:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:57 INFO - 'PWD': '/builds/slave/test', 09:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:57 INFO - 'SHELL': '/bin/bash', 09:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:13:57 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:57 INFO - 'USER': 'cltbld', 09:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:57 INFO - 'XPC_FLAGS': '0x0', 09:13:57 INFO - 'XPC_SERVICE_NAME': '0', 09:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-TeQIB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-2PuCkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Itu777-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-AWqQkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:58 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-L9G9GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:58 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-ym_8gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:58 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9IolKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:58 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Sj0dIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:58 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Puj9DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:58 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-NNDyDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:58 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-FRtXZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-IaZoT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-qSMz2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-SZtbN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-IhwfGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:59 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)) 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-eseNH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:59 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)) 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-WfxB3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:59 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)) 09:13:59 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)) 09:13:59 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)) 09:13:59 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)) 09:13:59 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)) 09:13:59 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)) 09:13:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:13:59 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 09:13:59 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 09:13:59 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 09:13:59 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 09:13:59 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 09:13:59 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 09:14:01 INFO - Downloading blessings-1.6.tar.gz 09:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:01 INFO - Installing collected packages: blessings 09:14:01 INFO - Running setup.py install for blessings 09:14:02 INFO - Successfully installed blessings 09:14:02 INFO - Cleaning up... 09:14:02 INFO - Return code: 0 09:14:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:02 INFO - Reading from file tmpfile_stdout 09:14:02 INFO - Current package versions: 09:14:02 INFO - blessings == 1.6 09:14:02 INFO - blobuploader == 1.2.4 09:14:02 INFO - docopt == 0.6.1 09:14:02 INFO - functools32 == 3.2.3-2 09:14:02 INFO - jsonschema == 2.5.1 09:14:02 INFO - manifestparser == 1.1 09:14:02 INFO - mozInstall == 1.12 09:14:02 INFO - mozcrash == 0.17 09:14:02 INFO - mozdebug == 0.1 09:14:02 INFO - mozdevice == 0.48 09:14:02 INFO - mozfile == 1.2 09:14:02 INFO - mozhttpd == 0.7 09:14:02 INFO - mozinfo == 0.9 09:14:02 INFO - mozleak == 0.1 09:14:02 INFO - mozlog == 3.2 09:14:02 INFO - moznetwork == 0.27 09:14:02 INFO - mozprocess == 0.22 09:14:02 INFO - mozprofile == 0.28 09:14:02 INFO - mozrunner == 6.11 09:14:02 INFO - mozscreenshot == 0.1 09:14:02 INFO - mozsystemmonitor == 0.3 09:14:02 INFO - moztest == 0.7 09:14:02 INFO - mozversion == 1.4 09:14:02 INFO - psutil == 3.1.1 09:14:02 INFO - requests == 1.2.3 09:14:02 INFO - wsgiref == 0.1.2 09:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:02 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')]} 09:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:02 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')]} 09:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:02 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 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:14:02 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 09:14:02 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 09:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:02 INFO - 'HOME': '/Users/cltbld', 09:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:02 INFO - 'LOGNAME': 'cltbld', 09:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:02 INFO - 'MOZ_NO_REMOTE': '1', 09:14:02 INFO - 'NO_EM_RESTART': '1', 09:14:02 INFO - 'PAGER': '/bin/cat', 09:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:02 INFO - 'PWD': '/builds/slave/test', 09:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:02 INFO - 'SHELL': '/bin/bash', 09:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:14:02 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:02 INFO - 'USER': 'cltbld', 09:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:02 INFO - 'XPC_FLAGS': '0x0', 09:14:02 INFO - 'XPC_SERVICE_NAME': '0', 09:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 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)) 09:14:02 INFO - Cleaning up... 09:14:02 INFO - Return code: 0 09:14:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:02 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')]} 09:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:02 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')]} 09:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:02 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 0x109505a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc149cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, '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.sPoPWw8c4m/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.SARbA5wM49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 09:14:02 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 09:14:02 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 09:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:02 INFO - 'HOME': '/Users/cltbld', 09:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:02 INFO - 'LOGNAME': 'cltbld', 09:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:02 INFO - 'MOZ_NO_REMOTE': '1', 09:14:02 INFO - 'NO_EM_RESTART': '1', 09:14:02 INFO - 'PAGER': '/bin/cat', 09:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:02 INFO - 'PWD': '/builds/slave/test', 09:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:02 INFO - 'SHELL': '/bin/bash', 09:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:14:02 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:02 INFO - 'USER': 'cltbld', 09:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:02 INFO - 'XPC_FLAGS': '0x0', 09:14:02 INFO - 'XPC_SERVICE_NAME': '0', 09:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:02 INFO - Cleaning up... 09:14:02 INFO - Return code: 0 09:14:02 INFO - Running post-action listener: _resource_record_post_action 09:14:02 INFO - Running post-action listener: _start_resource_monitoring 09:14:03 INFO - Starting resource monitoring. 09:14:03 INFO - ##### 09:14:03 INFO - ##### Finished create-virtualenv step (success) 09:14:03 INFO - ##### 09:14:03 INFO - ##### 09:14:03 INFO - ##### Running install step. 09:14:03 INFO - ##### 09:14:03 INFO - Running pre-action listener: _resource_record_pre_action 09:14:03 INFO - Running main action method: install 09:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:03 INFO - Reading from file tmpfile_stdout 09:14:03 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:03 INFO - Reading from file tmpfile_stdout 09:14:03 INFO - Output received: 09:14:03 INFO - Usage: mozinstall [options] installer 09:14:03 INFO - Options: 09:14:03 INFO - -h, --help show this help message and exit 09:14:03 INFO - -d DEST, --destination=DEST 09:14:03 INFO - Directory to install application into. [default: 09:14:03 INFO - "/builds/slave/test"] 09:14:03 INFO - --app=APP Application being installed. [default: firefox] 09:14:03 INFO - mkdir: /builds/slave/test/build/application 09:14:03 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'] 09:14:03 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 09:14:38 INFO - Reading from file tmpfile_stdout 09:14:38 INFO - Output received: 09:14:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:14:38 INFO - Running post-action listener: _resource_record_post_action 09:14:38 INFO - ##### 09:14:38 INFO - ##### Finished install step (success) 09:14:38 INFO - ##### 09:14:38 INFO - ##### 09:14:38 INFO - ##### Running run-tests step. 09:14:38 INFO - ##### 09:14:38 INFO - Running pre-action listener: _resource_record_pre_action 09:14:38 INFO - Running main action method: run_tests 09:14:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:38 INFO - 2016-07-05 09:14:38.482 screenresolution[1640:7641] starting screenresolution argv=screenresolution get 09:14:38 INFO - 2016-07-05 09:14:38.485 screenresolution[1640:7641] Display 0: 1600x1200x32@60 09:14:38 INFO - 2016-07-05 09:14:38.491 screenresolution[1641:7643] starting screenresolution argv=screenresolution list 09:14:38 INFO - Available Modes on Display 0 09:14:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:38 INFO - Intel Iris: 09:14:38 INFO - Chipset Model: Intel Iris 09:14:38 INFO - Type: GPU 09:14:38 INFO - Bus: Built-In 09:14:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:38 INFO - Vendor: Intel (0x8086) 09:14:38 INFO - Device ID: 0x0a2e 09:14:38 INFO - Revision ID: 0x0009 09:14:38 INFO - Displays: 09:14:38 INFO - Display: 09:14:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:38 INFO - Display Serial Number: 1600x1200 60 09:14:38 INFO - Main Display: Yes 09:14:38 INFO - Mirror: Off 09:14:38 INFO - Online: Yes 09:14:38 INFO - Rotation: Supported 09:14:38 INFO - Return code: 0 09:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:38 INFO - Python 2.7.3 09:14:38 INFO - Return code: 0 09:14:38 INFO - grabbing minidump binary from tooltool 09:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:38 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 0x109469d30>, '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 0x1091cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109461b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:38 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 09:14:38 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 09:14:38 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 09:14:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:38 INFO - Return code: 0 09:14:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:14:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:14:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 09:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0385 --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 09:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sPoPWw8c4m/Render', 09:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:38 INFO - 'HOME': '/Users/cltbld', 09:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:38 INFO - 'LOGNAME': 'cltbld', 09:14:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:38 INFO - 'MOZ_NO_REMOTE': '1', 09:14:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:38 INFO - 'NO_EM_RESTART': '1', 09:14:38 INFO - 'PAGER': '/bin/cat', 09:14:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:38 INFO - 'PWD': '/builds/slave/test', 09:14:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:38 INFO - 'SHELL': '/bin/bash', 09:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SARbA5wM49/Listeners', 09:14:38 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 09:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:38 INFO - 'USER': 'cltbld', 09:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:38 INFO - 'XPC_FLAGS': '0x0', 09:14:38 INFO - 'XPC_SERVICE_NAME': '0', 09:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 09:14:39 INFO - mozversion application_buildid: 20160705070128 09:14:39 INFO - mozversion application_changeset: f47a1bc057ff5a6084e776040425da258a2851ca 09:14:39 INFO - mozversion application_display_name: Nightly 09:14:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:39 INFO - mozversion application_name: Firefox 09:14:39 INFO - mozversion application_remotingname: firefox 09:14:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:14:39 INFO - mozversion application_vendor: Mozilla 09:14:39 INFO - mozversion application_version: 50.0a1 09:14:39 INFO - mozversion platform_buildid: 20160705070128 09:14:39 INFO - mozversion platform_changeset: f47a1bc057ff5a6084e776040425da258a2851ca 09:14:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:14:39 INFO - mozversion platform_version: 50.0a1 09:14:39 INFO - using testdate: 1467735279 09:14:39 INFO - actual date: 1467735279 09:14:39 INFO - starting webserver on 'localhost:49271' 09:14:39 INFO - SUITE-START | Running 2 tests 09:14:39 INFO - TEST-START | dromaeo_css 09:14:39 INFO - operating with platform_type : mac_ 09:14:39 INFO - Initialising browser for dromaeo_css test... 09:14:39 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpKKVn_E/profile http://localhost:49271/getInfo.html) 09:14:42 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 09:14:42 INFO - PROCESS | 1651 | colorDepth:24 09:14:42 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 09:14:42 INFO - PROCESS | 1651 | __metrics 09:14:42 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:14:42 INFO - TEST-INFO | 1651: exit 0 09:14:42 INFO - Browser initialized. 09:14:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:42 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpKKVn_E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:55 INFO - PROCESS | 1654 | RSS: Main: 255848448 09:14:55 INFO - PROCESS | 1654 | 09:15:44 INFO - PROCESS | 1654 | 1467735344766 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] 09:17:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 09:17:56 INFO - PROCESS | 1654 | RSS: Main: 268247040 09:17:56 INFO - PROCESS | 1654 | 09:20:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 09:20:59 INFO - PROCESS | 1654 | RSS: Main: 276586496 09:20:59 INFO - PROCESS | 1654 | 09:24:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 09:24:02 INFO - PROCESS | 1654 | RSS: Main: 281702400 09:24:02 INFO - PROCESS | 1654 | 09:27:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 09:27:04 INFO - PROCESS | 1654 | RSS: Main: 280723456 09:27:04 INFO - PROCESS | 1654 | 09:30:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 09:30:07 INFO - PROCESS | 1654 | RSS: Main: 284413952 09:30:07 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:33:10 INFO - PROCESS | 1654 | RSS: Main: 284155904 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | __start_tp_report 09:33:10 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 09:33:10 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 09:33:10 INFO - PROCESS | 1654 | |i|pagename|runs| 09:33:10 INFO - PROCESS | 1654 | |0;dojo.html;3349.983250083749;3391.3725960697275;3392.830358482077;3405.5232267482543;3418.3163367326533;5348.812791552292;5830.504407125394;5886.440788125121;5892.998190307647;5940.702964851756;4773.737444440554;4920.261960705887;5706.258186435757;5725.742341594628;5885.234919460464;5152.69083854969;5204.947950520503;5271.28837606922;5342.732863356836;5348.518633323;675.5104697772044;4341.891452713676;5252.8161514347;5269.446708095652;5299.947000529984;5224.764885580158;5251.973740131275;5256.632035757499;5263.289455923459;5293.523582877521;3941.862034828796;5163.845084647466;5272.99813035522;5277.788888444457;5320.760565774511;4101.446304748851;4645.976770116128;4752.9305906171185;5241.24002019705;5260.658057226268;4919.7540122993705;5710.2862142232225;5862.355140934494;5913.0539113742025;5965.866634784953;6136.702895113906;6180.381961803829;6228.314885362606;6293.056041593752;6320.051992201161;5118.897622047575;6228.813135605939;6238.812835614939;6248.718807653667;6268.686565671698;5912;5936.584439089265;5945.601529210292;5949.851253718692;5953.255843019622;6222.62664240147;6240.4071613196675;6252.124702541648;6312.873742525124;6331.778387756406;6144.815655530341;6225.252969643581;6237.376262373727;6250.374962503804;6263.060540918898;6214.533909956771;6223.1287619733275;6273.1844860167885;6286.182796236551;6288.685565721696;6116.122740413025;6116.457510225599;6150.138980542728;6168.753249870045;6181.907271390933;6124.655575320006;6129.328227221949;6220.937790622036;6260;6282.842928926813;4958.181899986462;5016.673916195436;5039.0929632666475;5040.143175660147;5047.621428392885;4042.656374208166;4395;4399.38408622793;4414.227510185769;4503.256962601135;5109.591232701375;5505.229267902497;5951.791687290924;6010.128531362928;6029.8191054268445;6269.811905642838;6273.7176827042895;6273.749050038039;6295.811125666238;6298.590591611531;5860.531157507389;5947.316058653224;5972.790952316735;5978.730957106941;6028.758849645965;4612.469565999953;5480.808171713971;5497.587680923947;5507.146392309199;5515.172724091338;5020;6200.56596038273;6230.7819226326865;6428.742850286029;6453.386928241809;6140.933729673127;6164.352742962104;6184.938150618616;6242.250929888442;6251.062340648939;5489.231507589021;6380;6408.839779005562;6443.96778016107;6553.475721942138;6056.66688332146;6143.170671959407;6196.845078873064;6210.378962103753;6223.097650840693;6160.383961603804;6187.938120618736;6238.095476156022;6256.343083976117;6269.623822570478;5216.582673386044;5562.527185189304;5678.602497825278;6164.7842325518395;6230.190075290183;5159.767810448464;6127.647695153045;6164.4143806338325;6223.688815559294;6224.097505861715;4478.619317358061;4560.703554268962;6050.6369617823075;6054.122152287981;6146.969265153824;6153.84615384619;6209.875802484015;6245.28179259391;6249.593776404519;6261.843453913689;5978.880422391615;6067.575269731076;6090.390960903874;6108.541859360477;6122.2959359674205 09:33:10 INFO - PROCESS | 1654 | |1;ext.html;448.9708168969019;482.0816344863036;513.9177731562951;540.678296413634;546.751228191173;39099.804500977494;42056.948576285606;42070;42073.78963105188;42190.15619687604;43007.56992430075;43644.78177609108;43644.78177609108;43711.907202319955;43721.562784372145;9775.511224438786;9951.303408761389;9974.052465015848;9976.600935962553;9991.300608957376;9850.9507452463;9941.602335906591;9945.502724863763;9948.90051099487;9958.352707074053;9913.950430247838;9930.65242716505;9942.304038717293;9959.850602240973;9969.401835889834;9862.802743945116;9903.90096099037;9923.60305587783;9984.301098923079;10002.499875006257;9680.467574283412;9747.853782193273;9757.804843903154;9773.267004974656;9796.95101524495;40888.79555602233;40932.795336023126;41207.1758564827;41243.587564124275;41612;3139.5133754268127;3398.422268214385;3452.430348992413;3460.7468979159507;3569.821508924543;31924.723011079528;32074.518882216784;33205.83397083023;33321.666783332344;33369.6663033369;3326.700596946262;3331.283773988604;3340.3820293245585;3353.2455197580593;3457.4986626939203;478836;482018;486573;492417;493437;70024;70625.2937470629;70930.2906970934;70994.2900570998;71227;37133.25733485315;37454.06364840901;37943;38371.84884453471;75927.4814503718;17268.05025723572;17352.91323543374;17436.738448923275;17482.475525734248;17491.38780142689;10887.455627218607;12054.216475929037;13135.080544361803;13255.867441325656;13298.002649801303;21841.344759657237;21947.890260548596;21966.45083872916;22066.22768203105;22075;8820.426672266281;9195.264378849675;9218.262538996863;9240.445573265626;9248.445093294424;893.3166127912152;900.221308568097;975.673149494913;975.858500517421;1043.8486419469286;27022.864885675837;29849;30820.537691934638;31250.68749312523;31381.52927706086;974.5809302000208;1054.6097943760858;1071.287593750163;1134.2683968840051;1148.0757989818276;15857.762133568005;16114.435994740363;16181.19094045293;16236.918815405847;16408.75386869198;399737;400411;405486;406266.9686651607;718125;59492.70253648704;61534;61706.69146654238;61716;61946.76106477845;1379.296558755042;1380.9585712428643;1382.4401117547409;1400.248511674544;1406.079018243032;26822.195334140008;30288.242793930327;30453.934112305964;30829.845850770602;30921.536176956914;50660;51249.23126153185;51262;51468.74265628648;51558.226626599884;664346;667261;668464;669148;669571;26990.460190796468;27593.86203069052;28301.71698282991;28327.575086374134;28422.573661394683;49871.50128498668;50192.74903625605;50202.49797501978;50501.242481362075;51175.48824511856;34655.48016779801;41493.37759933543;42139;42480;42634.93412664708;34901.8254908734;41174.79412602918;41270.50527385147;41726.79136604298;42354.576454236296;33333.83333083319;39066;40084;40118.598814011486;43372.91567710706;41281.380779287734;42814.57185428106;44230.55769442264;44407.33388999103;45083.32375014312;33136.668633313355;33588.1602959928;33603.159921002174;34316.48525272073;34319 09:33:10 INFO - PROCESS | 1654 | |2;jquery.html;292.9809562378445;373.80562107704;388.14995160598306;406.8331983886607;417.73265110329396;17065;21588.2444114456;22110.22614208503;22391.992360343782;22488.875556222163;17084.402045928397;20564.971751412446;21078.89460552695;22542.43643908903;22579.887100564516;5616.382197958242;5757.798477053304;5932.9406705932815;6045.879082418349;6053.455189032986;3897.1231472918507;5881.882362352771;6031.4270144336215;6086.17836592061;6210.689465526705;6172.7530898764;6208.2239720034995;6211.503079753631;6214.3474935131835;6218.160548325964;6291;6842.521023528305;6843.589384636938;6860.931390686104;6869.313068693165;4718.693284936502;5478.561715062785;5938.435848594377;5969.074793406985;6065.939340606626;12024.69938251542;13365.33173341329;13604.727905441934;13741.931290343584;13800.171989680652;1757.5957529768225;2029.7564292284874;2062.2163577840324;2176.847620666554;2243.338215226512;10187.337823041478;10293.330933489375;10400.843987340197;10498.842517362245;10591.682249532527;1512.122968678164;1661.0451531260446;1756.3589289909091;1764.1091248919213;1789.7382345446429;109003.45498272536;121193.99999999911;121411.39294303561;121906;122440;11404.771904561861;11586.304821710724;11598;11787.528498860122;11798.41007949599;14616.342264598119;14711.264436778118;14762.852371476149;14776.113433194043;14800.851991480164;7383.966244725742;8586.957065214634;8666.913330866611;8762.430442021248;8853.768374543373;8566;8607.913920860836;8643.438176518506;8726.69456569017;8765.780855478664;4553.567411095941;4594.517575654575;4629.259318509023;4691.085238378483;4723.834665786681;1801.4325487471403;1944.8315128631475;3321.8837340692958;3680.117476062726;3836.827342769582;862.3877047296364;908.028409601733;1006.3861044762689;1010.8324884758116;1040.105509262034;21721.891390543264;22136.89315534249;22274.888625556767;22451.43871403228;22588.887055564617;937.9062093790567;971.820213260549;973.153356579766;982.7543114221445;1058.7353161709573;9390.483523406141;11284.717882053013;11509.53961841517;11638.301701897914;11767.293962362286;569190;611131;622317;628334;631957;131399;135664;135853.3207333957;136740;138281;1012.4380968562372;1022.9028242316969;1026.2764750850633;1039.9740006499746;1043.3739756146404;19173.945433001318;19455.054494550997;19463.708044379062;19549.21803127859;19665.60668786645;50114.74942625264;51345.743271283405;52902.470975289754;53423;53783;78973.60513197398;80001;82371.17628823635;83924;92714;7229.277072292939;7480.625968701434;7562.962185189039;7939.6030198491;8411.70559030431;9523.76190595213;13302.800457993331;13525;13694.246816425193;13827.170369777845;11663.300201987908;11676.474558645052;11815.940920295343;11853.170278080797;11897.881021189678;8541.701040463555;11504.424778760862;11702.765944681229;11782;11803.468843902217;5856.472917437451;10654.467276636293;11628.94185529067;11704.765904682028;12083.275003499819;7378.372838308589;7468.3278504934815;7471.40228781707;7475;7566.092068951761;8922.598483068406;10650.89349106499;11005.724856878322;11288.830667540158;11885.76228475443 09:33:10 INFO - PROCESS | 1654 | |3;mootools.html;1388.5140200929675;1565.7494800831862;1620.2708781048532;1777.751114843922;1934.2456441987617;7187.532810367323;8192.877106843387;8402.91597084029;8469.983601967764;8814;8306.335493160548;8455.873161902577;8462.788430289245;8549.829003419927;8555;2060.8253295621466;2077.981788923424;2229.8216142708543;2355.0697474497647;2355.904504405451;2240.204727321802;2337.614293641547;2370.810335173182;2380.0241900820665;2383.7020372453444;2295.598270302699;2297.8391512594126;2304.331743794298;2378.9643155352683;2383.4041489627593;2343.60158773009;2349.5183487385043;2358.917437889683;2364.3616223619697;2370.679958205646;2360.3155085025323;2363.0902102690416;2363.1492662641435;2367.6685264063044;2369.5853225685437;7686.770116781288;8160.714374996906;8549.572521373968;8610.784730381727;8666.52334121623;5205.531502164823;5298.92051619226;5332.120200166968;5341.519263266325;5356.4375740547075;3191.12244132863;3460.7058400036026;3477.3135029510668;3604.4232922732235;3636.7817930923966;1051.2273478992934;1069.6256310291415;1072.9056362510196;1080.508368692243;1084.9945750271197;9087.318451116193;10970.067544258667;11116.610918617891;11270.211085223955;11329.206955513117;4572.9314060289125;4592.724436533818;4751.6436267279405;4804.447488538793;4805.735684537384;9802.705918822447;9821.870484894329;9840.311178217598;9847.310688251753;9847.655332063343;5261.736913154327;5283.577313814885;5288.92066619001;5306.8938621228135;5311.389190243094;4322.330038843984;4658.813647454132;4752.382190315237;4812.398450193726;4838.298446725205;3920.882373528799;3955.802209889494;4007.3788562772816;4018.0356714388336;4053;1279.309173046563;1297.0401902592014;1297.4031945305264;1300.219868079145;1308.4896890212824;942.6135284533445;945.8344789661782;951.2390087929629;954.2652157838564;1001.1290177545436;5889.116632505158;5929.258842644669;5975.25309336333;6022.69886505673;6108.267007959073;440.6342735529503;450.8985478267364;453.9182947069493;456.3155267099351;466.1865045495564;3992.461017762565;4095.467589213443;4156.56356082613;4165.770882601486;4168.18720349535;8291.83416331682;9072.95463522678;9391.765205869771;10072.74818129538;10322.535485903152;10242.027007434282;10254.692359229235;10314.381137131797;10348.223883208639;10406.427646479517;7586.848263034708;7793.64928578204;7950.045994480583;8000.239977202156;8069.9596502018285;5919.82983967964;6033.155358249936;6046.365131661112;6054.3642917493025;6119.3268740437625;9716.271279653913;9727.513624318897;9840.852387214341;9845.507724613884;9881.901180988098;9414.764630884283;9931.453770042717;9935.602575896883;10044;10091.899081009096;6934.514583979073;7249.093863267091;7399.186089530255;7596.582187979714;7629.847403051797;8287.709930152416;8388.454750441202;8432.70485533028;8454.83090338202;8468.407211495136;7290.854182916418;7427.925720742724;7465.186580107947;7471.701131954661;7480;7226.566406015656;7238.203797582157;7302.868055451414;7339.926600733925;7409.37020353276;7013.123359580052;7034.5427547209265;7040.3663670269925;7058.435325173871;7073.717051318095;4938.975305123451;4953.281774142802;5109.514596113363;5120.820771272987;5146.408163061295;5086.54221120101;5162.09663308927;5184.092783762751;5184.7926082956255;5252.343457067866 09:33:10 INFO - PROCESS | 1654 | |4;prototype.html;311.6011505273251;317.10259964301025;322.56936989119527;329.231245042825;329.57155697593123;4693.967327188022;5458.372287186975;5656.236408084907;5685.971570142148;5751.597388182824;4527.68306218564;5678.971605141968;5703.77184912604;5777.797777077803;5779.942200577993;3746.063484128968;4196.3705444183315;4302.182585308797;4308;4312.547182545834;3739.457778622098;4154.43915071466;4250.57494250574;4314.1156063007165;4315.309550471925;3727.366347720894;4184.267753143203;4220;4243.936340954888;4248.490181178263;4220.092680073799;4255.191513612419;4272.209641216354;4277.6791740619265;4279.0799978004725;3380.4253276942977;3440.8645147101397;3670.1558641512333;3692.51997240357;3710.6456143507426;4551.431071116111;5095.8980820383385;5156.484351564851;5460.945390546083;5522.2544956431175;4474.574915383034;4829.106615276185;4872.65891387603;4892.559669629751;4917.60659147271;5391.519900845616;5397.54120899724;5523.861903452445;6001.879962400728;6084.756609735649;3403.8808641697424;3552.342816578941;3991.44119823225;4048.178319756092;4055.634992850628;5203.791848326063;5227.320448341691;6161.075838624198;6234.438900498977;6250.468710159642;3115.12776422602;3609.3322735294055;3649.9635003650155;4095.5699651536756;4127.380892866094;3194.872205111816;4141.668666506672;4149.170165966759;4197.706160568731;4217.40956266123;4820.637887435131;4880.853574392774;4887.189865827164;4894.290327902434;4895.730734809548;5817.7091145442555;6050.122732203894;6092;6092.8781424372155;6106.267247930276;1194.5580135349976;1262.9391311298552;1372.512757970906;1386.7503849307222;1404.3469786549304;834.5493433545938;837.6816809612309;863.447393668053;864.2826454043129;873.4497266721925;3976.681865450757;4691.7184968901975;4712.198926182557;4734.431868175772;4779.761011949388;4635.824460244743;4688.695234809727;4865.635077369211;4911.312416261726;4995;4134.077653890955;4182.623563879205;4242.257604919127;4477.395551600493;4743.952560474351;2496.95006099877;2547.5159719653207;2761.762971992692;2766.958495622567;2789.302674331417;4900.531298685701;5208.73956302191;5385.192221166778;5405.675559509448;5445.576718360371;4395.7362558246605;4526.456825181;4617.561331673485;5324.92012619811;5351.866203344947;4294.957050429518;4715.151272770866;5164.586833053347;5362.168863826113;5411.350637923474;4693.389859318267;4775.922473723941;5013.3205376199385;5258.553022992935;5265.763040663102;4803.951960480351;4891.95108048915;4951.183054795918;4991.926735751831;5642.576806739593;5474.151506516497;6120.510359171167;6294.874102517832;6429.517786165963;6445.548811583144;4039.91920161601;4055.4994651978955;4058.1883623276053;4079.306517891906;4098.815553300049;5936.308152176609;6025.819225423069;6259.655718935503;6291.685415729286;6313.40022697843;5817.8364327133895;5843.357230704534;5861.824145275648;5927.673977931083;6055.485283750931;5329.626926115135;6024.939750602438;6037.275526936795;6065.7261974983985;6091.360407157362;4768.57082862544;4881.633877459134;5921.17103605487;5934.47784691513;6005.39946005396;5285.207218917193;5334.853006603599;5570;5632.493075623213;6075.11671381873;4365.148795984753;5088.524327944854;5673.205751194753;5895.7052147393315;5946.167536544974 09:33:10 INFO - PROCESS | 1654 | |5;yui.html;768.4390395011642;782.6751897962349;813.8738495533187;838.1450920061537;895.3195571365765;15205.695886082272;15396.384144634229;15834.920825395871;15872.365105395771;15877.841221587794;14199.645008874782;14308.499202527888;14364.92817535911;14679.926600366984;14710.85289147111;661.3485716569176;892.2059367163246;913.7121806630923;919.2554031234688;921.87554680118;896.5696465696469;931.3434029009566;932.0912110692088;938.1462868789403;938.5448057692014;932.2169377722745;977.7457860956167;983.7835676151271;985.7141428985585;986.763176837561;979.5396163803001;981.7300242433316;981.9410835349902;983.4738414947968;984.990150098497;685.4858855858106;687.9793606191772;703.8627467643812;715.8353578676881;733.7505248215632;12422.627321180378;12772;15368.846311536965;15373.769393459108;15381.615459613487;12562.81155782664;14904.850951490564;14956.027858189183;14960.775588366183;15255.160966146857;11976.341301228429;12249.693757656041;12475.126741128124;12505.937470312681;12606.604745098402;3426.3489936911906;3750.912235451716;3888.0862997195636;4033.1530378620523;4119.134981653856;82305;101176;113638;114699;114971;11502.654920352403;11541.36522491271;11681.474333654836;11836.822447663291;12184;24206;24247.7575224249;24304.906279217477;24321.39196520066;24349.26952191437;8141.267285944294;8208.794780130545;8294.212049855374;8424.157584241526;8480.660773568989;4527.275635898306;4554.407926969539;4606.608438282717;4616.746078965622;4633.027064316464;3415.9146021349666;3525.4006818840858;3528.135606776305;3540.752147349661;3545.5745310562897;635.7647670361996;640.5612155673379;641.1920979565781;641.9422251997343;652.3606865271965;608.8143116349468;673.9258681545026;693.9548929319578;695.9234484206734;701.214639603637;9061.456312621263;9109.134632209929;9387.765305867408;9547.188488978376;9632.855507167398;589.8436914217735;614.4623454477332;635.4662083849588;657.2605818454239;702.9648517574203;4568.474625418053;4661.417322834645;4703.247480403187;4734.360861283682;4795.592374648194;141675;144336;149266;153149;154222.2288888571;107828;113857;125123;125222;126537;70849;92896;115421.42289288668;115643;122677;7489.101307843093;9729.70810875675;9999.800004000024;10048.69853904384;10275.486225688535;53277;61979.690101549204;62236;63438.682806585675;64524.354756453715;88721;95188;97602.02397976213;98425.50787246018;99974;13332.066755327034;13393.464261429433;13744.793828092786;13877.167369957835;14014.719705606034;15071.773923391378;15098.245087745789;15429;15430.30563624662;15771.290291937119;13813.930930345285;13844.515441959484;13913.58259252224;14261.71476570442;14290.499832505813;13848.09987350819;14036.859631403555;14238.932080094242;14362.856371436152;14521.346539405964;13780.586582402544;13797.241151736349;13816.447342106203;13818.963577731509;14085.577432677037;11135.498902549567;11507.827382589101;11810.468528916048;11859.644210673694;11889.82165267539;10708.320661305459;10745.785084298113;11626.128040397174;11818.231814932002;11883.940580297043 09:33:10 INFO - PROCESS | 1654 | __end_tp_report 09:33:10 INFO - PROCESS | 1654 | __start_cc_report 09:33:10 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,442 09:33:10 INFO - PROCESS | 1654 | __end_cc_report 09:33:10 INFO - PROCESS | 1654 | __startTimestamp1467736390901__endTimestamp 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | ------- Summary: start ------- 09:33:10 INFO - PROCESS | 1654 | Number of tests: 6 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5669.63 Median:6028.76 stddev:813.75 (13.5%) stddev-sans-first:795.64 09:33:10 INFO - PROCESS | 1654 | Values: 3350.0 3391.4 3392.8 3405.5 3418.3 5348.8 5830.5 5886.4 5893.0 5940.7 4773.7 4920.3 5706.3 5725.7 5885.2 5152.7 5204.9 5271.3 5342.7 5348.5 675.5 4341.9 5252.8 5269.4 5299.9 5224.8 5252.0 5256.6 5263.3 5293.5 3941.9 5163.8 5273.0 5277.8 5320.8 4101.4 4646.0 4752.9 5241.2 5260.7 4919.8 5710.3 5862.4 5913.1 5965.9 6136.7 6180.4 6228.3 6293.1 6320.1 5118.9 6228.8 6238.8 6248.7 6268.7 5912.0 5936.6 5945.6 5949.9 5953.3 6222.6 6240.4 6252.1 6312.9 6331.8 6144.8 6225.3 6237.4 6250.4 6263.1 6214.5 6223.1 6273.2 6286.2 6288.7 6116.1 6116.5 6150.1 6168.8 6181.9 6124.7 6129.3 6220.9 6260.0 6282.8 4958.2 5016.7 5039.1 5040.1 5047.6 4042.7 4395.0 4399.4 4414.2 4503.3 5109.6 5505.2 5951.8 6010.1 6029.8 6269.8 6273.7 6273.7 6295.8 6298.6 5860.5 5947.3 5972.8 5978.7 6028.8 4612.5 5480.8 5497.6 5507.1 5515.2 5020.0 6200.6 6230.8 6428.7 6453.4 6140.9 6164.4 6184.9 6242.3 6251.1 5489.2 6380.0 6408.8 6444.0 6553.5 6056.7 6143.2 6196.8 6210.4 6223.1 6160.4 6187.9 6238.1 6256.3 6269.6 5216.6 5562.5 5678.6 6164.8 6230.2 5159.8 6127.6 6164.4 6223.7 6224.1 4478.6 4560.7 6050.6 6054.1 6147.0 6153.8 6209.9 6245.3 6249.6 6261.8 5978.9 6067.6 6090.4 6108.5 6122.3 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:68923.11 Median:41891.87 stddev:147577.79 (352.3%) stddev-sans-first:147902.23 09:33:10 INFO - PROCESS | 1654 | Values: 449.0 482.1 513.9 540.7 546.8 39099.8 42056.9 42070.0 42073.8 42190.2 43007.6 43644.8 43644.8 43711.9 43721.6 9775.5 9951.3 9974.1 9976.6 9991.3 9851.0 9941.6 9945.5 9948.9 9958.4 9914.0 9930.7 9942.3 9959.9 9969.4 9862.8 9903.9 9923.6 9984.3 10002.5 9680.5 9747.9 9757.8 9773.3 9797.0 40888.8 40932.8 41207.2 41243.6 41612.0 3139.5 3398.4 3452.4 3460.7 3569.8 31924.7 32074.5 33205.8 33321.7 33369.7 3326.7 3331.3 3340.4 3353.2 3457.5 478836.0 482018.0 486573.0 492417.0 493437.0 70024.0 70625.3 70930.3 70994.3 71227.0 37133.3 37454.1 37943.0 38371.8 75927.5 17268.1 17352.9 17436.7 17482.5 17491.4 10887.5 12054.2 13135.1 13255.9 13298.0 21841.3 21947.9 21966.5 22066.2 22075.0 8820.4 9195.3 9218.3 9240.4 9248.4 893.3 900.2 975.7 975.9 1043.8 27022.9 29849.0 30820.5 31250.7 31381.5 974.6 1054.6 1071.3 1134.3 1148.1 15857.8 16114.4 16181.2 16236.9 16408.8 399737.0 400411.0 405486.0 406267.0 718125.0 59492.7 61534.0 61706.7 61716.0 61946.8 1379.3 1381.0 1382.4 1400.2 1406.1 26822.2 30288.2 30453.9 30829.8 30921.5 50660.0 51249.2 51262.0 51468.7 51558.2 664346.0 667261.0 668464.0 669148.0 669571.0 26990.5 27593.9 28301.7 28327.6 28422.6 49871.5 50192.7 50202.5 50501.2 51175.5 34655.5 41493.4 42139.0 42480.0 42634.9 34901.8 41174.8 41270.5 41726.8 42354.6 33333.8 39066.0 40084.0 40118.6 43372.9 41281.4 42814.6 44230.6 44407.3 45083.3 33136.7 33588.2 33603.2 34316.5 34319.0 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35607.55 Median:12347.39 stddev:102507.27 (830.2%) stddev-sans-first:102760.53 09:33:10 INFO - PROCESS | 1654 | Values: 293.0 373.8 388.1 406.8 417.7 17065.0 21588.2 22110.2 22392.0 22488.9 17084.4 20565.0 21078.9 22542.4 22579.9 5616.4 5757.8 5932.9 6045.9 6053.5 3897.1 5881.9 6031.4 6086.2 6210.7 6172.8 6208.2 6211.5 6214.3 6218.2 6291.0 6842.5 6843.6 6860.9 6869.3 4718.7 5478.6 5938.4 5969.1 6065.9 12024.7 13365.3 13604.7 13741.9 13800.2 1757.6 2029.8 2062.2 2176.8 2243.3 10187.3 10293.3 10400.8 10498.8 10591.7 1512.1 1661.0 1756.4 1764.1 1789.7 109003.5 121194.0 121411.4 121906.0 122440.0 11404.8 11586.3 11598.0 11787.5 11798.4 14616.3 14711.3 14762.9 14776.1 14800.9 7384.0 8587.0 8666.9 8762.4 8853.8 8566.0 8607.9 8643.4 8726.7 8765.8 4553.6 4594.5 4629.3 4691.1 4723.8 1801.4 1944.8 3321.9 3680.1 3836.8 862.4 908.0 1006.4 1010.8 1040.1 21721.9 22136.9 22274.9 22451.4 22588.9 937.9 971.8 973.2 982.8 1058.7 9390.5 11284.7 11509.5 11638.3 11767.3 569190.0 611131.0 622317.0 628334.0 631957.0 131399.0 135664.0 135853.3 136740.0 138281.0 1012.4 1022.9 1026.3 1040.0 1043.4 19173.9 19455.1 19463.7 19549.2 19665.6 50114.7 51345.7 52902.5 53423.0 53783.0 78973.6 80001.0 82371.2 83924.0 92714.0 7229.3 7480.6 7563.0 7939.6 8411.7 9523.8 13302.8 13525.0 13694.2 13827.2 11663.3 11676.5 11815.9 11853.2 11897.9 8541.7 11504.4 11702.8 11782.0 11803.5 5856.5 10654.5 11628.9 11704.8 12083.3 7378.4 7468.3 7471.4 7475.0 7566.1 8922.6 10650.9 11005.7 11288.8 11885.8 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5592.00 Median:5173.09 stddev:3057.64 (59.1%) stddev-sans-first:3049.89 09:33:10 INFO - PROCESS | 1654 | Values: 1388.5 1565.7 1620.3 1777.8 1934.2 7187.5 8192.9 8402.9 8470.0 8814.0 8306.3 8455.9 8462.8 8549.8 8555.0 2060.8 2078.0 2229.8 2355.1 2355.9 2240.2 2337.6 2370.8 2380.0 2383.7 2295.6 2297.8 2304.3 2379.0 2383.4 2343.6 2349.5 2358.9 2364.4 2370.7 2360.3 2363.1 2363.1 2367.7 2369.6 7686.8 8160.7 8549.6 8610.8 8666.5 5205.5 5298.9 5332.1 5341.5 5356.4 3191.1 3460.7 3477.3 3604.4 3636.8 1051.2 1069.6 1072.9 1080.5 1085.0 9087.3 10970.1 11116.6 11270.2 11329.2 4572.9 4592.7 4751.6 4804.4 4805.7 9802.7 9821.9 9840.3 9847.3 9847.7 5261.7 5283.6 5288.9 5306.9 5311.4 4322.3 4658.8 4752.4 4812.4 4838.3 3920.9 3955.8 4007.4 4018.0 4053.0 1279.3 1297.0 1297.4 1300.2 1308.5 942.6 945.8 951.2 954.3 1001.1 5889.1 5929.3 5975.3 6022.7 6108.3 440.6 450.9 453.9 456.3 466.2 3992.5 4095.5 4156.6 4165.8 4168.2 8291.8 9073.0 9391.8 10072.7 10322.5 10242.0 10254.7 10314.4 10348.2 10406.4 7586.8 7793.6 7950.0 8000.2 8070.0 5919.8 6033.2 6046.4 6054.4 6119.3 9716.3 9727.5 9840.9 9845.5 9881.9 9414.8 9931.5 9935.6 10044.0 10091.9 6934.5 7249.1 7399.2 7596.6 7629.8 8287.7 8388.5 8432.7 8454.8 8468.4 7290.9 7427.9 7465.2 7471.7 7480.0 7226.6 7238.2 7302.9 7339.9 7409.4 7013.1 7034.5 7040.4 7058.4 7073.7 4939.0 4953.3 5109.5 5120.8 5146.4 5086.5 5162.1 5184.1 5184.8 5252.3 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4551.71 Median:4881.24 stddev:1418.96 (29.1%) stddev-sans-first:1386.79 09:33:10 INFO - PROCESS | 1654 | Values: 311.6 317.1 322.6 329.2 329.6 4694.0 5458.4 5656.2 5686.0 5751.6 4527.7 5679.0 5703.8 5777.8 5779.9 3746.1 4196.4 4302.2 4308.0 4312.5 3739.5 4154.4 4250.6 4314.1 4315.3 3727.4 4184.3 4220.0 4243.9 4248.5 4220.1 4255.2 4272.2 4277.7 4279.1 3380.4 3440.9 3670.2 3692.5 3710.6 4551.4 5095.9 5156.5 5460.9 5522.3 4474.6 4829.1 4872.7 4892.6 4917.6 5391.5 5397.5 5523.9 6001.9 6084.8 3403.9 3552.3 3991.4 4048.2 4055.6 5203.8 5227.3 6161.1 6234.4 6250.5 3115.1 3609.3 3650.0 4095.6 4127.4 3194.9 4141.7 4149.2 4197.7 4217.4 4820.6 4880.9 4887.2 4894.3 4895.7 5817.7 6050.1 6092.0 6092.9 6106.3 1194.6 1262.9 1372.5 1386.8 1404.3 834.5 837.7 863.4 864.3 873.4 3976.7 4691.7 4712.2 4734.4 4779.8 4635.8 4688.7 4865.6 4911.3 4995.0 4134.1 4182.6 4242.3 4477.4 4744.0 2497.0 2547.5 2761.8 2767.0 2789.3 4900.5 5208.7 5385.2 5405.7 5445.6 4395.7 4526.5 4617.6 5324.9 5351.9 4295.0 4715.2 5164.6 5362.2 5411.4 4693.4 4775.9 5013.3 5258.6 5265.8 4804.0 4892.0 4951.2 4991.9 5642.6 5474.2 6120.5 6294.9 6429.5 6445.5 4039.9 4055.5 4058.2 4079.3 4098.8 5936.3 6025.8 6259.7 6291.7 6313.4 5817.8 5843.4 5861.8 5927.7 6055.5 5329.6 6024.9 6037.3 6065.7 6091.4 4768.6 4881.6 5921.2 5934.5 6005.4 5285.2 5334.9 5570.0 5632.5 6075.1 4365.1 5088.5 5673.2 5895.7 5946.2 09:33:10 INFO - PROCESS | 1654 | 09:33:10 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24627.64 Median:3475.87 stddev:38587.83 (1110.2%) stddev-sans-first:38654.50 09:33:10 INFO - PROCESS | 1654 | Values: 768.4 782.7 813.9 838.1 895.3 15205.7 15396.4 15834.9 15872.4 15877.8 14199.6 14308.5 14364.9 14679.9 14710.9 661.3 892.2 913.7 919.3 921.9 896.6 931.3 932.1 938.1 938.5 932.2 977.7 983.8 985.7 986.8 979.5 981.7 981.9 983.5 985.0 685.5 688.0 703.9 715.8 733.8 12422.6 12772.0 15368.8 15373.8 15381.6 12562.8 14904.9 14956.0 14960.8 15255.2 11976.3 12249.7 12475.1 12505.9 12606.6 3426.3 3750.9 3888.1 4033.2 4119.1 82305.0 101176.0 113638.0 114699.0 114971.0 11502.7 11541.4 11681.5 11836.8 12184.0 24206.0 24247.8 24304.9 24321.4 24349.3 8141.3 8208.8 8294.2 8424.2 8480.7 4527.3 4554.4 4606.6 4616.7 4633.0 3415.9 3525.4 3528.1 3540.8 3545.6 635.8 640.6 641.2 641.9 652.4 608.8 673.9 694.0 695.9 701.2 9061.5 9109.1 9387.8 9547.2 9632.9 589.8 614.5 635.5 657.3 703.0 4568.5 4661.4 4703.2 4734.4 4795.6 141675.0 144336.0 149266.0 153149.0 154222.2 107828.0 113857.0 125123.0 125222.0 126537.0 70849.0 92896.0 115421.4 115643.0 122677.0 7489.1 9729.7 9999.8 10048.7 10275.5 53277.0 61979.7 62236.0 63438.7 64524.4 88721.0 95188.0 97602.0 98425.5 99974.0 13332.1 13393.5 13744.8 13877.2 14014.7 15071.8 15098.2 15429.0 15430.3 15771.3 13813.9 13844.5 13913.6 14261.7 14290.5 13848.1 14036.9 14238.9 14362.9 14521.3 13780.6 13797.2 13816.4 13819.0 14085.6 11135.5 11507.8 11810.5 11859.6 11889.8 10708.3 10745.8 11626.1 11818.2 11883.9 09:33:10 INFO - PROCESS | 1654 | -------- Summary: end -------- 09:33:10 INFO - PROCESS | 1654 | 09:33:11 INFO - TEST-INFO | 1654: exit 0 09:33:11 INFO - TEST-OK | dromaeo_css | took 1112403ms 09:33:11 INFO - TEST-START | kraken 09:33:11 INFO - operating with platform_type : mac_ 09:33:11 INFO - Initialising browser for kraken test... 09:33:11 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpfPDlrz/profile http://localhost:49271/getInfo.html) 09:33:14 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 09:33:14 INFO - PROCESS | 1663 | colorDepth:24 09:33:14 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 09:33:14 INFO - PROCESS | 1663 | __metrics 09:33:14 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:33:15 INFO - TEST-INFO | 1663: exit 0 09:33:15 INFO - Browser initialized. 09:33:15 INFO - Running cycle 1/1 for kraken test... 09:33:15 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpfPDlrz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:27 INFO - PROCESS | 1665 | RSS: Main: 256188416 09:33:27 INFO - PROCESS | 1665 | 09:33:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:30 INFO - PROCESS | 1665 | RSS: Main: 269344768 09:33:30 INFO - PROCESS | 1665 | 09:33:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:33:33 INFO - PROCESS | 1665 | RSS: Main: 272941056 09:33:33 INFO - PROCESS | 1665 | 09:33:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:33:38 INFO - PROCESS | 1665 | RSS: Main: 273231872 09:33:38 INFO - PROCESS | 1665 | 09:33:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:33:40 INFO - PROCESS | 1665 | RSS: Main: 274137088 09:33:40 INFO - PROCESS | 1665 | 09:33:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:43 INFO - PROCESS | 1665 | RSS: Main: 274800640 09:33:43 INFO - PROCESS | 1665 | 09:33:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:47 INFO - PROCESS | 1665 | RSS: Main: 275660800 09:33:47 INFO - PROCESS | 1665 | 09:33:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:50 INFO - PROCESS | 1665 | RSS: Main: 275927040 09:33:50 INFO - PROCESS | 1665 | 09:33:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:33:54 INFO - PROCESS | 1665 | RSS: Main: 276111360 09:33:54 INFO - PROCESS | 1665 | 09:33:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:33:56 INFO - PROCESS | 1665 | RSS: Main: 275304448 09:33:56 INFO - PROCESS | 1665 | 09:33:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:33:59 INFO - PROCESS | 1665 | RSS: Main: 275308544 09:33:59 INFO - PROCESS | 1665 | 09:34:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:02 INFO - PROCESS | 1665 | RSS: Main: 275697664 09:34:02 INFO - PROCESS | 1665 | 09:34:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:05 INFO - PROCESS | 1665 | RSS: Main: 275820544 09:34:05 INFO - PROCESS | 1665 | 09:34:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:09 INFO - PROCESS | 1665 | RSS: Main: 275959808 09:34:09 INFO - PROCESS | 1665 | 09:34:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:34:11 INFO - PROCESS | 1665 | RSS: Main: 276979712 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | __start_tp_report 09:34:11 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 09:34:11 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 09:34:11 INFO - PROCESS | 1665 | |i|pagename|runs| 09:34:11 INFO - PROCESS | 1665 | |0;ai-astar;102;116;107;116;117;119;113;116;117;132 09:34:11 INFO - PROCESS | 1665 | |1;audio-beat-detection;148;108;123;143;125;160;158;98;154;125 09:34:11 INFO - PROCESS | 1665 | |2;audio-dft;196;191;211;177;268;239;243;287;247;200 09:34:11 INFO - PROCESS | 1665 | |3;audio-fft;67;83;77;147;57;60;67;85;156;80 09:34:11 INFO - PROCESS | 1665 | |4;audio-oscillator;71;71;118;72;71;90;114;69;76;143 09:34:11 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;89;82;89;86;90;73;117;131;96;130 09:34:11 INFO - PROCESS | 1665 | |6;imaging-darkroom;95;95;96;113;148;95;96;99;147;150 09:34:11 INFO - PROCESS | 1665 | |7;imaging-desaturate;92;96;77;79;145;94;144;142;113;90 09:34:11 INFO - PROCESS | 1665 | |8;json-parse-financial;56;56;55;55;57;59;55;58;57;56 09:34:11 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;83;102;76;72;81;80;75;73;73;75 09:34:11 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;86;97;111;104;106;95;89;84;82;83 09:34:11 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;148;137;125;148;159;141;145;128;168;151 09:34:11 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;164;168;165;161;167;163;169;166;163;166 09:34:11 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;71;70;83;86;86;69;72;76;83;92 09:34:11 INFO - PROCESS | 1665 | __end_tp_report 09:34:11 INFO - PROCESS | 1665 | __start_cc_report 09:34:11 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1104 09:34:11 INFO - PROCESS | 1665 | __end_cc_report 09:34:11 INFO - PROCESS | 1665 | __startTimestamp1467736451156__endTimestamp 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | ------- Summary: start ------- 09:34:11 INFO - PROCESS | 1665 | Number of tests: 14 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:7.82 (6.7%) stddev-sans-first:6.60 09:34:11 INFO - PROCESS | 1665 | Values: 102.0 116.0 107.0 116.0 117.0 119.0 113.0 116.0 117.0 132.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:151.00 stddev:21.56 (14.3%) stddev-sans-first:22.28 09:34:11 INFO - PROCESS | 1665 | Values: 148.0 108.0 123.0 143.0 125.0 160.0 158.0 98.0 154.0 125.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:225.90 Median:241.00 stddev:36.23 (15.0%) stddev-sans-first:36.77 09:34:11 INFO - PROCESS | 1665 | Values: 196.0 191.0 211.0 177.0 268.0 239.0 243.0 287.0 247.0 200.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:87.90 Median:72.00 stddev:34.88 (48.4%) stddev-sans-first:36.17 09:34:11 INFO - PROCESS | 1665 | Values: 67.0 83.0 77.0 147.0 57.0 60.0 67.0 85.0 156.0 80.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:71.00 stddev:26.27 (37.0%) stddev-sans-first:27.00 09:34:11 INFO - PROCESS | 1665 | Values: 71.0 71.0 118.0 72.0 71.0 90.0 114.0 69.0 76.0 143.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:87.50 stddev:20.35 (23.3%) stddev-sans-first:21.31 09:34:11 INFO - PROCESS | 1665 | Values: 89.0 82.0 89.0 86.0 90.0 73.0 117.0 131.0 96.0 130.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:95.00 stddev:24.71 (26.0%) stddev-sans-first:25.29 09:34:11 INFO - PROCESS | 1665 | Values: 95.0 95.0 96.0 113.0 148.0 95.0 96.0 99.0 147.0 150.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:107.20 Median:84.50 stddev:27.00 (32.0%) stddev-sans-first:28.07 09:34:11 INFO - PROCESS | 1665 | Values: 92.0 96.0 77.0 79.0 145.0 94.0 144.0 142.0 113.0 90.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.35 (2.4%) stddev-sans-first:1.42 09:34:11 INFO - PROCESS | 1665 | Values: 56.0 56.0 55.0 55.0 57.0 59.0 55.0 58.0 57.0 56.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:79.00 Median:75.50 stddev:8.89 (11.8%) stddev-sans-first:9.32 09:34:11 INFO - PROCESS | 1665 | Values: 83.0 102.0 76.0 72.0 81.0 80.0 75.0 73.0 73.0 75.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:85.00 stddev:10.52 (12.4%) stddev-sans-first:10.78 09:34:11 INFO - PROCESS | 1665 | Values: 86.0 97.0 111.0 104.0 106.0 95.0 89.0 84.0 82.0 83.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:148.00 stddev:13.11 (8.9%) stddev-sans-first:13.87 09:34:11 INFO - PROCESS | 1665 | Values: 148.0 137.0 125.0 148.0 159.0 141.0 145.0 128.0 168.0 151.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.00 stddev:2.49 (1.5%) stddev-sans-first:2.60 09:34:11 INFO - PROCESS | 1665 | Values: 164.0 168.0 165.0 161.0 167.0 163.0 169.0 166.0 163.0 166.0 09:34:11 INFO - PROCESS | 1665 | 09:34:11 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:83.00 stddev:8.18 (9.9%) stddev-sans-first:8.17 09:34:11 INFO - PROCESS | 1665 | Values: 71.0 70.0 83.0 86.0 86.0 69.0 72.0 76.0 83.0 92.0 09:34:11 INFO - PROCESS | 1665 | -------- Summary: end -------- 09:34:11 INFO - PROCESS | 1665 | 09:34:12 INFO - TEST-INFO | 1665: exit 0 09:34:12 INFO - TEST-OK | kraken | took 60642ms 09:34:12 INFO - SUITE-END | took 1173s 09:34:12 INFO - Completed test suite (00:19:33) 09:34:12 INFO - javascript benchmark 09:34:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7403.586765395516, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.983250083749, 3391.3725960697275, 3392.830358482077, 3405.5232267482543, 3418.3163367326533, 5348.812791552292, 5830.504407125394, 5886.440788125121, 5892.998190307647, 5940.702964851756, 4773.737444440554, 4920.261960705887, 5706.258186435757, 5725.742341594628, 5885.234919460464, 5152.69083854969, 5204.947950520503, 5271.28837606922, 5342.732863356836, 5348.518633323, 675.5104697772044, 4341.891452713676, 5252.8161514347, 5269.446708095652, 5299.947000529984, 5224.764885580158, 5251.973740131275, 5256.632035757499, 5263.289455923459, 5293.523582877521, 3941.862034828796, 5163.845084647466, 5272.99813035522, 5277.788888444457, 5320.760565774511, 4101.446304748851, 4645.976770116128, 4752.9305906171185, 5241.24002019705, 5260.658057226268, 4919.7540122993705, 5710.2862142232225, 5862.355140934494, 5913.0539113742025, 5965.866634784953, 6136.702895113906, 6180.381961803829, 6228.314885362606, 6293.056041593752, 6320.051992201161, 5118.897622047575, 6228.813135605939, 6238.812835614939, 6248.718807653667, 6268.686565671698, 5912.0, 5936.584439089265, 5945.601529210292, 5949.851253718692, 5953.255843019622, 6222.62664240147, 6240.4071613196675, 6252.124702541648, 6312.873742525124, 6331.778387756406, 6144.815655530341, 6225.252969643581, 6237.376262373727, 6250.374962503804, 6263.060540918898, 6214.533909956771, 6223.1287619733275, 6273.1844860167885, 6286.182796236551, 6288.685565721696, 6116.122740413025, 6116.457510225599, 6150.138980542728, 6168.753249870045, 6181.907271390933, 6124.655575320006, 6129.328227221949, 6220.937790622036, 6260.0, 6282.842928926813, 4958.181899986462, 5016.673916195436, 5039.0929632666475, 5040.143175660147, 5047.621428392885, 4042.656374208166, 4395.0, 4399.38408622793, 4414.227510185769, 4503.256962601135, 5109.591232701375, 5505.229267902497, 5951.791687290924, 6010.128531362928, 6029.8191054268445, 6269.811905642838, 6273.7176827042895, 6273.749050038039, 6295.811125666238, 6298.590591611531, 5860.531157507389, 5947.316058653224, 5972.790952316735, 5978.730957106941, 6028.758849645965, 4612.469565999953, 5480.808171713971, 5497.587680923947, 5507.146392309199, 5515.172724091338, 5020.0, 6200.56596038273, 6230.7819226326865, 6428.742850286029, 6453.386928241809, 6140.933729673127, 6164.352742962104, 6184.938150618616, 6242.250929888442, 6251.062340648939, 5489.231507589021, 6380.0, 6408.839779005562, 6443.96778016107, 6553.475721942138, 6056.66688332146, 6143.170671959407, 6196.845078873064, 6210.378962103753, 6223.097650840693, 6160.383961603804, 6187.938120618736, 6238.095476156022, 6256.343083976117, 6269.623822570478, 5216.582673386044, 5562.527185189304, 5678.602497825278, 6164.7842325518395, 6230.190075290183, 5159.767810448464, 6127.647695153045, 6164.4143806338325, 6223.688815559294, 6224.097505861715, 4478.619317358061, 4560.703554268962, 6050.6369617823075, 6054.122152287981, 6146.969265153824, 6153.84615384619, 6209.875802484015, 6245.28179259391, 6249.593776404519, 6261.843453913689, 5978.880422391615, 6067.575269731076, 6090.390960903874, 6108.541859360477, 6122.2959359674205], "value": 5620.208191968816, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.9708168969019, 482.0816344863036, 513.9177731562951, 540.678296413634, 546.751228191173, 39099.804500977494, 42056.948576285606, 42070.0, 42073.78963105188, 42190.15619687604, 43007.56992430075, 43644.78177609108, 43644.78177609108, 43711.907202319955, 43721.562784372145, 9775.511224438786, 9951.303408761389, 9974.052465015848, 9976.600935962553, 9991.300608957376, 9850.9507452463, 9941.602335906591, 9945.502724863763, 9948.90051099487, 9958.352707074053, 9913.950430247838, 9930.65242716505, 9942.304038717293, 9959.850602240973, 9969.401835889834, 9862.802743945116, 9903.90096099037, 9923.60305587783, 9984.301098923079, 10002.499875006257, 9680.467574283412, 9747.853782193273, 9757.804843903154, 9773.267004974656, 9796.95101524495, 40888.79555602233, 40932.795336023126, 41207.1758564827, 41243.587564124275, 41612.0, 3139.5133754268127, 3398.422268214385, 3452.430348992413, 3460.7468979159507, 3569.821508924543, 31924.723011079528, 32074.518882216784, 33205.83397083023, 33321.666783332344, 33369.6663033369, 3326.700596946262, 3331.283773988604, 3340.3820293245585, 3353.2455197580593, 3457.4986626939203, 478836.0, 482018.0, 486573.0, 492417.0, 493437.0, 70024.0, 70625.2937470629, 70930.2906970934, 70994.2900570998, 71227.0, 37133.25733485315, 37454.06364840901, 37943.0, 38371.84884453471, 75927.4814503718, 17268.05025723572, 17352.91323543374, 17436.738448923275, 17482.475525734248, 17491.38780142689, 10887.455627218607, 12054.216475929037, 13135.080544361803, 13255.867441325656, 13298.002649801303, 21841.344759657237, 21947.890260548596, 21966.45083872916, 22066.22768203105, 22075.0, 8820.426672266281, 9195.264378849675, 9218.262538996863, 9240.445573265626, 9248.445093294424, 893.3166127912152, 900.221308568097, 975.673149494913, 975.858500517421, 1043.8486419469286, 27022.864885675837, 29849.0, 30820.537691934638, 31250.68749312523, 31381.52927706086, 974.5809302000208, 1054.6097943760858, 1071.287593750163, 1134.2683968840051, 1148.0757989818276, 15857.762133568005, 16114.435994740363, 16181.19094045293, 16236.918815405847, 16408.75386869198, 399737.0, 400411.0, 405486.0, 406266.9686651607, 718125.0, 59492.70253648704, 61534.0, 61706.69146654238, 61716.0, 61946.76106477845, 1379.296558755042, 1380.9585712428643, 1382.4401117547409, 1400.248511674544, 1406.079018243032, 26822.195334140008, 30288.242793930327, 30453.934112305964, 30829.845850770602, 30921.536176956914, 50660.0, 51249.23126153185, 51262.0, 51468.74265628648, 51558.226626599884, 664346.0, 667261.0, 668464.0, 669148.0, 669571.0, 26990.460190796468, 27593.86203069052, 28301.71698282991, 28327.575086374134, 28422.573661394683, 49871.50128498668, 50192.74903625605, 50202.49797501978, 50501.242481362075, 51175.48824511856, 34655.48016779801, 41493.37759933543, 42139.0, 42480.0, 42634.93412664708, 34901.8254908734, 41174.79412602918, 41270.50527385147, 41726.79136604298, 42354.576454236296, 33333.83333083319, 39066.0, 40084.0, 40118.598814011486, 43372.91567710706, 41281.380779287734, 42814.57185428106, 44230.55769442264, 44407.33388999103, 45083.32375014312, 33136.668633313355, 33588.1602959928, 33603.159921002174, 34316.48525272073, 34319.0], "value": 20730.041810909403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.9809562378445, 373.80562107704, 388.14995160598306, 406.8331983886607, 417.73265110329396, 17065.0, 21588.2444114456, 22110.22614208503, 22391.992360343782, 22488.875556222163, 17084.402045928397, 20564.971751412446, 21078.89460552695, 22542.43643908903, 22579.887100564516, 5616.382197958242, 5757.798477053304, 5932.9406705932815, 6045.879082418349, 6053.455189032986, 3897.1231472918507, 5881.882362352771, 6031.4270144336215, 6086.17836592061, 6210.689465526705, 6172.7530898764, 6208.2239720034995, 6211.503079753631, 6214.3474935131835, 6218.160548325964, 6291.0, 6842.521023528305, 6843.589384636938, 6860.931390686104, 6869.313068693165, 4718.693284936502, 5478.561715062785, 5938.435848594377, 5969.074793406985, 6065.939340606626, 12024.69938251542, 13365.33173341329, 13604.727905441934, 13741.931290343584, 13800.171989680652, 1757.5957529768225, 2029.7564292284874, 2062.2163577840324, 2176.847620666554, 2243.338215226512, 10187.337823041478, 10293.330933489375, 10400.843987340197, 10498.842517362245, 10591.682249532527, 1512.122968678164, 1661.0451531260446, 1756.3589289909091, 1764.1091248919213, 1789.7382345446429, 109003.45498272536, 121193.99999999911, 121411.39294303561, 121906.0, 122440.0, 11404.771904561861, 11586.304821710724, 11598.0, 11787.528498860122, 11798.41007949599, 14616.342264598119, 14711.264436778118, 14762.852371476149, 14776.113433194043, 14800.851991480164, 7383.966244725742, 8586.957065214634, 8666.913330866611, 8762.430442021248, 8853.768374543373, 8566.0, 8607.913920860836, 8643.438176518506, 8726.69456569017, 8765.780855478664, 4553.567411095941, 4594.517575654575, 4629.259318509023, 4691.085238378483, 4723.834665786681, 1801.4325487471403, 1944.8315128631475, 3321.8837340692958, 3680.117476062726, 3836.827342769582, 862.3877047296364, 908.028409601733, 1006.3861044762689, 1010.8324884758116, 1040.105509262034, 21721.891390543264, 22136.89315534249, 22274.888625556767, 22451.43871403228, 22588.887055564617, 937.9062093790567, 971.820213260549, 973.153356579766, 982.7543114221445, 1058.7353161709573, 9390.483523406141, 11284.717882053013, 11509.53961841517, 11638.301701897914, 11767.293962362286, 569190.0, 611131.0, 622317.0, 628334.0, 631957.0, 131399.0, 135664.0, 135853.3207333957, 136740.0, 138281.0, 1012.4380968562372, 1022.9028242316969, 1026.2764750850633, 1039.9740006499746, 1043.3739756146404, 19173.945433001318, 19455.054494550997, 19463.708044379062, 19549.21803127859, 19665.60668786645, 50114.74942625264, 51345.743271283405, 52902.470975289754, 53423.0, 53783.0, 78973.60513197398, 80001.0, 82371.17628823635, 83924.0, 92714.0, 7229.277072292939, 7480.625968701434, 7562.962185189039, 7939.6030198491, 8411.70559030431, 9523.76190595213, 13302.800457993331, 13525.0, 13694.246816425193, 13827.170369777845, 11663.300201987908, 11676.474558645052, 11815.940920295343, 11853.170278080797, 11897.881021189678, 8541.701040463555, 11504.424778760862, 11702.765944681229, 11782.0, 11803.468843902217, 5856.472917437451, 10654.467276636293, 11628.94185529067, 11704.765904682028, 12083.275003499819, 7378.372838308589, 7468.3278504934815, 7471.40228781707, 7475.0, 7566.092068951761, 8922.598483068406, 10650.89349106499, 11005.724856878322, 11288.830667540158, 11885.76228475443], "value": 9601.74863927959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.5140200929675, 1565.7494800831862, 1620.2708781048532, 1777.751114843922, 1934.2456441987617, 7187.532810367323, 8192.877106843387, 8402.91597084029, 8469.983601967764, 8814.0, 8306.335493160548, 8455.873161902577, 8462.788430289245, 8549.829003419927, 8555.0, 2060.8253295621466, 2077.981788923424, 2229.8216142708543, 2355.0697474497647, 2355.904504405451, 2240.204727321802, 2337.614293641547, 2370.810335173182, 2380.0241900820665, 2383.7020372453444, 2295.598270302699, 2297.8391512594126, 2304.331743794298, 2378.9643155352683, 2383.4041489627593, 2343.60158773009, 2349.5183487385043, 2358.917437889683, 2364.3616223619697, 2370.679958205646, 2360.3155085025323, 2363.0902102690416, 2363.1492662641435, 2367.6685264063044, 2369.5853225685437, 7686.770116781288, 8160.714374996906, 8549.572521373968, 8610.784730381727, 8666.52334121623, 5205.531502164823, 5298.92051619226, 5332.120200166968, 5341.519263266325, 5356.4375740547075, 3191.12244132863, 3460.7058400036026, 3477.3135029510668, 3604.4232922732235, 3636.7817930923966, 1051.2273478992934, 1069.6256310291415, 1072.9056362510196, 1080.508368692243, 1084.9945750271197, 9087.318451116193, 10970.067544258667, 11116.610918617891, 11270.211085223955, 11329.206955513117, 4572.9314060289125, 4592.724436533818, 4751.6436267279405, 4804.447488538793, 4805.735684537384, 9802.705918822447, 9821.870484894329, 9840.311178217598, 9847.310688251753, 9847.655332063343, 5261.736913154327, 5283.577313814885, 5288.92066619001, 5306.8938621228135, 5311.389190243094, 4322.330038843984, 4658.813647454132, 4752.382190315237, 4812.398450193726, 4838.298446725205, 3920.882373528799, 3955.802209889494, 4007.3788562772816, 4018.0356714388336, 4053.0, 1279.309173046563, 1297.0401902592014, 1297.4031945305264, 1300.219868079145, 1308.4896890212824, 942.6135284533445, 945.8344789661782, 951.2390087929629, 954.2652157838564, 1001.1290177545436, 5889.116632505158, 5929.258842644669, 5975.25309336333, 6022.69886505673, 6108.267007959073, 440.6342735529503, 450.8985478267364, 453.9182947069493, 456.3155267099351, 466.1865045495564, 3992.461017762565, 4095.467589213443, 4156.56356082613, 4165.770882601486, 4168.18720349535, 8291.83416331682, 9072.95463522678, 9391.765205869771, 10072.74818129538, 10322.535485903152, 10242.027007434282, 10254.692359229235, 10314.381137131797, 10348.223883208639, 10406.427646479517, 7586.848263034708, 7793.64928578204, 7950.045994480583, 8000.239977202156, 8069.9596502018285, 5919.82983967964, 6033.155358249936, 6046.365131661112, 6054.3642917493025, 6119.3268740437625, 9716.271279653913, 9727.513624318897, 9840.852387214341, 9845.507724613884, 9881.901180988098, 9414.764630884283, 9931.453770042717, 9935.602575896883, 10044.0, 10091.899081009096, 6934.514583979073, 7249.093863267091, 7399.186089530255, 7596.582187979714, 7629.847403051797, 8287.709930152416, 8388.454750441202, 8432.70485533028, 8454.83090338202, 8468.407211495136, 7290.854182916418, 7427.925720742724, 7465.186580107947, 7471.701131954661, 7480.0, 7226.566406015656, 7238.203797582157, 7302.868055451414, 7339.926600733925, 7409.37020353276, 7013.123359580052, 7034.5427547209265, 7040.3663670269925, 7058.435325173871, 7073.717051318095, 4938.975305123451, 4953.281774142802, 5109.514596113363, 5120.820771272987, 5146.408163061295, 5086.54221120101, 5162.09663308927, 5184.092783762751, 5184.7926082956255, 5252.343457067866], "value": 4462.783122817162, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.6011505273251, 317.10259964301025, 322.56936989119527, 329.231245042825, 329.57155697593123, 4693.967327188022, 5458.372287186975, 5656.236408084907, 5685.971570142148, 5751.597388182824, 4527.68306218564, 5678.971605141968, 5703.77184912604, 5777.797777077803, 5779.942200577993, 3746.063484128968, 4196.3705444183315, 4302.182585308797, 4308.0, 4312.547182545834, 3739.457778622098, 4154.43915071466, 4250.57494250574, 4314.1156063007165, 4315.309550471925, 3727.366347720894, 4184.267753143203, 4220.0, 4243.936340954888, 4248.490181178263, 4220.092680073799, 4255.191513612419, 4272.209641216354, 4277.6791740619265, 4279.0799978004725, 3380.4253276942977, 3440.8645147101397, 3670.1558641512333, 3692.51997240357, 3710.6456143507426, 4551.431071116111, 5095.8980820383385, 5156.484351564851, 5460.945390546083, 5522.2544956431175, 4474.574915383034, 4829.106615276185, 4872.65891387603, 4892.559669629751, 4917.60659147271, 5391.519900845616, 5397.54120899724, 5523.861903452445, 6001.879962400728, 6084.756609735649, 3403.8808641697424, 3552.342816578941, 3991.44119823225, 4048.178319756092, 4055.634992850628, 5203.791848326063, 5227.320448341691, 6161.075838624198, 6234.438900498977, 6250.468710159642, 3115.12776422602, 3609.3322735294055, 3649.9635003650155, 4095.5699651536756, 4127.380892866094, 3194.872205111816, 4141.668666506672, 4149.170165966759, 4197.706160568731, 4217.40956266123, 4820.637887435131, 4880.853574392774, 4887.189865827164, 4894.290327902434, 4895.730734809548, 5817.7091145442555, 6050.122732203894, 6092.0, 6092.8781424372155, 6106.267247930276, 1194.5580135349976, 1262.9391311298552, 1372.512757970906, 1386.7503849307222, 1404.3469786549304, 834.5493433545938, 837.6816809612309, 863.447393668053, 864.2826454043129, 873.4497266721925, 3976.681865450757, 4691.7184968901975, 4712.198926182557, 4734.431868175772, 4779.761011949388, 4635.824460244743, 4688.695234809727, 4865.635077369211, 4911.312416261726, 4995.0, 4134.077653890955, 4182.623563879205, 4242.257604919127, 4477.395551600493, 4743.952560474351, 2496.95006099877, 2547.5159719653207, 2761.762971992692, 2766.958495622567, 2789.302674331417, 4900.531298685701, 5208.73956302191, 5385.192221166778, 5405.675559509448, 5445.576718360371, 4395.7362558246605, 4526.456825181, 4617.561331673485, 5324.92012619811, 5351.866203344947, 4294.957050429518, 4715.151272770866, 5164.586833053347, 5362.168863826113, 5411.350637923474, 4693.389859318267, 4775.922473723941, 5013.3205376199385, 5258.553022992935, 5265.763040663102, 4803.951960480351, 4891.95108048915, 4951.183054795918, 4991.926735751831, 5642.576806739593, 5474.151506516497, 6120.510359171167, 6294.874102517832, 6429.517786165963, 6445.548811583144, 4039.91920161601, 4055.4994651978955, 4058.1883623276053, 4079.306517891906, 4098.815553300049, 5936.308152176609, 6025.819225423069, 6259.655718935503, 6291.685415729286, 6313.40022697843, 5817.8364327133895, 5843.357230704534, 5861.824145275648, 5927.673977931083, 6055.485283750931, 5329.626926115135, 6024.939750602438, 6037.275526936795, 6065.7261974983985, 6091.360407157362, 4768.57082862544, 4881.633877459134, 5921.17103605487, 5934.47784691513, 6005.39946005396, 5285.207218917193, 5334.853006603599, 5570.0, 5632.493075623213, 6075.11671381873, 4365.148795984753, 5088.524327944854, 5673.205751194753, 5895.7052147393315, 5946.167536544974], "value": 4104.272307853427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.4390395011642, 782.6751897962349, 813.8738495533187, 838.1450920061537, 895.3195571365765, 15205.695886082272, 15396.384144634229, 15834.920825395871, 15872.365105395771, 15877.841221587794, 14199.645008874782, 14308.499202527888, 14364.92817535911, 14679.926600366984, 14710.85289147111, 661.3485716569176, 892.2059367163246, 913.7121806630923, 919.2554031234688, 921.87554680118, 896.5696465696469, 931.3434029009566, 932.0912110692088, 938.1462868789403, 938.5448057692014, 932.2169377722745, 977.7457860956167, 983.7835676151271, 985.7141428985585, 986.763176837561, 979.5396163803001, 981.7300242433316, 981.9410835349902, 983.4738414947968, 984.990150098497, 685.4858855858106, 687.9793606191772, 703.8627467643812, 715.8353578676881, 733.7505248215632, 12422.627321180378, 12772.0, 15368.846311536965, 15373.769393459108, 15381.615459613487, 12562.81155782664, 14904.850951490564, 14956.027858189183, 14960.775588366183, 15255.160966146857, 11976.341301228429, 12249.693757656041, 12475.126741128124, 12505.937470312681, 12606.604745098402, 3426.3489936911906, 3750.912235451716, 3888.0862997195636, 4033.1530378620523, 4119.134981653856, 82305.0, 101176.0, 113638.0, 114699.0, 114971.0, 11502.654920352403, 11541.36522491271, 11681.474333654836, 11836.822447663291, 12184.0, 24206.0, 24247.7575224249, 24304.906279217477, 24321.39196520066, 24349.26952191437, 8141.267285944294, 8208.794780130545, 8294.212049855374, 8424.157584241526, 8480.660773568989, 4527.275635898306, 4554.407926969539, 4606.608438282717, 4616.746078965622, 4633.027064316464, 3415.9146021349666, 3525.4006818840858, 3528.135606776305, 3540.752147349661, 3545.5745310562897, 635.7647670361996, 640.5612155673379, 641.1920979565781, 641.9422251997343, 652.3606865271965, 608.8143116349468, 673.9258681545026, 693.9548929319578, 695.9234484206734, 701.214639603637, 9061.456312621263, 9109.134632209929, 9387.765305867408, 9547.188488978376, 9632.855507167398, 589.8436914217735, 614.4623454477332, 635.4662083849588, 657.2605818454239, 702.9648517574203, 4568.474625418053, 4661.417322834645, 4703.247480403187, 4734.360861283682, 4795.592374648194, 141675.0, 144336.0, 149266.0, 153149.0, 154222.2288888571, 107828.0, 113857.0, 125123.0, 125222.0, 126537.0, 70849.0, 92896.0, 115421.42289288668, 115643.0, 122677.0, 7489.101307843093, 9729.70810875675, 9999.800004000024, 10048.69853904384, 10275.486225688535, 53277.0, 61979.690101549204, 62236.0, 63438.682806585675, 64524.354756453715, 88721.0, 95188.0, 97602.02397976213, 98425.50787246018, 99974.0, 13332.066755327034, 13393.464261429433, 13744.793828092786, 13877.167369957835, 14014.719705606034, 15071.773923391378, 15098.245087745789, 15429.0, 15430.30563624662, 15771.290291937119, 13813.930930345285, 13844.515441959484, 13913.58259252224, 14261.71476570442, 14290.499832505813, 13848.09987350819, 14036.859631403555, 14238.932080094242, 14362.856371436152, 14521.346539405964, 13780.586582402544, 13797.241151736349, 13816.447342106203, 13818.963577731509, 14085.577432677037, 11135.498902549567, 11507.827382589101, 11810.468528916048, 11859.644210673694, 11889.82165267539, 10708.320661305459, 10745.785084298113, 11626.128040397174, 11818.231814932002, 11883.940580297043], "value": 8036.362277523508, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 107.0, 116.0, 117.0, 119.0, 113.0, 116.0, 117.0, 132.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 108.0, 123.0, 143.0, 125.0, 160.0, 158.0, 98.0, 154.0, 125.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 191.0, 211.0, 177.0, 268.0, 239.0, 243.0, 287.0, 247.0, 200.0], "value": 225.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 83.0, 77.0, 147.0, 57.0, 60.0, 67.0, 85.0, 156.0, 80.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 118.0, 72.0, 71.0, 90.0, 114.0, 69.0, 76.0, 143.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 89.0, 86.0, 90.0, 73.0, 117.0, 131.0, 96.0, 130.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 113.0, 148.0, 95.0, 96.0, 99.0, 147.0, 150.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 77.0, 79.0, 145.0, 94.0, 144.0, 142.0, 113.0, 90.0], "value": 107.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 57.0, 59.0, 55.0, 58.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 102.0, 76.0, 72.0, 81.0, 80.0, 75.0, 73.0, 73.0, 75.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 111.0, 104.0, 106.0, 95.0, 89.0, 84.0, 82.0, 83.0], "value": 93.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 137.0, 125.0, 148.0, 159.0, 141.0, 145.0, 128.0, 168.0, 151.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 165.0, 161.0, 167.0, 163.0, 169.0, 166.0, 163.0, 166.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 83.0, 86.0, 86.0, 69.0, 72.0, 76.0, 83.0, 92.0], "value": 78.8, "unit": "score"}]}]} 09:34:12 INFO - Return code: 0 09:34:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:12 ERROR - # TBPL SUCCESS # 09:34:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:34:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:34:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:34:12 INFO - 2016-07-05 09:34:12.460 screenresolution[1670:10406] starting screenresolution argv=screenresolution get 09:34:12 INFO - 2016-07-05 09:34:12.463 screenresolution[1670:10406] Display 0: 1600x1200x32@60 09:34:12 INFO - 2016-07-05 09:34:12.469 screenresolution[1671:10409] starting screenresolution argv=screenresolution list 09:34:12 INFO - Available Modes on Display 0 09:34:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:34:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:34:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:34:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:34:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:34:12 INFO - Intel Iris: 09:34:12 INFO - Chipset Model: Intel Iris 09:34:12 INFO - Type: GPU 09:34:12 INFO - Bus: Built-In 09:34:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:34:12 INFO - Vendor: Intel (0x8086) 09:34:12 INFO - Device ID: 0x0a2e 09:34:12 INFO - Revision ID: 0x0009 09:34:12 INFO - Displays: 09:34:12 INFO - Display: 09:34:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:34:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:34:12 INFO - Display Serial Number: 1600x1200 60 09:34:12 INFO - Main Display: Yes 09:34:12 INFO - Mirror: Off 09:34:12 INFO - Online: Yes 09:34:12 INFO - Rotation: Supported 09:34:12 INFO - Return code: 0 09:34:12 INFO - Running post-action listener: _resource_record_post_action 09:34:12 INFO - ##### 09:34:12 INFO - ##### Finished run-tests step (success) 09:34:12 INFO - ##### 09:34:12 INFO - Running post-run listener: _resource_record_post_run 09:34:12 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 36894208; Write bytes: 707574272; Read time: 240; Write time: 1963 09:34:12 INFO - TinderboxPrint: CPU usage
54.6% 09:34:12 INFO - TinderboxPrint: I/O read bytes / time
36,894,208 / 240 09:34:12 INFO - TinderboxPrint: I/O write bytes / time
707,574,272 / 1,963 09:34:12 INFO - TinderboxPrint: CPU idle
2,196.9 (45.4%) 09:34:12 INFO - TinderboxPrint: CPU system
986.0 (20.4%) 09:34:12 INFO - TinderboxPrint: CPU user
1,654.7 (34.2%) 09:34:12 INFO - TinderboxPrint: Swap in / out
442,986,496 / 0 09:34:12 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 403833344; Write bytes: 393479680; Read time: 29813; Write time: 804 09:34:12 INFO - run-tests - Wall time: 1174s; CPU: 55.0%; Read bytes: 29638144; Write bytes: 296252416; Read time: 178; Write time: 1112 09:34:13 INFO - Running post-run listener: _upload_blobber_files 09:34:13 INFO - Blob upload gear active. 09:34:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:13 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 09:34:13 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:34:13 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:34:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:34:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:14 INFO - (blobuploader) - INFO - Done attempting. 09:34:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:34:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:15 INFO - (blobuploader) - INFO - Done attempting. 09:34:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:34:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:34:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:17 INFO - (blobuploader) - INFO - Done attempting. 09:34:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:34:17 INFO - Return code: 0 09:34:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:34:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:34:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10ae6cd502aab6343d31726222c9f15115334a1e09c231191b99931cec7314124d1ef8335285b79e141cdb035802b264342c9e754de9e87ad9f53b600fc1433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a28da4594269c7b52a069f40e99a3a280797f5b907005486966eccc55fdb1086f5d880b2b5337c972a3549406361b3b946c6c0c03f49744973de0bd5e271af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70dcc027aae8bd44194c258212b19080e46c3dee82e98c0dece916e57a68158f794e69989803efa0b8056eb559fee87cb6ba967a19454c1958fcc7906f49418c"} 09:34:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:34:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:34:17 INFO - Contents: 09:34:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10ae6cd502aab6343d31726222c9f15115334a1e09c231191b99931cec7314124d1ef8335285b79e141cdb035802b264342c9e754de9e87ad9f53b600fc1433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a28da4594269c7b52a069f40e99a3a280797f5b907005486966eccc55fdb1086f5d880b2b5337c972a3549406361b3b946c6c0c03f49744973de0bd5e271af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70dcc027aae8bd44194c258212b19080e46c3dee82e98c0dece916e57a68158f794e69989803efa0b8056eb559fee87cb6ba967a19454c1958fcc7906f49418c"} 09:34:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:34:17 INFO - Copying logs to upload dir... 09:34:17 INFO - mkdir: /builds/slave/test/build/upload/logs 09:34:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.666056 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-05 09:34:17.936337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:34:17.940108) ========= 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.sPoPWw8c4m/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.SARbA5wM49/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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/Firefox/sha512/10ae6cd502aab6343d31726222c9f15115334a1e09c231191b99931cec7314124d1ef8335285b79e141cdb035802b264342c9e754de9e87ad9f53b600fc1433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a28da4594269c7b52a069f40e99a3a280797f5b907005486966eccc55fdb1086f5d880b2b5337c972a3549406361b3b946c6c0c03f49744973de0bd5e271af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70dcc027aae8bd44194c258212b19080e46c3dee82e98c0dece916e57a68158f794e69989803efa0b8056eb559fee87cb6ba967a19454c1958fcc7906f49418c"} build_url:https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/Brs4ZbJpQX-vcOGPt5MhnA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10ae6cd502aab6343d31726222c9f15115334a1e09c231191b99931cec7314124d1ef8335285b79e141cdb035802b264342c9e754de9e87ad9f53b600fc1433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a28da4594269c7b52a069f40e99a3a280797f5b907005486966eccc55fdb1086f5d880b2b5337c972a3549406361b3b946c6c0c03f49744973de0bd5e271af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70dcc027aae8bd44194c258212b19080e46c3dee82e98c0dece916e57a68158f794e69989803efa0b8056eb559fee87cb6ba967a19454c1958fcc7906f49418c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:34:17.973211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:34:17.973609) ========= 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.sPoPWw8c4m/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.SARbA5wM49/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.005275 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:34:18.022487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:34:18.022822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:34:18.023231) ========= ========= Total master_lag: 0.18 =========