builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0295 starttime: 1467675405.76 results: success (0) buildid: 20160704144723 builduid: 08d556a0df02451594a99d90e9b0dbb4 revision: e8324c74d19778e079499c0ec3bc6cfe66de3be0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:45.760797) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:45.761911) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:45.762217) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:46.078051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:46.078359) ========= 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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-04 16:36:46-- 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% 68.1M=0s 2016-07-04 16:36:46 (68.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.496141 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:46.601050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:46.601405) ========= 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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.026740 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:46.650282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:36:46.650677) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e8324c74d19778e079499c0ec3bc6cfe66de3be0 --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 e8324c74d19778e079499c0ec3bc6cfe66de3be0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OW2d8KMAP9/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.OfvwjbZNaI/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-04 16:36:46,738 truncating revision to first 12 chars 2016-07-04 16:36:46,738 Setting DEBUG logging. 2016-07-04 16:36:46,738 attempt 1/10 2016-07-04 16:36:46,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e8324c74d197?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 16:36:47,692 unpacking tar archive at: mozilla-central-e8324c74d197/testing/mozharness/ program finished with exit code 0 elapsedTime=1.224189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:36:47.899004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:47.899352) ========= script_repo_revision: e8324c74d19778e079499c0ec3bc6cfe66de3be0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:47.899777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:47.900082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:36:47.919217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-07-04 16:36:47.919707) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:36:48 INFO - MultiFileLogger online at 20160704 16:36:48 in /builds/slave/test 16:36:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:36:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:48 INFO - {'append_to_log': False, 16:36:48 INFO - 'base_work_dir': '/builds/slave/test', 16:36:48 INFO - 'blob_upload_branch': 'Firefox', 16:36:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:48 INFO - 'branch': 'Firefox', 16:36:48 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:48 INFO - 'config_files': ('talos/mac_config.py',), 16:36:48 INFO - 'default_actions': ('clobber', 16:36:48 INFO - 'read-buildbot-config', 16:36:48 INFO - 'download-and-extract', 16:36:48 INFO - 'populate-webroot', 16:36:48 INFO - 'create-virtualenv', 16:36:48 INFO - 'install', 16:36:48 INFO - 'run-tests'), 16:36:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:48 INFO - 'download_minidump_stackwalk': True, 16:36:48 INFO - 'download_symbols': 'ondemand', 16:36:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:48 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:48 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:48 INFO - 'installer_path': 'installer.exe', 16:36:48 INFO - 'log_level': 'info', 16:36:48 INFO - 'log_name': 'talos', 16:36:48 INFO - 'log_to_console': True, 16:36:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:36:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:36:48 INFO - 'opt_config_files': (), 16:36:48 INFO - 'pip_index': False, 16:36:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:48 INFO - 'cmd': ('bash', 16:36:48 INFO - '-c', 16:36:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:48 INFO - 'enabled': True, 16:36:48 INFO - 'halt_on_failure': False, 16:36:48 INFO - 'name': 'check_screen_resolution'},), 16:36:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:48 INFO - 'cmd': ('bash', 16:36:48 INFO - '-c', 16:36:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:48 INFO - 'enabled': True, 16:36:48 INFO - 'halt_on_failure': False, 16:36:48 INFO - 'name': 'check_screen_resolution'},), 16:36:48 INFO - 'run_cmd_checks_enabled': True, 16:36:48 INFO - 'sps_profile': False, 16:36:48 INFO - 'sps_profile_interval': 0, 16:36:48 INFO - 'suite': 'dromaeojs', 16:36:48 INFO - 'system_bits': '32', 16:36:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:48 INFO - 'title': 't-yosemite-r7-0295', 16:36:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:48 INFO - 'use_talos_json': True, 16:36:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:48 INFO - 'work_dir': 'build'} 16:36:48 INFO - ##### 16:36:48 INFO - ##### Running clobber step. 16:36:48 INFO - ##### 16:36:48 INFO - Running pre-action listener: _resource_record_pre_action 16:36:48 INFO - Running main action method: clobber 16:36:48 INFO - rmtree: /builds/slave/test/build 16:36:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:50 INFO - Running post-action listener: _resource_record_post_action 16:36:50 INFO - ##### 16:36:50 INFO - ##### Finished clobber step (success) 16:36:50 INFO - ##### 16:36:50 INFO - ##### 16:36:50 INFO - ##### Running read-buildbot-config step. 16:36:50 INFO - ##### 16:36:50 INFO - Running pre-action listener: _resource_record_pre_action 16:36:50 INFO - Running main action method: read_buildbot_config 16:36:50 INFO - Using buildbot properties: 16:36:50 INFO - { 16:36:50 INFO - "project": "", 16:36:50 INFO - "product": "firefox", 16:36:50 INFO - "script_repo_revision": "production", 16:36:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:36:50 INFO - "repository": "", 16:36:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:36:50 INFO - "buildid": "20160704144723", 16:36:50 INFO - "pgo_build": "False", 16:36:50 INFO - "basedir": "/builds/slave/test", 16:36:50 INFO - "buildnumber": 35, 16:36:50 INFO - "slavename": "t-yosemite-r7-0295", 16:36:50 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:36:50 INFO - "platform": "yosemite_r7", 16:36:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:36:50 INFO - "branch": "mozilla-central", 16:36:50 INFO - "repo_path": "mozilla-central", 16:36:50 INFO - "revision": "e8324c74d19778e079499c0ec3bc6cfe66de3be0", 16:36:50 INFO - "stage_platform": "macosx64", 16:36:50 INFO - "builduid": "08d556a0df02451594a99d90e9b0dbb4", 16:36:50 INFO - "slavebuilddir": "test" 16:36:50 INFO - } 16:36:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 16:36:50 INFO - Running post-action listener: _resource_record_post_action 16:36:50 INFO - ##### 16:36:50 INFO - ##### Finished read-buildbot-config step (success) 16:36:50 INFO - ##### 16:36:50 INFO - ##### 16:36:50 INFO - ##### Running download-and-extract step. 16:36:50 INFO - ##### 16:36:50 INFO - Running pre-action listener: _resource_record_pre_action 16:36:50 INFO - Running main action method: download_and_extract 16:36:50 INFO - mkdir: /builds/slave/test/build/tests 16:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:50 INFO - https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:36:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:36:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:36:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:36:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:00 INFO - Downloaded 1199 bytes. 16:37:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 16:37:00 INFO - Using the following test package requirements: 16:37:00 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:37:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 16:37:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 16:37:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'jsshell-mac.zip'], 16:37:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 16:37:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:37:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 16:37:00 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 16:37:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 16:37:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:37:00 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 16:37:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:00 INFO - https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:37:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:37:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:37:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:06 INFO - Downloaded 18795131 bytes. 16:37:06 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'] 16:37:06 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 16:37:09 INFO - Return code: 0 16:37:09 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 16:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:09 INFO - https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:22 INFO - Downloaded 18795131 bytes. 16:37:22 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'] 16:37:22 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 16:37:26 INFO - Return code: 0 16:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:26 INFO - https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:37:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:37:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:37:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:27 INFO - Downloaded 14403333 bytes. 16:37:27 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'] 16:37:27 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 16:37:27 INFO - Return code: 0 16:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:27 INFO - https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:37:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:37:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:37:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 16:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uq_SJYIyTWG01jkol8rEEA/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 16:37:30 INFO - Downloaded 112412524 bytes. 16:37:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:37:30 INFO - mkdir: /builds/slave/test/properties 16:37:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:30 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:30 INFO - Contents: 16:37:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:37:31 INFO - Running post-action listener: _resource_record_post_action 16:37:31 INFO - Running post-action listener: set_extra_try_arguments 16:37:31 INFO - ##### 16:37:31 INFO - ##### Finished download-and-extract step (success) 16:37:31 INFO - ##### 16:37:31 INFO - ##### 16:37:31 INFO - ##### Running populate-webroot step. 16:37:31 INFO - ##### 16:37:31 INFO - Running pre-action listener: _resource_record_pre_action 16:37:31 INFO - Running main action method: populate_webroot 16:37:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:31 INFO - '--tppagecycles', 16:37:31 INFO - '7'], 16:37:31 INFO - 'tests': ['tsvgm']}}, 16:37:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:37:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:37:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['damp', 'tps']}, 16:37:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'tests': ['damp', 'tps']}, 16:37:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['dromaeo_dom']}, 16:37:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['basic_compositor_video']}, 16:37:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:37:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['a11yr', 16:37:31 INFO - 'ts_paint', 16:37:31 INFO - 'tpaint', 16:37:31 INFO - 'sessionrestore', 16:37:31 INFO - 'sessionrestore_no_auto_restore', 16:37:31 INFO - 'tabpaint']}, 16:37:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:37:31 INFO - 'ts_paint', 16:37:31 INFO - 'tpaint', 16:37:31 INFO - 'sessionrestore', 16:37:31 INFO - 'sessionrestore_no_auto_restore', 16:37:31 INFO - 'tabpaint']}, 16:37:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:37:31 INFO - 'ts_paint', 16:37:31 INFO - 'tpaint', 16:37:31 INFO - 'sessionrestore', 16:37:31 INFO - 'sessionrestore_no_auto_restore', 16:37:31 INFO - 'tabpaint']}, 16:37:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:37:31 INFO - 'ts_paint', 16:37:31 INFO - 'tpaint', 16:37:31 INFO - 'sessionrestore', 16:37:31 INFO - 'sessionrestore_no_auto_restore', 16:37:31 INFO - 'tabpaint']}, 16:37:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['a11yr', 16:37:31 INFO - 'ts_paint', 16:37:31 INFO - 'tpaint', 16:37:31 INFO - 'sessionrestore', 16:37:31 INFO - 'sessionrestore_no_auto_restore', 16:37:31 INFO - 'tabpaint']}, 16:37:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['a11yr', 16:37:31 INFO - 'ts_paint', 16:37:31 INFO - 'tpaint', 16:37:31 INFO - 'sessionrestore', 16:37:31 INFO - 'sessionrestore_no_auto_restore', 16:37:31 INFO - 'tabpaint']}, 16:37:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['tsvgx', 16:37:31 INFO - 'tsvgr_opacity', 16:37:31 INFO - 'tart', 16:37:31 INFO - 'tscrollx', 16:37:31 INFO - 'cart']}, 16:37:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:37:31 INFO - 'tsvgr_opacity', 16:37:31 INFO - 'tart', 16:37:31 INFO - 'tscrollx', 16:37:31 INFO - 'cart']}, 16:37:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'talos_options': ['--disable-e10s'], 16:37:31 INFO - 'tests': ['tp5o']}, 16:37:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'tests': ['tp5o']}, 16:37:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'talos_options': ['--disable-e10s', 16:37:31 INFO - '--xperf_path', 16:37:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:31 INFO - 'tests': ['tp5n']}, 16:37:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:31 INFO - 'talos_options': ['--xperf_path', 16:37:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:31 INFO - 'tests': ['tp5n']}}, 16:37:31 INFO - 'talos.zip': {'path': '', 16:37:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:31 INFO - Running post-action listener: _resource_record_post_action 16:37:31 INFO - ##### 16:37:31 INFO - ##### Finished populate-webroot step (success) 16:37:31 INFO - ##### 16:37:31 INFO - ##### 16:37:31 INFO - ##### Running create-virtualenv step. 16:37:31 INFO - ##### 16:37:31 INFO - Running pre-action listener: _resource_record_pre_action 16:37:31 INFO - Running main action method: create_virtualenv 16:37:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:31 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 16:37:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:31 INFO - Using real prefix '/tools/python27' 16:37:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:32 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:35 INFO - Installing pip.................done. 16:37:35 INFO - Return code: 0 16:37:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:35 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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:37:35 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 16:37:35 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 16:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:35 INFO - 'HOME': '/Users/cltbld', 16:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:35 INFO - 'LOGNAME': 'cltbld', 16:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:35 INFO - 'MOZ_NO_REMOTE': '1', 16:37:35 INFO - 'NO_EM_RESTART': '1', 16:37:35 INFO - 'PAGER': '/bin/cat', 16:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:35 INFO - 'PWD': '/builds/slave/test', 16:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:35 INFO - 'SHELL': '/bin/bash', 16:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:37:35 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:35 INFO - 'USER': 'cltbld', 16:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:35 INFO - 'XPC_FLAGS': '0x0', 16:37:35 INFO - 'XPC_SERVICE_NAME': '0', 16:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:35 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 16:37:35 INFO - Cleaning up... 16:37:35 INFO - Return code: 0 16:37:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:35 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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:37:35 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 16:37:35 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 16:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:35 INFO - 'HOME': '/Users/cltbld', 16:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:35 INFO - 'LOGNAME': 'cltbld', 16:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:35 INFO - 'MOZ_NO_REMOTE': '1', 16:37:35 INFO - 'NO_EM_RESTART': '1', 16:37:35 INFO - 'PAGER': '/bin/cat', 16:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:35 INFO - 'PWD': '/builds/slave/test', 16:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:35 INFO - 'SHELL': '/bin/bash', 16:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:37:35 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:35 INFO - 'USER': 'cltbld', 16:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:35 INFO - 'XPC_FLAGS': '0x0', 16:37:35 INFO - 'XPC_SERVICE_NAME': '0', 16:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:35 INFO - Downloading/unpacking psutil>=3.1.1 16:37:35 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 16:37:35 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 16:37:35 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 16:37:35 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 16:37:35 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 16:37:35 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 16:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:39 INFO - Installing collected packages: psutil 16:37:39 INFO - Running setup.py install for psutil 16:37:39 INFO - building 'psutil._psutil_osx' extension 16:37:39 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 16:37:39 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 16:37:39 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 16:37: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 16:37:40 INFO - building 'psutil._psutil_posix' extension 16:37:40 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 16:37:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:37:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:37:40 INFO - ^ 16:37:40 INFO - 1 warning generated. 16:37:40 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 16:37:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:40 INFO - Successfully installed psutil 16:37:40 INFO - Cleaning up... 16:37:40 INFO - Return code: 0 16:37:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:40 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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:37:40 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 16:37:40 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 16:37:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:37:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:40 INFO - 'HOME': '/Users/cltbld', 16:37:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:40 INFO - 'LOGNAME': 'cltbld', 16:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:40 INFO - 'MOZ_NO_REMOTE': '1', 16:37:40 INFO - 'NO_EM_RESTART': '1', 16:37:40 INFO - 'PAGER': '/bin/cat', 16:37:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:40 INFO - 'PWD': '/builds/slave/test', 16:37:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:40 INFO - 'SHELL': '/bin/bash', 16:37:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:37:40 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:37:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:40 INFO - 'USER': 'cltbld', 16:37:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:40 INFO - 'XPC_FLAGS': '0x0', 16:37:40 INFO - 'XPC_SERVICE_NAME': '0', 16:37:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:37:40 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 16:37:40 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 16:37:40 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 16:37:40 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 16:37:40 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 16:37:40 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 16:37:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:37:43 INFO - Installing collected packages: mozsystemmonitor 16:37:43 INFO - Running setup.py install for mozsystemmonitor 16:37:43 INFO - Successfully installed mozsystemmonitor 16:37:43 INFO - Cleaning up... 16:37:43 INFO - Return code: 0 16:37:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:43 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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:37:43 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 16:37:43 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 16:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:43 INFO - 'HOME': '/Users/cltbld', 16:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:43 INFO - 'LOGNAME': 'cltbld', 16:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:43 INFO - 'MOZ_NO_REMOTE': '1', 16:37:43 INFO - 'NO_EM_RESTART': '1', 16:37:43 INFO - 'PAGER': '/bin/cat', 16:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:43 INFO - 'PWD': '/builds/slave/test', 16:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:43 INFO - 'SHELL': '/bin/bash', 16:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:37:43 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:43 INFO - 'USER': 'cltbld', 16:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:43 INFO - 'XPC_FLAGS': '0x0', 16:37:43 INFO - 'XPC_SERVICE_NAME': '0', 16:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:43 INFO - Downloading/unpacking jsonschema==2.5.1 16:37:43 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 16:37:43 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 16:37:43 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 16:37:43 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 16:37:43 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 16:37:43 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 16:37:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:46 INFO - warning: no files found matching '*.txt' 16:37:46 INFO - no previously-included directories found matching 'build' 16:37:46 INFO - no previously-included directories found matching 'dist' 16:37:46 INFO - no previously-included directories found matching '.git*' 16:37:46 INFO - Installing collected packages: jsonschema, functools32 16:37:46 INFO - Running setup.py install for functools32 16:37:46 INFO - warning: no files found matching '*.txt' 16:37:46 INFO - no previously-included directories found matching 'build' 16:37:46 INFO - no previously-included directories found matching 'dist' 16:37:46 INFO - no previously-included directories found matching '.git*' 16:37:46 INFO - Successfully installed jsonschema functools32 16:37:46 INFO - Cleaning up... 16:37:46 INFO - Return code: 0 16:37:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:46 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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:37:46 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 16:37:46 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 16:37:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:37:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:46 INFO - 'HOME': '/Users/cltbld', 16:37:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:46 INFO - 'LOGNAME': 'cltbld', 16:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:46 INFO - 'MOZ_NO_REMOTE': '1', 16:37:46 INFO - 'NO_EM_RESTART': '1', 16:37:46 INFO - 'PAGER': '/bin/cat', 16:37:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:46 INFO - 'PWD': '/builds/slave/test', 16:37:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:46 INFO - 'SHELL': '/bin/bash', 16:37:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:37:46 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:37:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:46 INFO - 'USER': 'cltbld', 16:37:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:46 INFO - 'XPC_FLAGS': '0x0', 16:37:46 INFO - 'XPC_SERVICE_NAME': '0', 16:37:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:50 INFO - Downloading docopt-0.6.1.tar.gz 16:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:50 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:50 INFO - Running setup.py install for blobuploader 16:37:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:50 INFO - Running setup.py install for requests 16:37:51 INFO - Running setup.py install for docopt 16:37:51 INFO - Successfully installed blobuploader requests docopt 16:37:51 INFO - Cleaning up... 16:37:51 INFO - Return code: 0 16:37:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:37: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 16:37: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 16:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:52 INFO - 'HOME': '/Users/cltbld', 16:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:52 INFO - 'LOGNAME': 'cltbld', 16:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:52 INFO - 'MOZ_NO_REMOTE': '1', 16:37:52 INFO - 'NO_EM_RESTART': '1', 16:37:52 INFO - 'PAGER': '/bin/cat', 16:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:52 INFO - 'PWD': '/builds/slave/test', 16:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:52 INFO - 'SHELL': '/bin/bash', 16:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:37:52 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:52 INFO - 'USER': 'cltbld', 16:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:52 INFO - 'XPC_FLAGS': '0x0', 16:37:52 INFO - 'XPC_SERVICE_NAME': '0', 16:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-AAXJ0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-xCjR2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-rQUufN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-e8vylM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-gwZEkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-dUD840-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ZRvCoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-fp_DCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-n1hvOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-uQ6yRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-zSxhzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-9UJvQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-WpXmjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-dTe0x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-LRRZ4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-EsWjbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-0cWuhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:54 INFO - Running setup.py install for manifestparser 16:37:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:54 INFO - Running setup.py install for mozcrash 16:37:54 INFO - Running setup.py install for mozdebug 16:37:54 INFO - Running setup.py install for mozdevice 16:37:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:54 INFO - Running setup.py install for mozfile 16:37:54 INFO - Running setup.py install for mozhttpd 16:37:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Running setup.py install for mozinfo 16:37:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Running setup.py install for mozInstall 16:37:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Running setup.py install for mozleak 16:37:55 INFO - Running setup.py install for mozlog 16:37:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Running setup.py install for moznetwork 16:37:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:55 INFO - Running setup.py install for mozprocess 16:37:55 INFO - Running setup.py install for mozprofile 16:37:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:56 INFO - Running setup.py install for mozrunner 16:37:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:56 INFO - Running setup.py install for mozscreenshot 16:37:56 INFO - Running setup.py install for moztest 16:37:56 INFO - Running setup.py install for mozversion 16:37:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:56 INFO - Cleaning up... 16:37:56 INFO - Return code: 0 16:37:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:56 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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:37:56 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 16:37:56 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 16:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:56 INFO - 'HOME': '/Users/cltbld', 16:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:56 INFO - 'LOGNAME': 'cltbld', 16:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:56 INFO - 'MOZ_NO_REMOTE': '1', 16:37:56 INFO - 'NO_EM_RESTART': '1', 16:37:56 INFO - 'PAGER': '/bin/cat', 16:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:56 INFO - 'PWD': '/builds/slave/test', 16:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:56 INFO - 'SHELL': '/bin/bash', 16:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:37:56 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:56 INFO - 'USER': 'cltbld', 16:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:56 INFO - 'XPC_FLAGS': '0x0', 16:37:56 INFO - 'XPC_SERVICE_NAME': '0', 16:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-xKux8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37: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)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-fxPvYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37: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)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-iZGQtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37: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)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-BpsIrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-9Doztv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-TI9COb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-1N3aky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5qs8lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-7jBWxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-qsUZX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37: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)) 16:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-LhWXsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37: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)) 16:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-EF8bcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37: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)) 16:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-He82u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37: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)) 16:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-GteJBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:58 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)) 16:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-2h7X45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-2D5CgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-0O3plS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:01 INFO - Downloading blessings-1.6.tar.gz 16:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:01 INFO - Installing collected packages: blessings 16:38:01 INFO - Running setup.py install for blessings 16:38:01 INFO - Successfully installed blessings 16:38:01 INFO - Cleaning up... 16:38:01 INFO - Return code: 0 16:38:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:01 INFO - Reading from file tmpfile_stdout 16:38:01 INFO - Current package versions: 16:38:01 INFO - blessings == 1.6 16:38:01 INFO - blobuploader == 1.2.4 16:38:01 INFO - docopt == 0.6.1 16:38:01 INFO - functools32 == 3.2.3-2 16:38:01 INFO - jsonschema == 2.5.1 16:38:01 INFO - manifestparser == 1.1 16:38:01 INFO - mozInstall == 1.12 16:38:01 INFO - mozcrash == 0.17 16:38:01 INFO - mozdebug == 0.1 16:38:01 INFO - mozdevice == 0.48 16:38:01 INFO - mozfile == 1.2 16:38:01 INFO - mozhttpd == 0.7 16:38:01 INFO - mozinfo == 0.9 16:38:01 INFO - mozleak == 0.1 16:38:01 INFO - mozlog == 3.2 16:38:01 INFO - moznetwork == 0.27 16:38:01 INFO - mozprocess == 0.22 16:38:01 INFO - mozprofile == 0.28 16:38:01 INFO - mozrunner == 6.11 16:38:01 INFO - mozscreenshot == 0.1 16:38:01 INFO - mozsystemmonitor == 0.3 16:38:01 INFO - moztest == 0.7 16:38:01 INFO - mozversion == 1.4 16:38:01 INFO - psutil == 3.1.1 16:38:01 INFO - requests == 1.2.3 16:38:01 INFO - wsgiref == 0.1.2 16:38:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:01 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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:38:01 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 16:38:01 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 16:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:01 INFO - 'HOME': '/Users/cltbld', 16:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:01 INFO - 'LOGNAME': 'cltbld', 16:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:01 INFO - 'MOZ_NO_REMOTE': '1', 16:38:01 INFO - 'NO_EM_RESTART': '1', 16:38:01 INFO - 'PAGER': '/bin/cat', 16:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:01 INFO - 'PWD': '/builds/slave/test', 16:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:01 INFO - 'SHELL': '/bin/bash', 16:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:38:01 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:01 INFO - 'USER': 'cltbld', 16:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:01 INFO - 'XPC_FLAGS': '0x0', 16:38:01 INFO - 'XPC_SERVICE_NAME': '0', 16:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:38:01 INFO - Cleaning up... 16:38:02 INFO - Return code: 0 16:38:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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 0x1021e6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb48d8bac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, '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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 16:38: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 16:38: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 16:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:02 INFO - 'HOME': '/Users/cltbld', 16:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:02 INFO - 'LOGNAME': 'cltbld', 16:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:02 INFO - 'MOZ_NO_REMOTE': '1', 16:38:02 INFO - 'NO_EM_RESTART': '1', 16:38:02 INFO - 'PAGER': '/bin/cat', 16:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:02 INFO - 'PWD': '/builds/slave/test', 16:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:02 INFO - 'SHELL': '/bin/bash', 16:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:38:02 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:02 INFO - 'USER': 'cltbld', 16:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:02 INFO - 'XPC_FLAGS': '0x0', 16:38:02 INFO - 'XPC_SERVICE_NAME': '0', 16:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:38:02 INFO - Cleaning up... 16:38:02 INFO - Return code: 0 16:38:02 INFO - Running post-action listener: _resource_record_post_action 16:38:02 INFO - Running post-action listener: _start_resource_monitoring 16:38:02 INFO - Starting resource monitoring. 16:38:02 INFO - ##### 16:38:02 INFO - ##### Finished create-virtualenv step (success) 16:38:02 INFO - ##### 16:38:02 INFO - ##### 16:38:02 INFO - ##### Running install step. 16:38:02 INFO - ##### 16:38:02 INFO - Running pre-action listener: _resource_record_pre_action 16:38:02 INFO - Running main action method: install 16:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:02 INFO - Reading from file tmpfile_stdout 16:38:02 INFO - Detecting whether we're running mozinstall >=1.0... 16:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:38:02 INFO - Reading from file tmpfile_stdout 16:38:02 INFO - Output received: 16:38:02 INFO - Usage: mozinstall [options] installer 16:38:02 INFO - Options: 16:38:02 INFO - -h, --help show this help message and exit 16:38:02 INFO - -d DEST, --destination=DEST 16:38:02 INFO - Directory to install application into. [default: 16:38:02 INFO - "/builds/slave/test"] 16:38:02 INFO - --app=APP Application being installed. [default: firefox] 16:38:02 INFO - mkdir: /builds/slave/test/build/application 16:38:02 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'] 16:38:02 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 16:38:36 INFO - Reading from file tmpfile_stdout 16:38:36 INFO - Output received: 16:38:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:38:36 INFO - Running post-action listener: _resource_record_post_action 16:38:36 INFO - ##### 16:38:36 INFO - ##### Finished install step (success) 16:38:36 INFO - ##### 16:38:36 INFO - ##### 16:38:36 INFO - ##### Running run-tests step. 16:38:36 INFO - ##### 16:38:36 INFO - Running pre-action listener: _resource_record_pre_action 16:38:36 INFO - Running main action method: run_tests 16:38:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:38:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:38:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:38:36 INFO - 2016-07-04 16:38:36.460 screenresolution[1652:10123] starting screenresolution argv=screenresolution get 16:38:36 INFO - 2016-07-04 16:38:36.463 screenresolution[1652:10123] Display 0: 1600x1200x32@60 16:38:36 INFO - 2016-07-04 16:38:36.468 screenresolution[1653:10125] starting screenresolution argv=screenresolution list 16:38:36 INFO - Available Modes on Display 0 16:38:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:38:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:38:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:38:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:38:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:38:36 INFO - Intel Iris: 16:38:36 INFO - Chipset Model: Intel Iris 16:38:36 INFO - Type: GPU 16:38:36 INFO - Bus: Built-In 16:38:36 INFO - VRAM (Dynamic, Max): 1536 MB 16:38:36 INFO - Vendor: Intel (0x8086) 16:38:36 INFO - Device ID: 0x0a2e 16:38:36 INFO - Revision ID: 0x0009 16:38:36 INFO - Displays: 16:38:36 INFO - Display: 16:38:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:38:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:38:36 INFO - Display Serial Number: 1600x1200 60 16:38:36 INFO - Main Display: Yes 16:38:36 INFO - Mirror: Off 16:38:36 INFO - Online: Yes 16:38:36 INFO - Rotation: Supported 16:38:36 INFO - Return code: 0 16:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:36 INFO - Python 2.7.3 16:38:36 INFO - Return code: 0 16:38:36 INFO - grabbing minidump binary from tooltool 16:38: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')]} 16:38:36 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 0x10214ad30>, '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 0x101eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102142b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:36 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 16:38:36 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 16:38:36 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 16:38:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:36 INFO - Return code: 0 16:38:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:38:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:38:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0295 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OW2d8KMAP9/Render', 16:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:36 INFO - 'HOME': '/Users/cltbld', 16:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:36 INFO - 'LOGNAME': 'cltbld', 16:38:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:36 INFO - 'MOZ_NO_REMOTE': '1', 16:38:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:36 INFO - 'NO_EM_RESTART': '1', 16:38:36 INFO - 'PAGER': '/bin/cat', 16:38:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:36 INFO - 'PWD': '/builds/slave/test', 16:38:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:36 INFO - 'SHELL': '/bin/bash', 16:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfvwjbZNaI/Listeners', 16:38:36 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 16:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:36 INFO - 'USER': 'cltbld', 16:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:36 INFO - 'XPC_FLAGS': '0x0', 16:38:36 INFO - 'XPC_SERVICE_NAME': '0', 16:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:38:37 INFO - mozversion application_buildid: 20160704144723 16:38:37 INFO - mozversion application_changeset: e8324c74d19778e079499c0ec3bc6cfe66de3be0 16:38:37 INFO - mozversion application_display_name: Nightly 16:38:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:37 INFO - mozversion application_name: Firefox 16:38:37 INFO - mozversion application_remotingname: firefox 16:38:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:38:37 INFO - mozversion application_vendor: Mozilla 16:38:37 INFO - mozversion application_version: 50.0a1 16:38:37 INFO - mozversion platform_buildid: 20160704144723 16:38:37 INFO - mozversion platform_changeset: e8324c74d19778e079499c0ec3bc6cfe66de3be0 16:38:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:38:37 INFO - mozversion platform_version: 50.0a1 16:38:37 INFO - using testdate: 1467675517 16:38:37 INFO - actual date: 1467675517 16:38:37 INFO - starting webserver on 'localhost:49278' 16:38:37 INFO - SUITE-START | Running 2 tests 16:38:37 INFO - TEST-START | dromaeo_css 16:38:37 INFO - operating with platform_type : mac_ 16:38:37 INFO - Initialising browser for dromaeo_css test... 16:38:37 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpZdXPZi/profile http://localhost:49278/getInfo.html) 16:38:39 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 16:38:39 INFO - PROCESS | 1663 | colorDepth:24 16:38:39 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 16:38:39 INFO - PROCESS | 1663 | __metrics 16:38:39 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:38:39 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:40 INFO - TEST-INFO | 1663: exit 0 16:38:40 INFO - Browser initialized. 16:38:40 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:40 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpZdXPZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:52 INFO - PROCESS | 1666 | RSS: Main: 244756480 16:38:52 INFO - PROCESS | 1666 | 16:39:43 INFO - PROCESS | 1666 | 1467675583156 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] 16:41:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 16:41:55 INFO - PROCESS | 1666 | RSS: Main: 346214400 16:41:55 INFO - PROCESS | 1666 | 16:44:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 16:44:59 INFO - PROCESS | 1666 | RSS: Main: 370233344 16:44:59 INFO - PROCESS | 1666 | 16:48:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 16:48:02 INFO - PROCESS | 1666 | RSS: Main: 370061312 16:48:02 INFO - PROCESS | 1666 | 16:51:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 16:51:05 INFO - PROCESS | 1666 | RSS: Main: 370192384 16:51:05 INFO - PROCESS | 1666 | 16:54:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 16:54:09 INFO - PROCESS | 1666 | RSS: Main: 341078016 16:54:09 INFO - PROCESS | 1666 | 16:57:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 16:57:13 INFO - PROCESS | 1666 | RSS: Main: 380731392 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | __start_tp_report 16:57:13 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 16:57:13 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 16:57:13 INFO - PROCESS | 1666 | |i|pagename|runs| 16:57:13 INFO - PROCESS | 1666 | |0;dojo.html;2835.8723857426417;3369.5282660427542;3405.812680302583;3430.382531144396;3462.948055779162;5560.77756889725;5627.718614069296;5669.659820410768;5770.798022069223;5778.364379918216;5716.542676585863;5740.7129643517865;5747.626404283718;5755.740991655375;5766.0486019806685;5179.249008893708;5213.504717051893;5236.7119808410525;5254.92117618236;5293.602979776513;5282.894342113174;5307.310049693534;5332.600054995872;5367.543758780508;5375.16684913839;5279.260903473517;5280.287161233223;5283.682979021271;5328.6269961102735;5357.839264822042;5337.919931201016;5362.249285100089;5367.141257398836;5380.569554435636;5389.8113566025395;5163.380394352702;5165.483451654842;5178.741062946875;5276.261323414725;5283.181106928432;5711.171880077365;5712.428757124254;5716;5735.369109397963;5777.393373695743;6333.778317758856;6347.8413039673915;6348.682565871688;6354.650494222816;6356.300806911236;6147.907781383283;6203;6295.307516173218;6296.716647750863;6305.148804911324;5954.910676339815;5956.493698035672;5986.07215881539;5989.550783691154;5991.400859913973;6397.584157029872;6406.615603063738;6409.711562979677;6416.422521973045;6448.387403196689;6069.908951365733;6142.867137759775;6230.158928544589;6230.875382492325;6252.968735156386;5473.06957817172;6203;6286.465650419674;6292.402221788922;6324.620522768557;6228.781992630236;6286.371362863677;6306.243250809932;6318.905216421757;6321.367863213642;6143.849652621636;6213.1922850029205;6215.96892015537;6308.905366419507;6310.747570097236;4981.452040275567;5011.072951503984;5021.949780502221;5026.89946201074;5070.619703522177;4495.4605447345875;4495.730256184639;4507.121111383249;4535.138323718483;4545.113702827917;5738.913916291259;5813.069908814569;5836.445537673914;5886.705664716747;5886.705664716833;6253.741469449662;6282;6282.057691346243;6292.779752708633;6320.71556779946;5912.556558258148;5926.288845338587;5943.851403714855;5950.315713692894;5969.552283578662;5373.247745315659;5406.243125962368;5472.097103977799;5476.17857321397;5505.917411238835;6429.967850160906;6461.450776683847;6463.8060858173385;6499.1876015498065;6518.315576864456;6185.319614842454;6254.8123556293385;6283.057541368831;6284.968575157095;6305.148804911279;6358.173437453286;6400.679966001774;6420.775272865428;6475.417212450902;6516.446102081187;6259.937400625936;6269.7178626962805;6271.404216599416;6281.685915704105;6295.496360291074;4721.126591580569;5056.494350564914;6251.249850017845;6254.937450625435;6284.968575157095;6130.724117414817;6139.324674285915;6148.555089553862;6224.37756224374;6233.127362169391;6188.938110619017;6194.473469755121;6211.130441738251;6213.440790328892;6222.191115155001;5864.296284445893;5995.850103747267;6043.879122417615;6090;6099.085137229451;5179.689218646742;6120.233815636221;6198.442140207403;6210.503159747119;6230.59501132425;6071.150038994456;6072.757089716361;6114.327423983447;6119.816405507842;6131.662758548323 16:57:13 INFO - PROCESS | 1666 | |1;ext.html;492.8595350325158;500.0898364975743;515.9974200128999;526.8682829292677;553.3166539323935;31401.371972560533;33293.66706332936;33344.4998325025;33442.82950096747;33453.66546334536;45500.77249613747;46616.27069834414;46735.065298694004;49385.75307123459;49442.01115977678;9826.557804898779;10012.098911097999;10017.248706347016;10024.248181386389;10042.648507302245;9021.639134434648;9227.907720922773;9866.16137628299;9985.650502232424;9987.101160895518;12133.393330333492;12404.689882752959;12408.131430799847;12409;12424.751504969896;12317.199382040139;12318.199317044408;12375.381230938507;12377.690557735994;12382.566610168691;8897.332700047458;9095.954520227422;9103.953045399798;12148.088893332946;12244.510219591206;34502.309953801036;43336.783316083216;43450.91372715676;43569;45858.312125318145;2997.565353023799;3493.7903725776537;3539.004623875126;3715.294094122108;3960.0891794887048;31878.521822172686;32903.506447403306;34432.13919652004;34443.65556344429;34484.82757586196;3269.4441944869427;3387.2717365766234;3482.791032538056;3487.424574945131;3492.4062909305226;555292.2235388837;556796;559146;560580;561391;68533.97199042018;68897;69047.3095269041;69076.65461672659;69251.65374173097;71145.64427177934;71251.2874871255;71315.28684713191;71477;71527;14661.266936653125;15786.526404207892;17510.21204045821;17774.555636109202;17801.931884086996;12093.818592721116;12398.690032749253;12408.689782755322;12410.75178496425;12415.193012454161;7871.921280787234;7880.093789214314;7926.960365198137;14143.74855558124;19511.609767804566;6879.415249703831;6887.552309099892;7934.563599001995;8190.672373105128;8204.056533498604;916.3814425262921;1000.9949950250348;1039.5893622019412;1046.8900765419673;1118.983215251772;30451.847740761154;31958;32261;32559.186020349207;32841.67158328434;865.8095219051798;1035.177034257767;1088.3089238333557;1164.2723297938787;1210.9818352724717;16507.504774856774;16737.079460629782;16919.830801691827;16922.83077169237;17213.655726885394;671774;684042;686647;687344;689668;65613.67193164004;66147.66926165338;66240.33759662438;66248.66875665591;66347.68261586901;1265.4495294546903;1389.9861001389856;1412.9364178611986;1438.4461982136952;1443.45870298638;33401.66598333986;33730.66269337275;33847;34030.65969340275;34252.828735856165;45406.31890521711;56198;56521.43478565162;56528;56585.71707141438;543946.280268612;552408;553497;554465;555449;24889.377765556004;28048.859755701906;28208.85895570509;28378.86484540595;28696.99560515372;51493.742531287106;52487.73756131195;52518.40343100646;53352;53444;41567.58432415758;42774.78612606917;43072.13855722931;44469.55530444654;44573.88565285894;42234;42300;42676.146477070906;43017.569824301354;44033.77983110064;41931.371029433976;42152.57847421609;42202.577974219865;42466;42776;34067.4889876657;34660.133496662784;35833;37131;38429.4235586472;22820;27071;27682.169534913985;27856.44287114206;27989.160325189463 16:57:13 INFO - PROCESS | 1666 | |2;jquery.html;371.0797222887241;391.7199202570162;401.42796514966176;402.5652295520838;423.95124560675515;14580.03790457255;16961.40635077771;18687.906560467178;21305.57388852222;22260.109595616155;21436.4640883978;22043;22231.66652500214;22296.331110066723;22434.88782556089;1638.5412084616266;1648.6290584618484;1652.7603497492855;1653.966920661586;1779.6262784815203;5753.338366087891;6104.481119104881;6109.450149486545;6125.418085281914;6135.693215339237;5772.797952071678;6036.788712395067;6076.787312444066;6079.604825686316;6081.087836824468;6043.335233124353;6073.240844894388;6107.603005804608;6108.938910610904;6114.235720534955;5161.7161056141895;5217.295665085203;5277.129273669878;5278.736063196863;5487.2317875497465;13470.39383227757;13657.453701851913;13699.520516781964;13721.382537785823;23524.88237558801;2073.170731707314;2231.364061242538;2401.7238017628024;2414.915477958263;2921.24047747585;10029.1475224606;10145;10427.217958653131;10515.789684206273;10738.355698658028;1826.1782198010815;1838.3565751986832;1850.5836186857848;1880.576870204207;1916.2239293086323;67696.66151669259;92014.3992800364;105613.47193264062;123287.3835630825;124385;11175.720606984727;11465.713357166138;11600.187986841009;11713.062954963583;11890.940545297392;13167.934160329138;14613.634659133395;14730.189839558927;14750.40998360075;14751.852481475047;7900.9604951976025;8314.708985185489;8667.739967800977;8700.912990870136;8704.91295087041;8708.042115367305;8712.651493940299;8737.51943643093;8837.425567338103;8845.469271843709;4610.538946105363;4622.098690755338;4626.768661566908;4635.351050852883;4712.363830882787;1891.810818918097;1934.5067007913174;1935.7448572413261;1939.1177014458387;1943.9514012149527;792.2117493094408;846.4328899637258;897.5108565831638;908.5366463103865;926.4626516620344;19823.900880495792;21460.14159433605;22143.44641383946;22179.001944912518;22383.77616223817;941.665708673411;942.2650332740474;973.0755782007121;979.7991411760572;1032.4218437674926;10917.672469825919;11236.887631123747;11425.028872545927;11429.657110286706;11480;597884;607082;611354;644944.77527613;645940;131196;134627.32686336702;140601.29699351438;141363;144588;982.1455333859587;1005.7435353984687;1012.7012531303283;1013.5996281468779;1015.9339642923334;18971;19254;19343.322983695503;19407.417777466697;19418.931958742403;57310;57497;58311;58576.4142358588;59302.70348648402;78174.21825781897;79888;80063.59968200122;83695;90769.54615227146;7629.46593738433;7979.521228726295;8106.892208025838;8128.83742325162;8191.05802832658;9179.449233046038;11976;12756.553520626734;13000.349982501026;13047.217166970013;10974.890251097388;11122.443877805916;11151.052160566443;11180.329180249211;11296.548138074386;10793.56825726962;10994;11027.724306892393;11054.447277636247;11207.66377008691;9638.807223855343;11220.607278745205;11303.03924166455;11547.0762339011;11580.710482237675;6971.860562788817;7294.905764135422;7351.77944661661;7994.52032878006;8292.33661307082;8279.420440569102;10586.947065264625;11283.266587671775;11517.712057198638;11602.187846850977 16:57:13 INFO - PROCESS | 1666 | |3;mootools.html;1420.8152940117784;1579.0999130495616;1614.402671011726;1848.3992702371725;1961.5096225943514;7915.485493442922;8697.260732837709;8927.910720892789;8928.91071089289;9080.8637870432;8670.306375489961;8911.91088089119;8916.73249802507;8921.732348029553;8925.598348074336;2369.656399822025;2398.6641870138196;2398.7721166489155;2403.4231784371714;2403.8557686538775;2341.203990643181;2385.5348207099623;2387.85672859629;2390.8206884483648;2392.4138586046356;2344.601417758985;2370.20598099636;2381.714194296687;2382.4758553118286;2383.940401489959;1935.8354539864058;2331.6735657008035;2359.9056037758555;2363.9409014774683;2376.916807911732;2274.704288442492;2357.599208134621;2363.7990770784504;2367.4673198530195;2369.6327069304284;8095.150009249003;8276.462029968034;9056.818863622757;9118.58966346516;9130.041345658743;5159.303494028296;5402.91895621566;5405.00007498614;5407.972485227794;5468.425815289377;3011.864466099031;3622.5366750609574;3655.707543396522;3715.145516531213;3757.3092108550986;1102.7684186320882;1104.3705088099707;1105.8562386889732;1113.192935122038;1126.9774604507945;11790.823137652942;11991.880081199164;12040.81938770919;12046.698832529257;12088.153829231956;4051.837926482967;4674;4777.077833675726;4817.638677099231;4909.607231421478;10373.377597344033;10426.739331516772;10429.478526073666;10437.32157409766;10438.478076096164;5446.645968012067;5447.809326673548;5448.700321482356;5449.2371068049715;5457.426970168154;4774.522547745198;4923.08922849274;4960.280759289883;4972.950270497248;4989.925151122736;3781.489498917611;3808.562015368268;3837.501124853751;3873.593272706325;3909.354956432157;1181.3915833345834;1183.8638556566104;1189.637160665988;1192.7077865922904;1200.6578125234266;871.8082021955287;944.5702205496483;959.0744931141481;960.4381436859376;1022.1873610479687;5944;6041.093835924647;6093.878122437526;6138.324784273726;6153.600015998945;427.79679652165595;442.85828534869177;451.668024002358;457.31174582253493;463.38369967942555;3988.581198974066;4119;4140.979295103505;4166.375043743463;4171.144915292358;9917.702468925943;10472.371657700562;10475.42385168823;10821.513031913582;10868.130549556017;10630.521626526825;10871.619493317854;10874.891251087545;10970.122390208764;10979.1765617579;8215.424920255524;8322.042965058974;8369.163083691705;8376.078631350547;8394;5997.190379298913;5999.610025348338;6130.5402094842175;6136.7852125175405;6297.590656607306;9700.563474643517;9924.503774811086;10049.346792458467;10351.327163734333;10395.58417663285;10158.847617285599;10257.384556926609;10369;10418.843717344094;10567.154627629925;7537.2462753724185;7661.310482056641;7669.69321227167;7676.577788221478;7704.6918123274445;8244.83510329778;8297.792555186168;8360.958195208985;8362.45644033136;8366.205210504992;7499.700011999459;7657.272559106876;7688.884666730115;7783.377329813715;7790.610469476617;7402.555846649218;7483.700651974078;7490.887636685563;7648.80877978055;7668.348190403655;7055.400290975324;7137.536060156073;7137.678804453708;7146.106736657918;7146.964265178641;4924.310596516562;5056.191009438472;5078.746062696924;5130.666506677054;5140;5140.485951404829;5166.173412254021;5178.326817513699;5248.212768084818;5299.549538289134 16:57:13 INFO - PROCESS | 1666 | |4;prototype.html;310.9191610181353;315.6701247196679;321.37011457543224;321.76028858500433;326.8806885486798;4803.606953983341;5313.973430132849;5469.003813608034;5501.927124210781;5595.608307418483;5365.892682146355;5401.70290634015;5477.808276710316;5494.736210671548;5496.680796608815;3411.573553305837;3488.5639295088113;3936.4882565266475;4061.614146656063;4243.8090285937205;3341.665833416663;3386.4920261960656;4121.670266378683;4210.3894935234375;4218.029853133781;3339.482380231068;4015.3135683013206;4113.444684967521;4148.668106551484;4155.33514637658;3811.599782022903;3853.959430953627;4121.752694838305;4132.648724858361;4158.958410415902;2931.618889544367;3547.9113022174392;3552.8223588820715;3578.2306804037;3588.810825396506;5217.087009773274;5229.738513074331;5233.555147812441;5235.764390602432;5294.338207724035;3986.923530646709;4412.903870661442;4729.834455794031;4743.169945259566;4814.831480898187;4488.640908727294;5477.452254774491;5598.636088654224;5616.691081990489;5625;3954.8615798447204;3957.9814294709618;3971.483707118085;3976;3977.164795392971;5029.371328583927;5599.972000139973;5713.8285851424525;5976.342602313742;6018.909716354215;4013.1371755072214;4015.397690346413;4024.2555127301544;4048.554658987509;4055.5602761020004;3616.258666973264;4100.913257986636;4112.177564487115;4113.6297733203555;4120.320147175682;3921.0983871934563;4510.481294651091;4655.883602909887;4723.622110231173;4767.284907263938;5151.789329507563;5368.248445217672;5392.703401312887;5569.860753481114;5571.4150014248735;1356.8982326325565;1367.9658008549666;1374.2510331869155;1377.3801789194902;1387.6600232942792;809.753025327269;846.5132548784474;847.4406891451613;862.9482231066156;866.5147517390282;4318.654507639381;4344.261475549164;4707.870111173363;5092.821751238689;5153.536181743586;4788.449328327218;4997.350344455198;5745.827625171251;5761.884762304814;5854.7072646367515;4555.246230201396;4941.034260568106;5202.609804264695;5237.502437268454;5352.625316227826;3028.364043550879;3065.754739620825;3076.292452735883;3077.938441231163;3081;5500.4499550045475;6055.364186760415;6071;6079.787207447718;6113.349395663146;5380.892382152335;5494.7636781723795;5712.857178570569;6049.8487537811025;6057.606255593372;5059.519345662156;5096.872578185575;5301.893962120736;5509.090999984957;5970.611910225908;4881.389826271716;5453.318335208099;5626.803061892814;5871.266091738533;5913.438223368773;5754.251947246831;5793;5810.767569297181;5824.912626310524;5847.853803654943;6017.615948331821;6030.773536158134;6065.787697430569;6075.483583895241;6080.574359794772;3179.7138257556007;3957.109650328768;3984.8406063757125;3984.86052988144;4001.339778936443;5299.343453017405;5398.40617532079;5688.132070192143;5732.455416735404;5744.138379243147;4784.258439941815;5513.466542147568;5649;5679.74441150141;5706.942930570641;5309.230161626465;5427.2632757518795;5590.3166480090595;5651.519620832275;5658.519025882846;5157.742112894415;5491.75287112073;5522.337319521683;5530.253415788978;5538.584606154474;4627.629789616755;4835.44392394865;5449.209864569536;5600.663960162403;5611.166360987675;5359.4104648487855;5565.024416332144;5592.636478628876;5593.580481463988;5598.300212473441 16:57:13 INFO - PROCESS | 1666 | |5;yui.html;786.4101923557332;824.3281725393804;847.8134810341725;849.2314455417845;866.9393142480021;15293.388264469422;15968.121753303563;16685.249163787645;16732.665346693073;16860.578485537866;15030.699386012273;15052.774208386883;15247.695046099072;15256.771148432783;15354.616134596641;754.2156157596094;763.900692909921;910.0899100899101;927.8422668146397;930.6324002019198;933.8179055084262;934.7149119518544;944.5607792376544;945.6075728572634;949.6486300068949;1005.7586179316947;1006.7483129217695;1007.0433088565892;1008.541113793226;1008.7175590834578;729.1468981291902;782.2451334462243;806.891069705594;808.3775492870516;1005.6027868991744;712.7612249896291;719.7229066809264;723.9022731931175;739.1684355100512;742.1242933338658;15463;15469.381224750996;15476.226188690633;15516.301766420538;15530;14184.858151418457;14352.64118397038;14373.496927607484;14402.855971440256;14593.78109328361;12528.624141275777;12910.548130815376;13214.867851321556;13485.528006519724;13488.055836091478;4308.224519586473;4644.303354496818;4660.300954856799;4728.6453515986095;4778.283257511366;113772.43113784461;114067.28899066521;115089;115133;115404.42297788458;9999;11023.779524409467;11739.178257522062;11818.822717659243;11941.522339106512;23714.170004049774;23964.64053039206;24138.758612414003;24188.274351769476;24197.274081777574;8455.365847561334;8477.23704866565;8563.400561960727;8569.314454843598;8593.312534997185;4467.843625473093;4592.816287348469;4593.035462552834;4608.423947006624;4755.881102972453;2985.4775414302844;3709.4250391189407;3710.4805327254207;3710.6474884885893;3718.330700473941;674.0832467843728;682.9726810927607;686.5983399711125;699.6641612026256;708.6350529477323;518.7399766369022;598.9251343582052;687.52560733094;705.6401235369896;718.3786025088261;9578;9698.806023879482;9732.318737688294;9846.803063938682;9857.950710246403;630.5151368527053;630.9305976342598;659.0378048049901;671.9496037797185;687.8693048320803;4430.180416622935;4706.364640773451;4735.952640473552;4763.071201115749;4764.190087685032;124743.376283118;134253;136411;136616;139551;127974;128882;130638;134250;136731.31634341765;112397;113670;114044;114270.42864785623;115202;9139.360244783067;9451.574679139318;9766.876809166752;9823.36148150368;9866.753331166778;63713.681431592544;63719.362806373196;63778.724425512155;65946;66722;82739.5863020681;97164.02835971549;97350.0264997341;97430.51284743531;98211.50894245484;13374.331283435984;13499.257540835348;13795.448182072605;13872.791908121184;14251.35868885882;15025.098494090389;15393.461228856937;15632.131333369829;15664.608384790472;16113.758293625839;14136.717265654836;14231.146131232159;14498.34757435939;14715.411383544539;14755.92622036926;14165.716685666435;14200.360983755962;14511.564653060424;14747.778783318045;14903.791131965609;13571.321433928462;14272.486509090118;14315.056883331938;14322.212278324376;14653.780193297322;11018.228723989243;11636.941815291208;11638.12714046433;11681.532738690697;11929.045676346044;11263.943680281545;11306.49120789583;11624.302541847515;11661.6501504955;11670.70823229426 16:57:13 INFO - PROCESS | 1666 | __end_tp_report 16:57:13 INFO - PROCESS | 1666 | __start_cc_report 16:57:13 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1115 16:57:13 INFO - PROCESS | 1666 | __end_cc_report 16:57:13 INFO - PROCESS | 1666 | __startTimestamp1467676633036__endTimestamp 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | ------- Summary: start ------- 16:57:13 INFO - PROCESS | 1666 | Number of tests: 6 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5800.90 Median:6069.91 stddev:663.48 (10.9%) stddev-sans-first:623.41 16:57:13 INFO - PROCESS | 1666 | Values: 2835.9 3369.5 3405.8 3430.4 3462.9 5560.8 5627.7 5669.7 5770.8 5778.4 5716.5 5740.7 5747.6 5755.7 5766.0 5179.2 5213.5 5236.7 5254.9 5293.6 5282.9 5307.3 5332.6 5367.5 5375.2 5279.3 5280.3 5283.7 5328.6 5357.8 5337.9 5362.2 5367.1 5380.6 5389.8 5163.4 5165.5 5178.7 5276.3 5283.2 5711.2 5712.4 5716.0 5735.4 5777.4 6333.8 6347.8 6348.7 6354.7 6356.3 6147.9 6203.0 6295.3 6296.7 6305.1 5954.9 5956.5 5986.1 5989.6 5991.4 6397.6 6406.6 6409.7 6416.4 6448.4 6069.9 6142.9 6230.2 6230.9 6253.0 5473.1 6203.0 6286.5 6292.4 6324.6 6228.8 6286.4 6306.2 6318.9 6321.4 6143.8 6213.2 6216.0 6308.9 6310.7 4981.5 5011.1 5021.9 5026.9 5070.6 4495.5 4495.7 4507.1 4535.1 4545.1 5738.9 5813.1 5836.4 5886.7 5886.7 6253.7 6282.0 6282.1 6292.8 6320.7 5912.6 5926.3 5943.9 5950.3 5969.6 5373.2 5406.2 5472.1 5476.2 5505.9 6430.0 6461.5 6463.8 6499.2 6518.3 6185.3 6254.8 6283.1 6285.0 6305.1 6358.2 6400.7 6420.8 6475.4 6516.4 6259.9 6269.7 6271.4 6281.7 6295.5 4721.1 5056.5 6251.2 6254.9 6285.0 6130.7 6139.3 6148.6 6224.4 6233.1 6188.9 6194.5 6211.1 6213.4 6222.2 5864.3 5995.9 6043.9 6090.0 6099.1 5179.7 6120.2 6198.4 6210.5 6230.6 6071.2 6072.8 6114.3 6119.8 6131.7 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:74426.78 Median:21194.76 stddev:160597.56 (757.7%) stddev-sans-first:160952.14 16:57:13 INFO - PROCESS | 1666 | Values: 492.9 500.1 516.0 526.9 553.3 31401.4 33293.7 33344.5 33442.8 33453.7 45500.8 46616.3 46735.1 49385.8 49442.0 9826.6 10012.1 10017.2 10024.2 10042.6 9021.6 9227.9 9866.2 9985.7 9987.1 12133.4 12404.7 12408.1 12409.0 12424.8 12317.2 12318.2 12375.4 12377.7 12382.6 8897.3 9096.0 9104.0 12148.1 12244.5 34502.3 43336.8 43450.9 43569.0 45858.3 2997.6 3493.8 3539.0 3715.3 3960.1 31878.5 32903.5 34432.1 34443.7 34484.8 3269.4 3387.3 3482.8 3487.4 3492.4 555292.2 556796.0 559146.0 560580.0 561391.0 68534.0 68897.0 69047.3 69076.7 69251.7 71145.6 71251.3 71315.3 71477.0 71527.0 14661.3 15786.5 17510.2 17774.6 17801.9 12093.8 12398.7 12408.7 12410.8 12415.2 7871.9 7880.1 7927.0 14143.7 19511.6 6879.4 6887.6 7934.6 8190.7 8204.1 916.4 1001.0 1039.6 1046.9 1119.0 30451.8 31958.0 32261.0 32559.2 32841.7 865.8 1035.2 1088.3 1164.3 1211.0 16507.5 16737.1 16919.8 16922.8 17213.7 671774.0 684042.0 686647.0 687344.0 689668.0 65613.7 66147.7 66240.3 66248.7 66347.7 1265.4 1390.0 1412.9 1438.4 1443.5 33401.7 33730.7 33847.0 34030.7 34252.8 45406.3 56198.0 56521.4 56528.0 56585.7 543946.3 552408.0 553497.0 554465.0 555449.0 24889.4 28048.9 28208.9 28378.9 28697.0 51493.7 52487.7 52518.4 53352.0 53444.0 41567.6 42774.8 43072.1 44469.6 44573.9 42234.0 42300.0 42676.1 43017.6 44033.8 41931.4 42152.6 42202.6 42466.0 42776.0 34067.5 34660.1 35833.0 37131.0 38429.4 22820.0 27071.0 27682.2 27856.4 27989.2 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:35446.92 Median:22245.89 stddev:103749.65 (466.4%) stddev-sans-first:104007.27 16:57:13 INFO - PROCESS | 1666 | Values: 371.1 391.7 401.4 402.6 424.0 14580.0 16961.4 18687.9 21305.6 22260.1 21436.5 22043.0 22231.7 22296.3 22434.9 1638.5 1648.6 1652.8 1654.0 1779.6 5753.3 6104.5 6109.5 6125.4 6135.7 5772.8 6036.8 6076.8 6079.6 6081.1 6043.3 6073.2 6107.6 6108.9 6114.2 5161.7 5217.3 5277.1 5278.7 5487.2 13470.4 13657.5 13699.5 13721.4 23524.9 2073.2 2231.4 2401.7 2414.9 2921.2 10029.1 10145.0 10427.2 10515.8 10738.4 1826.2 1838.4 1850.6 1880.6 1916.2 67696.7 92014.4 105613.5 123287.4 124385.0 11175.7 11465.7 11600.2 11713.1 11890.9 13167.9 14613.6 14730.2 14750.4 14751.9 7901.0 8314.7 8667.7 8700.9 8704.9 8708.0 8712.7 8737.5 8837.4 8845.5 4610.5 4622.1 4626.8 4635.4 4712.4 1891.8 1934.5 1935.7 1939.1 1944.0 792.2 846.4 897.5 908.5 926.5 19823.9 21460.1 22143.4 22179.0 22383.8 941.7 942.3 973.1 979.8 1032.4 10917.7 11236.9 11425.0 11429.7 11480.0 597884.0 607082.0 611354.0 644944.8 645940.0 131196.0 134627.3 140601.3 141363.0 144588.0 982.1 1005.7 1012.7 1013.6 1015.9 18971.0 19254.0 19343.3 19407.4 19418.9 57310.0 57497.0 58311.0 58576.4 59302.7 78174.2 79888.0 80063.6 83695.0 90769.5 7629.5 7979.5 8106.9 8128.8 8191.1 9179.4 11976.0 12756.6 13000.3 13047.2 10974.9 11122.4 11151.1 11180.3 11296.5 10793.6 10994.0 11027.7 11054.4 11207.7 9638.8 11220.6 11303.0 11547.1 11580.7 6971.9 7294.9 7351.8 7994.5 8292.3 8279.4 10586.9 11283.3 11517.7 11602.2 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5797.61 Median:4775.80 stddev:3281.75 (68.7%) stddev-sans-first:3274.47 16:57:13 INFO - PROCESS | 1666 | Values: 1420.8 1579.1 1614.4 1848.4 1961.5 7915.5 8697.3 8927.9 8928.9 9080.9 8670.3 8911.9 8916.7 8921.7 8925.6 2369.7 2398.7 2398.8 2403.4 2403.9 2341.2 2385.5 2387.9 2390.8 2392.4 2344.6 2370.2 2381.7 2382.5 2383.9 1935.8 2331.7 2359.9 2363.9 2376.9 2274.7 2357.6 2363.8 2367.5 2369.6 8095.2 8276.5 9056.8 9118.6 9130.0 5159.3 5402.9 5405.0 5408.0 5468.4 3011.9 3622.5 3655.7 3715.1 3757.3 1102.8 1104.4 1105.9 1113.2 1127.0 11790.8 11991.9 12040.8 12046.7 12088.2 4051.8 4674.0 4777.1 4817.6 4909.6 10373.4 10426.7 10429.5 10437.3 10438.5 5446.6 5447.8 5448.7 5449.2 5457.4 4774.5 4923.1 4960.3 4973.0 4989.9 3781.5 3808.6 3837.5 3873.6 3909.4 1181.4 1183.9 1189.6 1192.7 1200.7 871.8 944.6 959.1 960.4 1022.2 5944.0 6041.1 6093.9 6138.3 6153.6 427.8 442.9 451.7 457.3 463.4 3988.6 4119.0 4141.0 4166.4 4171.1 9917.7 10472.4 10475.4 10821.5 10868.1 10630.5 10871.6 10874.9 10970.1 10979.2 8215.4 8322.0 8369.2 8376.1 8394.0 5997.2 5999.6 6130.5 6136.8 6297.6 9700.6 9924.5 10049.3 10351.3 10395.6 10158.8 10257.4 10369.0 10418.8 10567.2 7537.2 7661.3 7669.7 7676.6 7704.7 8244.8 8297.8 8361.0 8362.5 8366.2 7499.7 7657.3 7688.9 7783.4 7790.6 7402.6 7483.7 7490.9 7648.8 7668.3 7055.4 7137.5 7137.7 7146.1 7147.0 4924.3 5056.2 5078.7 5130.7 5140.0 5140.5 5166.2 5178.3 5248.2 5299.5 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4570.66 Median:5209.85 stddev:1400.62 (26.9%) stddev-sans-first:1367.56 16:57:13 INFO - PROCESS | 1666 | Values: 310.9 315.7 321.4 321.8 326.9 4803.6 5314.0 5469.0 5501.9 5595.6 5365.9 5401.7 5477.8 5494.7 5496.7 3411.6 3488.6 3936.5 4061.6 4243.8 3341.7 3386.5 4121.7 4210.4 4218.0 3339.5 4015.3 4113.4 4148.7 4155.3 3811.6 3854.0 4121.8 4132.6 4159.0 2931.6 3547.9 3552.8 3578.2 3588.8 5217.1 5229.7 5233.6 5235.8 5294.3 3986.9 4412.9 4729.8 4743.2 4814.8 4488.6 5477.5 5598.6 5616.7 5625.0 3954.9 3958.0 3971.5 3976.0 3977.2 5029.4 5600.0 5713.8 5976.3 6018.9 4013.1 4015.4 4024.3 4048.6 4055.6 3616.3 4100.9 4112.2 4113.6 4120.3 3921.1 4510.5 4655.9 4723.6 4767.3 5151.8 5368.2 5392.7 5569.9 5571.4 1356.9 1368.0 1374.3 1377.4 1387.7 809.8 846.5 847.4 862.9 866.5 4318.7 4344.3 4707.9 5092.8 5153.5 4788.4 4997.4 5745.8 5761.9 5854.7 4555.2 4941.0 5202.6 5237.5 5352.6 3028.4 3065.8 3076.3 3077.9 3081.0 5500.4 6055.4 6071.0 6079.8 6113.3 5380.9 5494.8 5712.9 6049.8 6057.6 5059.5 5096.9 5301.9 5509.1 5970.6 4881.4 5453.3 5626.8 5871.3 5913.4 5754.3 5793.0 5810.8 5824.9 5847.9 6017.6 6030.8 6065.8 6075.5 6080.6 3179.7 3957.1 3984.8 3984.9 4001.3 5299.3 5398.4 5688.1 5732.5 5744.1 4784.3 5513.5 5649.0 5679.7 5706.9 5309.2 5427.3 5590.3 5651.5 5658.5 5157.7 5491.8 5522.3 5530.3 5538.6 4627.6 4835.4 5449.2 5600.7 5611.2 5359.4 5565.0 5592.6 5593.6 5598.3 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:25332.54 Median:23839.41 stddev:39237.05 (164.6%) stddev-sans-first:39303.84 16:57:13 INFO - PROCESS | 1666 | Values: 786.4 824.3 847.8 849.2 866.9 15293.4 15968.1 16685.2 16732.7 16860.6 15030.7 15052.8 15247.7 15256.8 15354.6 754.2 763.9 910.1 927.8 930.6 933.8 934.7 944.6 945.6 949.6 1005.8 1006.7 1007.0 1008.5 1008.7 729.1 782.2 806.9 808.4 1005.6 712.8 719.7 723.9 739.2 742.1 15463.0 15469.4 15476.2 15516.3 15530.0 14184.9 14352.6 14373.5 14402.9 14593.8 12528.6 12910.5 13214.9 13485.5 13488.1 4308.2 4644.3 4660.3 4728.6 4778.3 113772.4 114067.3 115089.0 115133.0 115404.4 9999.0 11023.8 11739.2 11818.8 11941.5 23714.2 23964.6 24138.8 24188.3 24197.3 8455.4 8477.2 8563.4 8569.3 8593.3 4467.8 4592.8 4593.0 4608.4 4755.9 2985.5 3709.4 3710.5 3710.6 3718.3 674.1 683.0 686.6 699.7 708.6 518.7 598.9 687.5 705.6 718.4 9578.0 9698.8 9732.3 9846.8 9858.0 630.5 630.9 659.0 671.9 687.9 4430.2 4706.4 4736.0 4763.1 4764.2 124743.4 134253.0 136411.0 136616.0 139551.0 127974.0 128882.0 130638.0 134250.0 136731.3 112397.0 113670.0 114044.0 114270.4 115202.0 9139.4 9451.6 9766.9 9823.4 9866.8 63713.7 63719.4 63778.7 65946.0 66722.0 82739.6 97164.0 97350.0 97430.5 98211.5 13374.3 13499.3 13795.4 13872.8 14251.4 15025.1 15393.5 15632.1 15664.6 16113.8 14136.7 14231.1 14498.3 14715.4 14755.9 14165.7 14200.4 14511.6 14747.8 14903.8 13571.3 14272.5 14315.1 14322.2 14653.8 11018.2 11636.9 11638.1 11681.5 11929.0 11263.9 11306.5 11624.3 11661.7 11670.7 16:57:13 INFO - PROCESS | 1666 | -------- Summary: end -------- 16:57:13 INFO - PROCESS | 1666 | 16:57:13 INFO - TEST-INFO | 1666: exit 0 16:57:13 INFO - TEST-OK | dromaeo_css | took 1116618ms 16:57:13 INFO - TEST-START | kraken 16:57:13 INFO - operating with platform_type : mac_ 16:57:13 INFO - Initialising browser for kraken test... 16:57:13 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpjVwPvg/profile http://localhost:49278/getInfo.html) 16:57:15 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 16:57:15 INFO - PROCESS | 1672 | colorDepth:24 16:57:15 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 16:57:15 INFO - PROCESS | 1672 | __metrics 16:57:15 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:57:15 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:57:16 INFO - TEST-INFO | 1672: exit 0 16:57:16 INFO - Browser initialized. 16:57:16 INFO - Running cycle 1/1 for kraken test... 16:57:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpjVwPvg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:28 INFO - PROCESS | 1673 | RSS: Main: 244830208 16:57:28 INFO - PROCESS | 1673 | 16:57:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:31 INFO - PROCESS | 1673 | RSS: Main: 294281216 16:57:31 INFO - PROCESS | 1673 | 16:57:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 16:57:35 INFO - PROCESS | 1673 | RSS: Main: 304181248 16:57:35 INFO - PROCESS | 1673 | 16:57:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 16:57:39 INFO - PROCESS | 1673 | RSS: Main: 387833856 16:57:39 INFO - PROCESS | 1673 | 16:57:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 16:57:41 INFO - PROCESS | 1673 | RSS: Main: 289447936 16:57:41 INFO - PROCESS | 1673 | 16:57:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:44 INFO - PROCESS | 1673 | RSS: Main: 293867520 16:57:44 INFO - PROCESS | 1673 | 16:57:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:47 INFO - PROCESS | 1673 | RSS: Main: 330911744 16:57:47 INFO - PROCESS | 1673 | 16:57:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:51 INFO - PROCESS | 1673 | RSS: Main: 332861440 16:57:51 INFO - PROCESS | 1673 | 16:57:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 16:57:54 INFO - PROCESS | 1673 | RSS: Main: 331300864 16:57:54 INFO - PROCESS | 1673 | 16:57:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:56 INFO - PROCESS | 1673 | RSS: Main: 311529472 16:57:56 INFO - PROCESS | 1673 | 16:57:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:59 INFO - PROCESS | 1673 | RSS: Main: 319119360 16:57:59 INFO - PROCESS | 1673 | 16:58:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:02 INFO - PROCESS | 1673 | RSS: Main: 320425984 16:58:02 INFO - PROCESS | 1673 | 16:58:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:05 INFO - PROCESS | 1673 | RSS: Main: 330153984 16:58:05 INFO - PROCESS | 1673 | 16:58:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:09 INFO - PROCESS | 1673 | RSS: Main: 326508544 16:58:09 INFO - PROCESS | 1673 | 16:58:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 16:58:11 INFO - PROCESS | 1673 | RSS: Main: 369737728 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | __start_tp_report 16:58:11 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 16:58:11 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 16:58:11 INFO - PROCESS | 1673 | |i|pagename|runs| 16:58:11 INFO - PROCESS | 1673 | |0;ai-astar;99;111;111;111;112;111;111;111;112;112 16:58:11 INFO - PROCESS | 1673 | |1;audio-beat-detection;145;101;108;161;107;106;127;107;161;136 16:58:11 INFO - PROCESS | 1673 | |2;audio-dft;182;180;183;180;183;184;179;182;182;182 16:58:11 INFO - PROCESS | 1673 | |3;audio-fft;81;65;58;103;80;80;75;64;81;57 16:58:11 INFO - PROCESS | 1673 | |4;audio-oscillator;86;86;91;72;70;67;95;69;67;102 16:58:11 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;86;83;85;83;85;82;86;82;86;85 16:58:11 INFO - PROCESS | 1673 | |6;imaging-darkroom;93;92;93;93;91;92;92;93;93;92 16:58:11 INFO - PROCESS | 1673 | |7;imaging-desaturate;83;86;84;86;84;84;84;83;84;84 16:58:11 INFO - PROCESS | 1673 | |8;json-parse-financial;53;54;52;53;54;53;52;53;52;55 16:58:11 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;66;74;69;75;70;70;70;72;71;73 16:58:11 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;83;81;85;84;84;80;83;85;85;80 16:58:11 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;153;153;156;135;136;135;134;137;176;136 16:58:11 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;163;160;162;160;160;160;161;160;161;161 16:58:11 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;67;66;65;66;65;66;65;65;65 16:58:11 INFO - PROCESS | 1673 | __end_tp_report 16:58:11 INFO - PROCESS | 1673 | __start_cc_report 16:58:11 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1979 16:58:11 INFO - PROCESS | 1673 | __end_cc_report 16:58:11 INFO - PROCESS | 1673 | __startTimestamp1467676691086__endTimestamp 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | ------- Summary: start ------- 16:58:11 INFO - PROCESS | 1673 | Number of tests: 14 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:3.93 (3.5%) stddev-sans-first:0.50 16:58:11 INFO - PROCESS | 1673 | Values: 99.0 111.0 111.0 111.0 112.0 111.0 111.0 111.0 112.0 112.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:131.50 stddev:23.53 (17.9%) stddev-sans-first:23.92 16:58:11 INFO - PROCESS | 1673 | Values: 145.0 101.0 108.0 161.0 107.0 106.0 127.0 107.0 161.0 136.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:181.70 Median:182.00 stddev:1.57 (0.9%) stddev-sans-first:1.66 16:58:11 INFO - PROCESS | 1673 | Values: 182.0 180.0 183.0 180.0 183.0 184.0 179.0 182.0 182.0 182.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:74.40 Median:77.50 stddev:13.89 (17.9%) stddev-sans-first:14.53 16:58:11 INFO - PROCESS | 1673 | Values: 81.0 65.0 58.0 103.0 80.0 80.0 75.0 64.0 81.0 57.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:79.00 stddev:13.01 (16.5%) stddev-sans-first:13.64 16:58:11 INFO - PROCESS | 1673 | Values: 86.0 86.0 91.0 72.0 70.0 67.0 95.0 69.0 67.0 102.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:84.30 Median:85.00 stddev:1.64 (1.9%) stddev-sans-first:1.62 16:58:11 INFO - PROCESS | 1673 | Values: 86.0 83.0 85.0 83.0 85.0 82.0 86.0 82.0 86.0 85.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 16:58:11 INFO - PROCESS | 1673 | Values: 93.0 92.0 93.0 93.0 91.0 92.0 92.0 93.0 93.0 92.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 16:58:11 INFO - PROCESS | 1673 | Values: 83.0 86.0 84.0 86.0 84.0 84.0 84.0 83.0 84.0 84.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 16:58:11 INFO - PROCESS | 1673 | Values: 53.0 54.0 52.0 53.0 54.0 53.0 52.0 53.0 52.0 55.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:2.62 (3.7%) stddev-sans-first:2.07 16:58:11 INFO - PROCESS | 1673 | Values: 66.0 74.0 69.0 75.0 70.0 70.0 70.0 72.0 71.0 73.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.00 stddev:2.00 (2.4%) stddev-sans-first:2.12 16:58:11 INFO - PROCESS | 1673 | Values: 83.0 81.0 85.0 84.0 84.0 80.0 83.0 85.0 85.0 80.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:145.00 stddev:13.97 (9.6%) stddev-sans-first:14.52 16:58:11 INFO - PROCESS | 1673 | Values: 153.0 153.0 156.0 135.0 136.0 135.0 134.0 137.0 176.0 136.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:0.73 16:58:11 INFO - PROCESS | 1673 | Values: 163.0 160.0 162.0 160.0 160.0 160.0 161.0 160.0 161.0 161.0 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 16:58:11 INFO - PROCESS | 1673 | Values: 66.0 67.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 16:58:11 INFO - PROCESS | 1673 | -------- Summary: end -------- 16:58:11 INFO - PROCESS | 1673 | 16:58:11 INFO - TEST-INFO | 1673: exit 0 16:58:11 INFO - TEST-OK | kraken | took 58230ms 16:58:11 INFO - SUITE-END | took 1174s 16:58:12 INFO - Completed test suite (00:19:35) 16:58:12 INFO - javascript benchmark 16:58:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2835.8723857426417, 3369.5282660427542, 3405.812680302583, 3430.382531144396, 3462.948055779162, 5560.77756889725, 5627.718614069296, 5669.659820410768, 5770.798022069223, 5778.364379918216, 5716.542676585863, 5740.7129643517865, 5747.626404283718, 5755.740991655375, 5766.0486019806685, 5179.249008893708, 5213.504717051893, 5236.7119808410525, 5254.92117618236, 5293.602979776513, 5282.894342113174, 5307.310049693534, 5332.600054995872, 5367.543758780508, 5375.16684913839, 5279.260903473517, 5280.287161233223, 5283.682979021271, 5328.6269961102735, 5357.839264822042, 5337.919931201016, 5362.249285100089, 5367.141257398836, 5380.569554435636, 5389.8113566025395, 5163.380394352702, 5165.483451654842, 5178.741062946875, 5276.261323414725, 5283.181106928432, 5711.171880077365, 5712.428757124254, 5716.0, 5735.369109397963, 5777.393373695743, 6333.778317758856, 6347.8413039673915, 6348.682565871688, 6354.650494222816, 6356.300806911236, 6147.907781383283, 6203.0, 6295.307516173218, 6296.716647750863, 6305.148804911324, 5954.910676339815, 5956.493698035672, 5986.07215881539, 5989.550783691154, 5991.400859913973, 6397.584157029872, 6406.615603063738, 6409.711562979677, 6416.422521973045, 6448.387403196689, 6069.908951365733, 6142.867137759775, 6230.158928544589, 6230.875382492325, 6252.968735156386, 5473.06957817172, 6203.0, 6286.465650419674, 6292.402221788922, 6324.620522768557, 6228.781992630236, 6286.371362863677, 6306.243250809932, 6318.905216421757, 6321.367863213642, 6143.849652621636, 6213.1922850029205, 6215.96892015537, 6308.905366419507, 6310.747570097236, 4981.452040275567, 5011.072951503984, 5021.949780502221, 5026.89946201074, 5070.619703522177, 4495.4605447345875, 4495.730256184639, 4507.121111383249, 4535.138323718483, 4545.113702827917, 5738.913916291259, 5813.069908814569, 5836.445537673914, 5886.705664716747, 5886.705664716833, 6253.741469449662, 6282.0, 6282.057691346243, 6292.779752708633, 6320.71556779946, 5912.556558258148, 5926.288845338587, 5943.851403714855, 5950.315713692894, 5969.552283578662, 5373.247745315659, 5406.243125962368, 5472.097103977799, 5476.17857321397, 5505.917411238835, 6429.967850160906, 6461.450776683847, 6463.8060858173385, 6499.1876015498065, 6518.315576864456, 6185.319614842454, 6254.8123556293385, 6283.057541368831, 6284.968575157095, 6305.148804911279, 6358.173437453286, 6400.679966001774, 6420.775272865428, 6475.417212450902, 6516.446102081187, 6259.937400625936, 6269.7178626962805, 6271.404216599416, 6281.685915704105, 6295.496360291074, 4721.126591580569, 5056.494350564914, 6251.249850017845, 6254.937450625435, 6284.968575157095, 6130.724117414817, 6139.324674285915, 6148.555089553862, 6224.37756224374, 6233.127362169391, 6188.938110619017, 6194.473469755121, 6211.130441738251, 6213.440790328892, 6222.191115155001, 5864.296284445893, 5995.850103747267, 6043.879122417615, 6090.0, 6099.085137229451, 5179.689218646742, 6120.233815636221, 6198.442140207403, 6210.503159747119, 6230.59501132425, 6071.150038994456, 6072.757089716361, 6114.327423983447, 6119.816405507842, 6131.662758548323], "value": 5757.88608690721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8595350325158, 500.0898364975743, 515.9974200128999, 526.8682829292677, 553.3166539323935, 31401.371972560533, 33293.66706332936, 33344.4998325025, 33442.82950096747, 33453.66546334536, 45500.77249613747, 46616.27069834414, 46735.065298694004, 49385.75307123459, 49442.01115977678, 9826.557804898779, 10012.098911097999, 10017.248706347016, 10024.248181386389, 10042.648507302245, 9021.639134434648, 9227.907720922773, 9866.16137628299, 9985.650502232424, 9987.101160895518, 12133.393330333492, 12404.689882752959, 12408.131430799847, 12409.0, 12424.751504969896, 12317.199382040139, 12318.199317044408, 12375.381230938507, 12377.690557735994, 12382.566610168691, 8897.332700047458, 9095.954520227422, 9103.953045399798, 12148.088893332946, 12244.510219591206, 34502.309953801036, 43336.783316083216, 43450.91372715676, 43569.0, 45858.312125318145, 2997.565353023799, 3493.7903725776537, 3539.004623875126, 3715.294094122108, 3960.0891794887048, 31878.521822172686, 32903.506447403306, 34432.13919652004, 34443.65556344429, 34484.82757586196, 3269.4441944869427, 3387.2717365766234, 3482.791032538056, 3487.424574945131, 3492.4062909305226, 555292.2235388837, 556796.0, 559146.0, 560580.0, 561391.0, 68533.97199042018, 68897.0, 69047.3095269041, 69076.65461672659, 69251.65374173097, 71145.64427177934, 71251.2874871255, 71315.28684713191, 71477.0, 71527.0, 14661.266936653125, 15786.526404207892, 17510.21204045821, 17774.555636109202, 17801.931884086996, 12093.818592721116, 12398.690032749253, 12408.689782755322, 12410.75178496425, 12415.193012454161, 7871.921280787234, 7880.093789214314, 7926.960365198137, 14143.74855558124, 19511.609767804566, 6879.415249703831, 6887.552309099892, 7934.563599001995, 8190.672373105128, 8204.056533498604, 916.3814425262921, 1000.9949950250348, 1039.5893622019412, 1046.8900765419673, 1118.983215251772, 30451.847740761154, 31958.0, 32261.0, 32559.186020349207, 32841.67158328434, 865.8095219051798, 1035.177034257767, 1088.3089238333557, 1164.2723297938787, 1210.9818352724717, 16507.504774856774, 16737.079460629782, 16919.830801691827, 16922.83077169237, 17213.655726885394, 671774.0, 684042.0, 686647.0, 687344.0, 689668.0, 65613.67193164004, 66147.66926165338, 66240.33759662438, 66248.66875665591, 66347.68261586901, 1265.4495294546903, 1389.9861001389856, 1412.9364178611986, 1438.4461982136952, 1443.45870298638, 33401.66598333986, 33730.66269337275, 33847.0, 34030.65969340275, 34252.828735856165, 45406.31890521711, 56198.0, 56521.43478565162, 56528.0, 56585.71707141438, 543946.280268612, 552408.0, 553497.0, 554465.0, 555449.0, 24889.377765556004, 28048.859755701906, 28208.85895570509, 28378.86484540595, 28696.99560515372, 51493.742531287106, 52487.73756131195, 52518.40343100646, 53352.0, 53444.0, 41567.58432415758, 42774.78612606917, 43072.13855722931, 44469.55530444654, 44573.88565285894, 42234.0, 42300.0, 42676.146477070906, 43017.569824301354, 44033.77983110064, 41931.371029433976, 42152.57847421609, 42202.577974219865, 42466.0, 42776.0, 34067.4889876657, 34660.133496662784, 35833.0, 37131.0, 38429.4235586472, 22820.0, 27071.0, 27682.169534913985, 27856.44287114206, 27989.160325189463], "value": 21052.104925883083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.0797222887241, 391.7199202570162, 401.42796514966176, 402.5652295520838, 423.95124560675515, 14580.03790457255, 16961.40635077771, 18687.906560467178, 21305.57388852222, 22260.109595616155, 21436.4640883978, 22043.0, 22231.66652500214, 22296.331110066723, 22434.88782556089, 1638.5412084616266, 1648.6290584618484, 1652.7603497492855, 1653.966920661586, 1779.6262784815203, 5753.338366087891, 6104.481119104881, 6109.450149486545, 6125.418085281914, 6135.693215339237, 5772.797952071678, 6036.788712395067, 6076.787312444066, 6079.604825686316, 6081.087836824468, 6043.335233124353, 6073.240844894388, 6107.603005804608, 6108.938910610904, 6114.235720534955, 5161.7161056141895, 5217.295665085203, 5277.129273669878, 5278.736063196863, 5487.2317875497465, 13470.39383227757, 13657.453701851913, 13699.520516781964, 13721.382537785823, 23524.88237558801, 2073.170731707314, 2231.364061242538, 2401.7238017628024, 2414.915477958263, 2921.24047747585, 10029.1475224606, 10145.0, 10427.217958653131, 10515.789684206273, 10738.355698658028, 1826.1782198010815, 1838.3565751986832, 1850.5836186857848, 1880.576870204207, 1916.2239293086323, 67696.66151669259, 92014.3992800364, 105613.47193264062, 123287.3835630825, 124385.0, 11175.720606984727, 11465.713357166138, 11600.187986841009, 11713.062954963583, 11890.940545297392, 13167.934160329138, 14613.634659133395, 14730.189839558927, 14750.40998360075, 14751.852481475047, 7900.9604951976025, 8314.708985185489, 8667.739967800977, 8700.912990870136, 8704.91295087041, 8708.042115367305, 8712.651493940299, 8737.51943643093, 8837.425567338103, 8845.469271843709, 4610.538946105363, 4622.098690755338, 4626.768661566908, 4635.351050852883, 4712.363830882787, 1891.810818918097, 1934.5067007913174, 1935.7448572413261, 1939.1177014458387, 1943.9514012149527, 792.2117493094408, 846.4328899637258, 897.5108565831638, 908.5366463103865, 926.4626516620344, 19823.900880495792, 21460.14159433605, 22143.44641383946, 22179.001944912518, 22383.77616223817, 941.665708673411, 942.2650332740474, 973.0755782007121, 979.7991411760572, 1032.4218437674926, 10917.672469825919, 11236.887631123747, 11425.028872545927, 11429.657110286706, 11480.0, 597884.0, 607082.0, 611354.0, 644944.77527613, 645940.0, 131196.0, 134627.32686336702, 140601.29699351438, 141363.0, 144588.0, 982.1455333859587, 1005.7435353984687, 1012.7012531303283, 1013.5996281468779, 1015.9339642923334, 18971.0, 19254.0, 19343.322983695503, 19407.417777466697, 19418.931958742403, 57310.0, 57497.0, 58311.0, 58576.4142358588, 59302.70348648402, 78174.21825781897, 79888.0, 80063.59968200122, 83695.0, 90769.54615227146, 7629.46593738433, 7979.521228726295, 8106.892208025838, 8128.83742325162, 8191.05802832658, 9179.449233046038, 11976.0, 12756.553520626734, 13000.349982501026, 13047.217166970013, 10974.890251097388, 11122.443877805916, 11151.052160566443, 11180.329180249211, 11296.548138074386, 10793.56825726962, 10994.0, 11027.724306892393, 11054.447277636247, 11207.66377008691, 9638.807223855343, 11220.607278745205, 11303.03924166455, 11547.0762339011, 11580.710482237675, 6971.860562788817, 7294.905764135422, 7351.77944661661, 7994.52032878006, 8292.33661307082, 8279.420440569102, 10586.947065264625, 11283.266587671775, 11517.712057198638, 11602.187846850977], "value": 9185.679221865646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.8152940117784, 1579.0999130495616, 1614.402671011726, 1848.3992702371725, 1961.5096225943514, 7915.485493442922, 8697.260732837709, 8927.910720892789, 8928.91071089289, 9080.8637870432, 8670.306375489961, 8911.91088089119, 8916.73249802507, 8921.732348029553, 8925.598348074336, 2369.656399822025, 2398.6641870138196, 2398.7721166489155, 2403.4231784371714, 2403.8557686538775, 2341.203990643181, 2385.5348207099623, 2387.85672859629, 2390.8206884483648, 2392.4138586046356, 2344.601417758985, 2370.20598099636, 2381.714194296687, 2382.4758553118286, 2383.940401489959, 1935.8354539864058, 2331.6735657008035, 2359.9056037758555, 2363.9409014774683, 2376.916807911732, 2274.704288442492, 2357.599208134621, 2363.7990770784504, 2367.4673198530195, 2369.6327069304284, 8095.150009249003, 8276.462029968034, 9056.818863622757, 9118.58966346516, 9130.041345658743, 5159.303494028296, 5402.91895621566, 5405.00007498614, 5407.972485227794, 5468.425815289377, 3011.864466099031, 3622.5366750609574, 3655.707543396522, 3715.145516531213, 3757.3092108550986, 1102.7684186320882, 1104.3705088099707, 1105.8562386889732, 1113.192935122038, 1126.9774604507945, 11790.823137652942, 11991.880081199164, 12040.81938770919, 12046.698832529257, 12088.153829231956, 4051.837926482967, 4674.0, 4777.077833675726, 4817.638677099231, 4909.607231421478, 10373.377597344033, 10426.739331516772, 10429.478526073666, 10437.32157409766, 10438.478076096164, 5446.645968012067, 5447.809326673548, 5448.700321482356, 5449.2371068049715, 5457.426970168154, 4774.522547745198, 4923.08922849274, 4960.280759289883, 4972.950270497248, 4989.925151122736, 3781.489498917611, 3808.562015368268, 3837.501124853751, 3873.593272706325, 3909.354956432157, 1181.3915833345834, 1183.8638556566104, 1189.637160665988, 1192.7077865922904, 1200.6578125234266, 871.8082021955287, 944.5702205496483, 959.0744931141481, 960.4381436859376, 1022.1873610479687, 5944.0, 6041.093835924647, 6093.878122437526, 6138.324784273726, 6153.600015998945, 427.79679652165595, 442.85828534869177, 451.668024002358, 457.31174582253493, 463.38369967942555, 3988.581198974066, 4119.0, 4140.979295103505, 4166.375043743463, 4171.144915292358, 9917.702468925943, 10472.371657700562, 10475.42385168823, 10821.513031913582, 10868.130549556017, 10630.521626526825, 10871.619493317854, 10874.891251087545, 10970.122390208764, 10979.1765617579, 8215.424920255524, 8322.042965058974, 8369.163083691705, 8376.078631350547, 8394.0, 5997.190379298913, 5999.610025348338, 6130.5402094842175, 6136.7852125175405, 6297.590656607306, 9700.563474643517, 9924.503774811086, 10049.346792458467, 10351.327163734333, 10395.58417663285, 10158.847617285599, 10257.384556926609, 10369.0, 10418.843717344094, 10567.154627629925, 7537.2462753724185, 7661.310482056641, 7669.69321227167, 7676.577788221478, 7704.6918123274445, 8244.83510329778, 8297.792555186168, 8360.958195208985, 8362.45644033136, 8366.205210504992, 7499.700011999459, 7657.272559106876, 7688.884666730115, 7783.377329813715, 7790.610469476617, 7402.555846649218, 7483.700651974078, 7490.887636685563, 7648.80877978055, 7668.348190403655, 7055.400290975324, 7137.536060156073, 7137.678804453708, 7146.106736657918, 7146.964265178641, 4924.310596516562, 5056.191009438472, 5078.746062696924, 5130.666506677054, 5140.0, 5140.485951404829, 5166.173412254021, 5178.326817513699, 5248.212768084818, 5299.549538289134], "value": 4567.123006067884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.9191610181353, 315.6701247196679, 321.37011457543224, 321.76028858500433, 326.8806885486798, 4803.606953983341, 5313.973430132849, 5469.003813608034, 5501.927124210781, 5595.608307418483, 5365.892682146355, 5401.70290634015, 5477.808276710316, 5494.736210671548, 5496.680796608815, 3411.573553305837, 3488.5639295088113, 3936.4882565266475, 4061.614146656063, 4243.8090285937205, 3341.665833416663, 3386.4920261960656, 4121.670266378683, 4210.3894935234375, 4218.029853133781, 3339.482380231068, 4015.3135683013206, 4113.444684967521, 4148.668106551484, 4155.33514637658, 3811.599782022903, 3853.959430953627, 4121.752694838305, 4132.648724858361, 4158.958410415902, 2931.618889544367, 3547.9113022174392, 3552.8223588820715, 3578.2306804037, 3588.810825396506, 5217.087009773274, 5229.738513074331, 5233.555147812441, 5235.764390602432, 5294.338207724035, 3986.923530646709, 4412.903870661442, 4729.834455794031, 4743.169945259566, 4814.831480898187, 4488.640908727294, 5477.452254774491, 5598.636088654224, 5616.691081990489, 5625.0, 3954.8615798447204, 3957.9814294709618, 3971.483707118085, 3976.0, 3977.164795392971, 5029.371328583927, 5599.972000139973, 5713.8285851424525, 5976.342602313742, 6018.909716354215, 4013.1371755072214, 4015.397690346413, 4024.2555127301544, 4048.554658987509, 4055.5602761020004, 3616.258666973264, 4100.913257986636, 4112.177564487115, 4113.6297733203555, 4120.320147175682, 3921.0983871934563, 4510.481294651091, 4655.883602909887, 4723.622110231173, 4767.284907263938, 5151.789329507563, 5368.248445217672, 5392.703401312887, 5569.860753481114, 5571.4150014248735, 1356.8982326325565, 1367.9658008549666, 1374.2510331869155, 1377.3801789194902, 1387.6600232942792, 809.753025327269, 846.5132548784474, 847.4406891451613, 862.9482231066156, 866.5147517390282, 4318.654507639381, 4344.261475549164, 4707.870111173363, 5092.821751238689, 5153.536181743586, 4788.449328327218, 4997.350344455198, 5745.827625171251, 5761.884762304814, 5854.7072646367515, 4555.246230201396, 4941.034260568106, 5202.609804264695, 5237.502437268454, 5352.625316227826, 3028.364043550879, 3065.754739620825, 3076.292452735883, 3077.938441231163, 3081.0, 5500.4499550045475, 6055.364186760415, 6071.0, 6079.787207447718, 6113.349395663146, 5380.892382152335, 5494.7636781723795, 5712.857178570569, 6049.8487537811025, 6057.606255593372, 5059.519345662156, 5096.872578185575, 5301.893962120736, 5509.090999984957, 5970.611910225908, 4881.389826271716, 5453.318335208099, 5626.803061892814, 5871.266091738533, 5913.438223368773, 5754.251947246831, 5793.0, 5810.767569297181, 5824.912626310524, 5847.853803654943, 6017.615948331821, 6030.773536158134, 6065.787697430569, 6075.483583895241, 6080.574359794772, 3179.7138257556007, 3957.109650328768, 3984.8406063757125, 3984.86052988144, 4001.339778936443, 5299.343453017405, 5398.40617532079, 5688.132070192143, 5732.455416735404, 5744.138379243147, 4784.258439941815, 5513.466542147568, 5649.0, 5679.74441150141, 5706.942930570641, 5309.230161626465, 5427.2632757518795, 5590.3166480090595, 5651.519620832275, 5658.519025882846, 5157.742112894415, 5491.75287112073, 5522.337319521683, 5530.253415788978, 5538.584606154474, 4627.629789616755, 4835.44392394865, 5449.209864569536, 5600.663960162403, 5611.166360987675, 5359.4104648487855, 5565.024416332144, 5592.636478628876, 5593.580481463988, 5598.300212473441], "value": 4125.543063307327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.4101923557332, 824.3281725393804, 847.8134810341725, 849.2314455417845, 866.9393142480021, 15293.388264469422, 15968.121753303563, 16685.249163787645, 16732.665346693073, 16860.578485537866, 15030.699386012273, 15052.774208386883, 15247.695046099072, 15256.771148432783, 15354.616134596641, 754.2156157596094, 763.900692909921, 910.0899100899101, 927.8422668146397, 930.6324002019198, 933.8179055084262, 934.7149119518544, 944.5607792376544, 945.6075728572634, 949.6486300068949, 1005.7586179316947, 1006.7483129217695, 1007.0433088565892, 1008.541113793226, 1008.7175590834578, 729.1468981291902, 782.2451334462243, 806.891069705594, 808.3775492870516, 1005.6027868991744, 712.7612249896291, 719.7229066809264, 723.9022731931175, 739.1684355100512, 742.1242933338658, 15463.0, 15469.381224750996, 15476.226188690633, 15516.301766420538, 15530.0, 14184.858151418457, 14352.64118397038, 14373.496927607484, 14402.855971440256, 14593.78109328361, 12528.624141275777, 12910.548130815376, 13214.867851321556, 13485.528006519724, 13488.055836091478, 4308.224519586473, 4644.303354496818, 4660.300954856799, 4728.6453515986095, 4778.283257511366, 113772.43113784461, 114067.28899066521, 115089.0, 115133.0, 115404.42297788458, 9999.0, 11023.779524409467, 11739.178257522062, 11818.822717659243, 11941.522339106512, 23714.170004049774, 23964.64053039206, 24138.758612414003, 24188.274351769476, 24197.274081777574, 8455.365847561334, 8477.23704866565, 8563.400561960727, 8569.314454843598, 8593.312534997185, 4467.843625473093, 4592.816287348469, 4593.035462552834, 4608.423947006624, 4755.881102972453, 2985.4775414302844, 3709.4250391189407, 3710.4805327254207, 3710.6474884885893, 3718.330700473941, 674.0832467843728, 682.9726810927607, 686.5983399711125, 699.6641612026256, 708.6350529477323, 518.7399766369022, 598.9251343582052, 687.52560733094, 705.6401235369896, 718.3786025088261, 9578.0, 9698.806023879482, 9732.318737688294, 9846.803063938682, 9857.950710246403, 630.5151368527053, 630.9305976342598, 659.0378048049901, 671.9496037797185, 687.8693048320803, 4430.180416622935, 4706.364640773451, 4735.952640473552, 4763.071201115749, 4764.190087685032, 124743.376283118, 134253.0, 136411.0, 136616.0, 139551.0, 127974.0, 128882.0, 130638.0, 134250.0, 136731.31634341765, 112397.0, 113670.0, 114044.0, 114270.42864785623, 115202.0, 9139.360244783067, 9451.574679139318, 9766.876809166752, 9823.36148150368, 9866.753331166778, 63713.681431592544, 63719.362806373196, 63778.724425512155, 65946.0, 66722.0, 82739.5863020681, 97164.02835971549, 97350.0264997341, 97430.51284743531, 98211.50894245484, 13374.331283435984, 13499.257540835348, 13795.448182072605, 13872.791908121184, 14251.35868885882, 15025.098494090389, 15393.461228856937, 15632.131333369829, 15664.608384790472, 16113.758293625839, 14136.717265654836, 14231.146131232159, 14498.34757435939, 14715.411383544539, 14755.92622036926, 14165.716685666435, 14200.360983755962, 14511.564653060424, 14747.778783318045, 14903.791131965609, 13571.321433928462, 14272.486509090118, 14315.056883331938, 14322.212278324376, 14653.780193297322, 11018.228723989243, 11636.941815291208, 11638.12714046433, 11681.532738690697, 11929.045676346044, 11263.943680281545, 11306.49120789583, 11624.302541847515, 11661.6501504955, 11670.70823229426], "value": 8206.593184599056, "unit": "score"}], "name": "dromaeo_css", "value": 7458.771613505664, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 111.0, 112.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 101.0, 108.0, 161.0, 107.0, 106.0, 127.0, 107.0, 161.0, 136.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 183.0, 180.0, 183.0, 184.0, 179.0, 182.0, 182.0, 182.0], "value": 181.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 65.0, 58.0, 103.0, 80.0, 80.0, 75.0, 64.0, 81.0, 57.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 91.0, 72.0, 70.0, 67.0, 95.0, 69.0, 67.0, 102.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 83.0, 85.0, 82.0, 86.0, 82.0, 86.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 91.0, 92.0, 92.0, 93.0, 93.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 86.0, 84.0, 84.0, 84.0, 83.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 53.0, 54.0, 53.0, 52.0, 53.0, 52.0, 55.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 69.0, 75.0, 70.0, 70.0, 70.0, 72.0, 71.0, 73.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 85.0, 84.0, 84.0, 80.0, 83.0, 85.0, 85.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 156.0, 135.0, 136.0, 135.0, 134.0, 137.0, 176.0, 136.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1412.0999999999997, "alertThreshold": 2.0}]} 16:58:12 INFO - Return code: 0 16:58:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:58:12 INFO - # TBPL SUCCESS # 16:58:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:12 INFO - 2016-07-04 16:58:12.383 screenresolution[1677:12258] starting screenresolution argv=screenresolution get 16:58:12 INFO - 2016-07-04 16:58:12.386 screenresolution[1677:12258] Display 0: 1600x1200x32@60 16:58:12 INFO - 2016-07-04 16:58:12.391 screenresolution[1678:12261] starting screenresolution argv=screenresolution list 16:58:12 INFO - Available Modes on Display 0 16:58:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:12 INFO - Intel Iris: 16:58:12 INFO - Chipset Model: Intel Iris 16:58:12 INFO - Type: GPU 16:58:12 INFO - Bus: Built-In 16:58:12 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:12 INFO - Vendor: Intel (0x8086) 16:58:12 INFO - Device ID: 0x0a2e 16:58:12 INFO - Revision ID: 0x0009 16:58:12 INFO - Displays: 16:58:12 INFO - Display: 16:58:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:12 INFO - Display Serial Number: 1600x1200 60 16:58:12 INFO - Main Display: Yes 16:58:12 INFO - Mirror: Off 16:58:12 INFO - Online: Yes 16:58:12 INFO - Rotation: Supported 16:58:12 INFO - Return code: 0 16:58:12 INFO - Running post-action listener: _resource_record_post_action 16:58:12 INFO - ##### 16:58:12 INFO - ##### Finished run-tests step (success) 16:58:12 INFO - ##### 16:58:12 INFO - Running post-run listener: _resource_record_post_run 16:58:12 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 31317504; Write bytes: 704597504; Read time: 189; Write time: 1944 16:58:12 INFO - TinderboxPrint: CPU usage
53.5% 16:58:12 INFO - TinderboxPrint: I/O read bytes / time
31,317,504 / 189 16:58:12 INFO - TinderboxPrint: I/O write bytes / time
704,597,504 / 1,944 16:58:12 INFO - TinderboxPrint: CPU idle
2,251.5 (46.5%) 16:58:12 INFO - TinderboxPrint: CPU system
959.5 (19.8%) 16:58:12 INFO - TinderboxPrint: CPU user
1,626.6 (33.6%) 16:58:12 INFO - TinderboxPrint: Swap in / out
433,979,392 / 0 16:58:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 407925248; Write bytes: 410318848; Read time: 29798; Write time: 855 16:58:12 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 29126144; Write bytes: 292845056; Read time: 169; Write time: 1084 16:58:13 INFO - Running post-run listener: _upload_blobber_files 16:58:13 INFO - Blob upload gear active. 16:58:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:58: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 16:58: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'] 16:58: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 16:58:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:58:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:14 INFO - (blobuploader) - INFO - Done attempting. 16:58:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:58:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:58:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:15 INFO - (blobuploader) - INFO - Done attempting. 16:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:17 INFO - (blobuploader) - INFO - Done attempting. 16:58:17 INFO - (blobuploader) - INFO - Iteration through files over. 16:58:17 INFO - Return code: 0 16:58:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:58:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:58:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52875dac9a7843a2e8fa09a2a54e16c433462760535539fffea5b03659f4b9ef9f6a0ffd0080ad2cd7419ffe043880d29c5f0cac612cf17c09a80243be78c887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab8f948597bf334b46badbca7e2e1b2b18592f0953cab68d3a6c69ba5cd6cb148540aef0754749f4fd815f3cfd2cbbd24a845704390635a0e111d89478a2549", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778afaa123496c78b736ef5edbf1da4ddb365d0d9a9d7627ab851fcf37da6c27e1a2a5ae7d3d47704d9ea646507b9ab6d26fc81057b590444889ed6c25b1f35b"} 16:58:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:58:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:58:17 INFO - Contents: 16:58:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52875dac9a7843a2e8fa09a2a54e16c433462760535539fffea5b03659f4b9ef9f6a0ffd0080ad2cd7419ffe043880d29c5f0cac612cf17c09a80243be78c887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab8f948597bf334b46badbca7e2e1b2b18592f0953cab68d3a6c69ba5cd6cb148540aef0754749f4fd815f3cfd2cbbd24a845704390635a0e111d89478a2549", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778afaa123496c78b736ef5edbf1da4ddb365d0d9a9d7627ab851fcf37da6c27e1a2a5ae7d3d47704d9ea646507b9ab6d26fc81057b590444889ed6c25b1f35b"} 16:58:17 INFO - Running post-run listener: copy_logs_to_upload_dir 16:58:17 INFO - Copying logs to upload dir... 16:58:17 INFO - mkdir: /builds/slave/test/build/upload/logs 16:58:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.046306 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-07-04 16:58:18.005294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 16:58:18.008644) ========= 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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52875dac9a7843a2e8fa09a2a54e16c433462760535539fffea5b03659f4b9ef9f6a0ffd0080ad2cd7419ffe043880d29c5f0cac612cf17c09a80243be78c887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab8f948597bf334b46badbca7e2e1b2b18592f0953cab68d3a6c69ba5cd6cb148540aef0754749f4fd815f3cfd2cbbd24a845704390635a0e111d89478a2549", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778afaa123496c78b736ef5edbf1da4ddb365d0d9a9d7627ab851fcf37da6c27e1a2a5ae7d3d47704d9ea646507b9ab6d26fc81057b590444889ed6c25b1f35b"} build_url:https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010973 build_url: 'https://queue.taskcluster.net/v1/task/Uq_SJYIyTWG01jkol8rEEA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52875dac9a7843a2e8fa09a2a54e16c433462760535539fffea5b03659f4b9ef9f6a0ffd0080ad2cd7419ffe043880d29c5f0cac612cf17c09a80243be78c887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab8f948597bf334b46badbca7e2e1b2b18592f0953cab68d3a6c69ba5cd6cb148540aef0754749f4fd815f3cfd2cbbd24a845704390635a0e111d89478a2549", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778afaa123496c78b736ef5edbf1da4ddb365d0d9a9d7627ab851fcf37da6c27e1a2a5ae7d3d47704d9ea646507b9ab6d26fc81057b590444889ed6c25b1f35b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 16:58:18.040809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:58:18.041166) ========= 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.OW2d8KMAP9/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.OfvwjbZNaI/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.004610 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:58:18.089461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 16:58:18.089845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 16:58:18.090206) ========= ========= Total master_lag: 0.18 =========