builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0278 starttime: 1476399143.51 results: success (0) buildid: 20161013133620 builduid: 8854ff9d10eb47f8aa7f74c7d26688fe revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.505765) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.506212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.506485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.530141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.530441) ========= 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.fKoY1Aij02/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.PzHe7F0zqN/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-10-13 15:52:23-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-10-13 15:52:23 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.687108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.687499) ========= 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.fKoY1Aij02/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.PzHe7F0zqN/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.032146 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:23.741813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 15:52:23.742535) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fKoY1Aij02/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.PzHe7F0zqN/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-10-13 15:52:23,824 truncating revision to first 12 chars 2016-10-13 15:52:23,824 Setting DEBUG logging. 2016-10-13 15:52:23,824 attempt 1/10 2016-10-13 15:52:23,824 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/183b9d08d264?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 15:52:24,780 unpacking tar archive at: fx-team-183b9d08d264/testing/mozharness/ program finished with exit code 0 elapsedTime=1.221342 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 15:52:24.990021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:24.990785) ========= script_repo_revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:24.991800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:24.992270) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 15:52:25.011027) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-10-13 15:52:25.011420) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fKoY1Aij02/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.PzHe7F0zqN/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:52:25 INFO - MultiFileLogger online at 20161013 15:52:25 in /builds/slave/test 15:52:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:52:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:25 INFO - {'append_to_log': False, 15:52:25 INFO - 'base_work_dir': '/builds/slave/test', 15:52:25 INFO - 'blob_upload_branch': 'Fx-Team', 15:52:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:25 INFO - 'branch': 'Fx-Team', 15:52:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:25 INFO - 'config_files': ('talos/mac_config.py',), 15:52:25 INFO - 'default_actions': ('clobber', 15:52:25 INFO - 'read-buildbot-config', 15:52:25 INFO - 'download-and-extract', 15:52:25 INFO - 'populate-webroot', 15:52:25 INFO - 'create-virtualenv', 15:52:25 INFO - 'install', 15:52:25 INFO - 'run-tests'), 15:52:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:25 INFO - 'download_minidump_stackwalk': True, 15:52:25 INFO - 'download_symbols': 'ondemand', 15:52:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:25 INFO - 'installer_path': 'installer.exe', 15:52:25 INFO - 'log_level': 'info', 15:52:25 INFO - 'log_name': 'talos', 15:52:25 INFO - 'log_to_console': True, 15:52:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:52:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:52:25 INFO - 'opt_config_files': (), 15:52:25 INFO - 'pip_index': False, 15:52:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:25 INFO - 'cmd': ('bash', 15:52:25 INFO - '-c', 15:52:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:25 INFO - 'enabled': True, 15:52:25 INFO - 'halt_on_failure': False, 15:52:25 INFO - 'name': 'check_screen_resolution'},), 15:52:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:25 INFO - 'cmd': ('bash', 15:52:25 INFO - '-c', 15:52:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:25 INFO - 'enabled': True, 15:52:25 INFO - 'halt_on_failure': False, 15:52:25 INFO - 'name': 'check_screen_resolution'},), 15:52:25 INFO - 'run_cmd_checks_enabled': True, 15:52:25 INFO - 'sps_profile': False, 15:52:25 INFO - 'sps_profile_interval': 0, 15:52:25 INFO - 'suite': 'dromaeojs', 15:52:25 INFO - 'system_bits': '32', 15:52:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:25 INFO - 'title': 't-yosemite-r7-0278', 15:52:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:25 INFO - 'use_talos_json': True, 15:52:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:25 INFO - 'work_dir': 'build'} 15:52:25 INFO - [mozharness: 2016-10-13 22:52:25.217701Z] Running clobber step. 15:52:25 INFO - Running pre-action listener: _resource_record_pre_action 15:52:25 INFO - Running main action method: clobber 15:52:25 INFO - rmtree: /builds/slave/test/build 15:52:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:27 INFO - Running post-action listener: _resource_record_post_action 15:52:27 INFO - [mozharness: 2016-10-13 22:52:27.875625Z] Finished clobber step (success) 15:52:27 INFO - [mozharness: 2016-10-13 22:52:27.875752Z] Running read-buildbot-config step. 15:52:27 INFO - Running pre-action listener: _resource_record_pre_action 15:52:27 INFO - Running main action method: read_buildbot_config 15:52:27 INFO - Using buildbot properties: 15:52:27 INFO - { 15:52:27 INFO - "project": "", 15:52:27 INFO - "product": "firefox", 15:52:27 INFO - "script_repo_revision": "production", 15:52:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:52:27 INFO - "repository": "", 15:52:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:52:27 INFO - "buildid": "20161013133620", 15:52:27 INFO - "pgo_build": "False", 15:52:27 INFO - "basedir": "/builds/slave/test", 15:52:27 INFO - "buildnumber": 183, 15:52:27 INFO - "slavename": "t-yosemite-r7-0278", 15:52:27 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:52:27 INFO - "platform": "yosemite_r7", 15:52:27 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:52:27 INFO - "branch": "fx-team", 15:52:27 INFO - "repo_path": "integration/fx-team", 15:52:27 INFO - "revision": "183b9d08d2648d4ed50fa1d354b50bd43c11a891", 15:52:27 INFO - "stage_platform": "macosx64", 15:52:27 INFO - "builduid": "8854ff9d10eb47f8aa7f74c7d26688fe", 15:52:27 INFO - "slavebuilddir": "test" 15:52:27 INFO - } 15:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:52:27 INFO - Running post-action listener: _resource_record_post_action 15:52:27 INFO - [mozharness: 2016-10-13 22:52:27.879023Z] Finished read-buildbot-config step (success) 15:52:27 INFO - [mozharness: 2016-10-13 22:52:27.879130Z] Running download-and-extract step. 15:52:27 INFO - Running pre-action listener: _resource_record_pre_action 15:52:27 INFO - Running main action method: download_and_extract 15:52:27 INFO - mkdir: /builds/slave/test/build/tests 15:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:27 INFO - trying https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 15:52:29 INFO - Downloaded 1199 bytes. 15:52:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:52:29 INFO - Using the following test package requirements: 15:52:29 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:52:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:52:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:52:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'jsshell-mac.zip'], 15:52:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:52:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:52:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:52:29 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:52:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:52:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:52:29 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:52:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:52:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:52:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:52:29 INFO - Fetch https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:52:29 INFO - Http code: 200 15:52:29 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 15:52:29 INFO - x-amz-cf-id: VtKfPqShtdco1VcRQiwf6Mz22zzSfj73wlgxr6N7fxHtMQFoipOMiQ== 15:52:29 INFO - x-amz-version-id: VOJ4gnb4.i_qQVAv1SBW2OH2lD3eXEbj 15:52:30 INFO - Expected file size: 16514321 15:52:30 INFO - Obtained file size: 16514321 15:52:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:52:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:52:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:52:36 INFO - Fetch https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:52:37 INFO - Http code: 200 15:52:37 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 15:52:37 INFO - x-amz-cf-id: Uz7DLGE2xp1MW14dqK0iRSRhYoCw9t1NEqvMjZHmoEjyUoZAaoL0bQ== 15:52:37 INFO - x-amz-version-id: VOJ4gnb4.i_qQVAv1SBW2OH2lD3eXEbj 15:52:37 INFO - Expected file size: 16514321 15:52:37 INFO - Obtained file size: 16514321 15:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:52:44 INFO - Http code: 200 15:52:44 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 15:52:44 INFO - x-amz-cf-id: l65_Cc4rkmZAf9vx3lD_9XjcyxglY2wkwDvxhLMuqzGsb6Vjub7uLw== 15:52:44 INFO - x-amz-version-id: 4l_83m7QVAxKmmE.dv7jVKqzLb7gy4I1 15:52:51 INFO - Expected file size: 14409006 15:52:51 INFO - Obtained file size: 14409006 15:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:51 INFO - trying https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:52:51 INFO - Downloading https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 15:52:55 INFO - Downloaded 111666536 bytes. 15:52:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:52:55 INFO - mkdir: /builds/slave/test/properties 15:52:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:55 INFO - Contents: 15:52:55 INFO - build_url:https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:52:56 INFO - Running post-action listener: _resource_record_post_action 15:52:56 INFO - Running post-action listener: set_extra_try_arguments 15:52:56 INFO - [mozharness: 2016-10-13 22:52:56.021995Z] Finished download-and-extract step (success) 15:52:56 INFO - [mozharness: 2016-10-13 22:52:56.022147Z] Running populate-webroot step. 15:52:56 INFO - Running pre-action listener: _resource_record_pre_action 15:52:56 INFO - Running main action method: populate_webroot 15:52:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:56 INFO - '--tppagecycles', 15:52:56 INFO - '7'], 15:52:56 INFO - 'tests': ['tsvgm']}}, 15:52:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['damp', 'tps']}, 15:52:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'tests': ['damp', 'tps']}, 15:52:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['dromaeo_dom']}, 15:52:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['basic_compositor_video']}, 15:52:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:52:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore', 15:52:56 INFO - 'tabpaint']}, 15:52:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore', 15:52:56 INFO - 'tabpaint']}, 15:52:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore', 15:52:56 INFO - 'tabpaint']}, 15:52:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore', 15:52:56 INFO - 'tabpaint']}, 15:52:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore', 15:52:56 INFO - 'tabpaint']}, 15:52:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore', 15:52:56 INFO - 'tabpaint']}, 15:52:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['tsvgx', 15:52:56 INFO - 'tsvgr_opacity', 15:52:56 INFO - 'tart', 15:52:56 INFO - 'tscrollx', 15:52:56 INFO - 'cart']}, 15:52:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:56 INFO - 'tsvgr_opacity', 15:52:56 INFO - 'tart', 15:52:56 INFO - 'tscrollx', 15:52:56 INFO - 'cart']}, 15:52:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--disable-e10s'], 15:52:56 INFO - 'tests': ['tp5o']}, 15:52:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'tests': ['tp5o']}, 15:52:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--disable-e10s', 15:52:56 INFO - '--xperf_path', 15:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:56 INFO - 'tests': ['tp5n']}, 15:52:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--xperf_path', 15:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:56 INFO - 'tests': ['tp5n']}}, 15:52:56 INFO - 'talos.zip': {'path': '', 15:52:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:56 INFO - Running post-action listener: _resource_record_post_action 15:52:56 INFO - [mozharness: 2016-10-13 22:52:56.040850Z] Finished populate-webroot step (success) 15:52:56 INFO - [mozharness: 2016-10-13 22:52:56.040982Z] Running create-virtualenv step. 15:52:56 INFO - Running pre-action listener: _resource_record_pre_action 15:52:56 INFO - Running main action method: create_virtualenv 15:52:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:56 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 15:52:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:56 INFO - Using real prefix '/tools/python27' 15:52:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:56 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:59 INFO - Installing pip.................done. 15:52:59 INFO - Return code: 0 15:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:53:00 INFO - Reading from file tmpfile_stdout 15:53:00 INFO - Output received: 15:53:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:53:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:00 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 15:53:00 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 15:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:00 INFO - 'HOME': '/Users/cltbld', 15:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:00 INFO - 'LOGNAME': 'cltbld', 15:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:00 INFO - 'MOZ_NO_REMOTE': '1', 15:53:00 INFO - 'NO_EM_RESTART': '1', 15:53:00 INFO - 'PAGER': '/bin/cat', 15:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:00 INFO - 'PWD': '/builds/slave/test', 15:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:00 INFO - 'SHELL': '/bin/bash', 15:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:00 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:00 INFO - 'USER': 'cltbld', 15:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:00 INFO - 'XPC_FLAGS': '0x0', 15:53:00 INFO - 'XPC_SERVICE_NAME': '0', 15:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:00 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 15:53:00 INFO - Cleaning up... 15:53:00 INFO - Return code: 0 15:53:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:00 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 15:53:00 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 15:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:00 INFO - 'HOME': '/Users/cltbld', 15:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:00 INFO - 'LOGNAME': 'cltbld', 15:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:00 INFO - 'MOZ_NO_REMOTE': '1', 15:53:00 INFO - 'NO_EM_RESTART': '1', 15:53:00 INFO - 'PAGER': '/bin/cat', 15:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:00 INFO - 'PWD': '/builds/slave/test', 15:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:00 INFO - 'SHELL': '/bin/bash', 15:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:00 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:00 INFO - 'USER': 'cltbld', 15:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:00 INFO - 'XPC_FLAGS': '0x0', 15:53:00 INFO - 'XPC_SERVICE_NAME': '0', 15:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:00 INFO - Downloading/unpacking psutil>=3.1.1 15:53:00 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 15:53:00 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 15:53:00 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 15:53:00 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 15:53:00 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 15:53:00 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 15:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:03 INFO - Installing collected packages: psutil 15:53:03 INFO - Running setup.py install for psutil 15:53:03 INFO - building 'psutil._psutil_osx' extension 15:53:03 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 15:53:04 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 15:53:04 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 15:53:04 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 15:53:04 INFO - building 'psutil._psutil_posix' extension 15:53:04 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 15:53:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:53:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:53:04 INFO - ^ 15:53:04 INFO - 1 warning generated. 15:53:04 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 15:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:04 INFO - Successfully installed psutil 15:53:04 INFO - Cleaning up... 15:53:05 INFO - Return code: 0 15:53:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:05 INFO - 'HOME': '/Users/cltbld', 15:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:05 INFO - 'LOGNAME': 'cltbld', 15:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:05 INFO - 'MOZ_NO_REMOTE': '1', 15:53:05 INFO - 'NO_EM_RESTART': '1', 15:53:05 INFO - 'PAGER': '/bin/cat', 15:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:05 INFO - 'PWD': '/builds/slave/test', 15:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:05 INFO - 'SHELL': '/bin/bash', 15:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:05 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:05 INFO - 'USER': 'cltbld', 15:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:05 INFO - 'XPC_FLAGS': '0x0', 15:53:05 INFO - 'XPC_SERVICE_NAME': '0', 15:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:05 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 15:53:05 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 15:53:05 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 15:53:05 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 15:53:05 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 15:53:05 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 15:53:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:07 INFO - Installing collected packages: mozsystemmonitor 15:53:07 INFO - Running setup.py install for mozsystemmonitor 15:53:07 INFO - Successfully installed mozsystemmonitor 15:53:07 INFO - Cleaning up... 15:53:08 INFO - Return code: 0 15:53:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:08 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:08 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 15:53:08 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 15:53:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:08 INFO - 'HOME': '/Users/cltbld', 15:53:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:08 INFO - 'LOGNAME': 'cltbld', 15:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:08 INFO - 'MOZ_NO_REMOTE': '1', 15:53:08 INFO - 'NO_EM_RESTART': '1', 15:53:08 INFO - 'PAGER': '/bin/cat', 15:53:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:08 INFO - 'PWD': '/builds/slave/test', 15:53:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:08 INFO - 'SHELL': '/bin/bash', 15:53:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:08 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:08 INFO - 'USER': 'cltbld', 15:53:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:08 INFO - 'XPC_FLAGS': '0x0', 15:53:08 INFO - 'XPC_SERVICE_NAME': '0', 15:53:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:08 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:08 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 15:53:08 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 15:53:08 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 15:53:08 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 15:53:08 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 15:53:08 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 15:53:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:11 INFO - warning: no files found matching '*.txt' 15:53:11 INFO - no previously-included directories found matching 'build' 15:53:11 INFO - no previously-included directories found matching 'dist' 15:53:11 INFO - no previously-included directories found matching '.git*' 15:53:11 INFO - Installing collected packages: jsonschema, functools32 15:53:11 INFO - Running setup.py install for functools32 15:53:11 INFO - warning: no files found matching '*.txt' 15:53:11 INFO - no previously-included directories found matching 'build' 15:53:11 INFO - no previously-included directories found matching 'dist' 15:53:11 INFO - no previously-included directories found matching '.git*' 15:53:11 INFO - Successfully installed jsonschema functools32 15:53:11 INFO - Cleaning up... 15:53:11 INFO - Return code: 0 15:53:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:11 INFO - 'HOME': '/Users/cltbld', 15:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:11 INFO - 'LOGNAME': 'cltbld', 15:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:11 INFO - 'MOZ_NO_REMOTE': '1', 15:53:11 INFO - 'NO_EM_RESTART': '1', 15:53:11 INFO - 'PAGER': '/bin/cat', 15:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:11 INFO - 'PWD': '/builds/slave/test', 15:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:11 INFO - 'SHELL': '/bin/bash', 15:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:11 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:11 INFO - 'USER': 'cltbld', 15:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:11 INFO - 'XPC_FLAGS': '0x0', 15:53:11 INFO - 'XPC_SERVICE_NAME': '0', 15:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:11 INFO - Cleaning up... 15:53:11 INFO - Return code: 0 15:53:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:11 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 15:53:11 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 15:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:11 INFO - 'HOME': '/Users/cltbld', 15:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:11 INFO - 'LOGNAME': 'cltbld', 15:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:11 INFO - 'MOZ_NO_REMOTE': '1', 15:53:11 INFO - 'NO_EM_RESTART': '1', 15:53:11 INFO - 'PAGER': '/bin/cat', 15:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:11 INFO - 'PWD': '/builds/slave/test', 15:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:11 INFO - 'SHELL': '/bin/bash', 15:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:11 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:11 INFO - 'USER': 'cltbld', 15:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:11 INFO - 'XPC_FLAGS': '0x0', 15:53:11 INFO - 'XPC_SERVICE_NAME': '0', 15:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:12 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:12 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 15:53:12 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 15:53:12 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 15:53:12 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 15:53:12 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 15:53:12 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 15:53:14 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:15 INFO - Downloading docopt-0.6.1.tar.gz 15:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:15 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:15 INFO - Running setup.py install for blobuploader 15:53:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:16 INFO - Running setup.py install for requests 15:53:16 INFO - Running setup.py install for docopt 15:53:16 INFO - Successfully installed blobuploader requests docopt 15:53:16 INFO - Cleaning up... 15:53:16 INFO - Return code: 0 15:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:16 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:16 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 15:53:16 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 15:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:16 INFO - 'HOME': '/Users/cltbld', 15:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:16 INFO - 'LOGNAME': 'cltbld', 15:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:16 INFO - 'MOZ_NO_REMOTE': '1', 15:53:16 INFO - 'NO_EM_RESTART': '1', 15:53:16 INFO - 'PAGER': '/bin/cat', 15:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:16 INFO - 'PWD': '/builds/slave/test', 15:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:16 INFO - 'SHELL': '/bin/bash', 15:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:16 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:16 INFO - 'USER': 'cltbld', 15:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:16 INFO - 'XPC_FLAGS': '0x0', 15:53:16 INFO - 'XPC_SERVICE_NAME': '0', 15:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-RChIAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-H8_wkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-nsdsaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LOivu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-I5pGUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-kOtaYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-4C529t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-tqNQsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-b2Plp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-HGIYxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:18 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-KCBZOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:18 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-drpSre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:18 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-rLDHPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:18 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-KzbqoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:18 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-2DJsGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:18 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-oCxUvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:18 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-IX660Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:18 INFO - Running setup.py install for manifestparser 15:53:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:18 INFO - Running setup.py install for mozcrash 15:53:19 INFO - Running setup.py install for mozdebug 15:53:19 INFO - Running setup.py install for mozdevice 15:53:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Running setup.py install for mozfile 15:53:19 INFO - Running setup.py install for mozhttpd 15:53:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Running setup.py install for mozinfo 15:53:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Running setup.py install for mozInstall 15:53:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:19 INFO - Running setup.py install for mozleak 15:53:20 INFO - Running setup.py install for mozlog 15:53:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:20 INFO - Running setup.py install for moznetwork 15:53:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:20 INFO - Running setup.py install for mozprocess 15:53:20 INFO - Running setup.py install for mozprofile 15:53:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:20 INFO - Running setup.py install for mozrunner 15:53:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:20 INFO - Running setup.py install for mozscreenshot 15:53:21 INFO - Running setup.py install for moztest 15:53:21 INFO - Running setup.py install for mozversion 15:53:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:21 INFO - Cleaning up... 15:53:21 INFO - Return code: 0 15:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:22 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:22 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 15:53:22 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 15:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:22 INFO - 'HOME': '/Users/cltbld', 15:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:22 INFO - 'LOGNAME': 'cltbld', 15:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:22 INFO - 'MOZ_NO_REMOTE': '1', 15:53:22 INFO - 'NO_EM_RESTART': '1', 15:53:22 INFO - 'PAGER': '/bin/cat', 15:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:22 INFO - 'PWD': '/builds/slave/test', 15:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:22 INFO - 'SHELL': '/bin/bash', 15:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:22 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:22 INFO - 'USER': 'cltbld', 15:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:22 INFO - 'XPC_FLAGS': '0x0', 15:53:22 INFO - 'XPC_SERVICE_NAME': '0', 15:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_TrVzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:22 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)) 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-I6jXsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:22 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)) 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Mpp5mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:22 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)) 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_qHrR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:22 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)) 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-J4qwL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:22 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)) 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-95FbFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:22 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)) 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-yffHE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:23 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)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-EcIc_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:23 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)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-evQae5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:23 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)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-gkWAg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-p7qK8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:23 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)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_I3wOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-hk9vMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:23 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)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-BguuY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-J9EnBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:23 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)) 15:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:23 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-qDJPmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:24 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)) 15:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:24 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vJ77k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:24 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)) 15:53:24 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)) 15:53:24 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)) 15:53:24 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)) 15:53:24 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)) 15:53:24 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)) 15:53:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:26 INFO - Downloading blessings-1.6.tar.gz 15:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:27 INFO - Installing collected packages: blessings 15:53:27 INFO - Running setup.py install for blessings 15:53:27 INFO - Successfully installed blessings 15:53:27 INFO - Cleaning up... 15:53:27 INFO - Return code: 0 15:53:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:27 INFO - Reading from file tmpfile_stdout 15:53:27 INFO - Current package versions: 15:53:27 INFO - blessings == 1.6 15:53:27 INFO - blobuploader == 1.2.4 15:53:27 INFO - docopt == 0.6.1 15:53:27 INFO - functools32 == 3.2.3-2 15:53:27 INFO - jsonschema == 2.5.1 15:53:27 INFO - manifestparser == 1.1 15:53:27 INFO - mozInstall == 1.12 15:53:27 INFO - mozcrash == 0.17 15:53:27 INFO - mozdebug == 0.1 15:53:27 INFO - mozdevice == 0.48 15:53:27 INFO - mozfile == 1.2 15:53:27 INFO - mozhttpd == 0.7 15:53:27 INFO - mozinfo == 0.9 15:53:27 INFO - mozleak == 0.1 15:53:27 INFO - mozlog == 3.4 15:53:27 INFO - moznetwork == 0.27 15:53:27 INFO - mozprocess == 0.23 15:53:27 INFO - mozprofile == 0.28 15:53:27 INFO - mozrunner == 6.12 15:53:27 INFO - mozscreenshot == 0.1 15:53:27 INFO - mozsystemmonitor == 0.3 15:53:27 INFO - moztest == 0.7 15:53:27 INFO - mozversion == 1.4 15:53:27 INFO - psutil == 3.1.1 15:53:27 INFO - requests == 1.2.3 15:53:27 INFO - wsgiref == 0.1.2 15:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:27 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 15:53:27 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 15:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:27 INFO - 'HOME': '/Users/cltbld', 15:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:27 INFO - 'LOGNAME': 'cltbld', 15:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:27 INFO - 'MOZ_NO_REMOTE': '1', 15:53:27 INFO - 'NO_EM_RESTART': '1', 15:53:27 INFO - 'PAGER': '/bin/cat', 15:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:27 INFO - 'PWD': '/builds/slave/test', 15:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:27 INFO - 'SHELL': '/bin/bash', 15:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:27 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:27 INFO - 'USER': 'cltbld', 15:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:27 INFO - 'XPC_FLAGS': '0x0', 15:53:27 INFO - 'XPC_SERVICE_NAME': '0', 15:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 INFO - Cleaning up... 15:53:27 INFO - Return code: 0 15:53:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 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 0x10a793490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a709570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae40d7a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, '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.fKoY1Aij02/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.PzHe7F0zqN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 15:53:27 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 15:53:27 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 15:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:27 INFO - 'HOME': '/Users/cltbld', 15:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:27 INFO - 'LOGNAME': 'cltbld', 15:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:27 INFO - 'MOZ_NO_REMOTE': '1', 15:53:27 INFO - 'NO_EM_RESTART': '1', 15:53:27 INFO - 'PAGER': '/bin/cat', 15:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:27 INFO - 'PWD': '/builds/slave/test', 15:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:27 INFO - 'SHELL': '/bin/bash', 15:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:53:27 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:27 INFO - 'USER': 'cltbld', 15:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:27 INFO - 'XPC_FLAGS': '0x0', 15:53:27 INFO - 'XPC_SERVICE_NAME': '0', 15:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:28 INFO - Cleaning up... 15:53:28 INFO - Return code: 0 15:53:28 INFO - Running post-action listener: _resource_record_post_action 15:53:28 INFO - Running post-action listener: _start_resource_monitoring 15:53:28 INFO - Starting resource monitoring. 15:53:28 INFO - [mozharness: 2016-10-13 22:53:28.121502Z] Finished create-virtualenv step (success) 15:53:28 INFO - [mozharness: 2016-10-13 22:53:28.122455Z] Running install step. 15:53:28 INFO - Running pre-action listener: _resource_record_pre_action 15:53:28 INFO - Running main action method: install 15:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:28 INFO - Reading from file tmpfile_stdout 15:53:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:28 INFO - Reading from file tmpfile_stdout 15:53:28 INFO - Output received: 15:53:28 INFO - Usage: mozinstall [options] installer 15:53:28 INFO - Options: 15:53:28 INFO - -h, --help show this help message and exit 15:53:28 INFO - -d DEST, --destination=DEST 15:53:28 INFO - Directory to install application into. [default: 15:53:28 INFO - "/builds/slave/test"] 15:53:28 INFO - --app=APP Application being installed. [default: firefox] 15:53:28 INFO - mkdir: /builds/slave/test/build/application 15:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:54:03 INFO - Reading from file tmpfile_stdout 15:54:03 INFO - Output received: 15:54:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:54:03 INFO - Running post-action listener: _resource_record_post_action 15:54:03 INFO - [mozharness: 2016-10-13 22:54:03.152445Z] Finished install step (success) 15:54:03 INFO - [mozharness: 2016-10-13 22:54:03.152582Z] Running run-tests step. 15:54:03 INFO - Running pre-action listener: _resource_record_pre_action 15:54:03 INFO - Running main action method: run_tests 15:54:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:54:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:54:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:54:03 INFO - 2016-10-13 15:54:03.166 screenresolution[1661:7464] starting screenresolution argv=screenresolution get 15:54:03 INFO - 2016-10-13 15:54:03.169 screenresolution[1661:7464] Display 0: 1600x1200x32@60 15:54:03 INFO - 2016-10-13 15:54:03.175 screenresolution[1662:7466] starting screenresolution argv=screenresolution list 15:54:03 INFO - Available Modes on Display 0 15:54:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:54:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:54:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:54:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:54:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:54:03 INFO - Intel Iris: 15:54:03 INFO - Chipset Model: Intel Iris 15:54:03 INFO - Type: GPU 15:54:03 INFO - Bus: Built-In 15:54:03 INFO - VRAM (Dynamic, Max): 1536 MB 15:54:03 INFO - Vendor: Intel (0x8086) 15:54:03 INFO - Device ID: 0x0a2e 15:54:03 INFO - Revision ID: 0x0009 15:54:03 INFO - Displays: 15:54:03 INFO - Display: 15:54:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:54:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:54:03 INFO - Display Serial Number: 1600x1200 60 15:54:03 INFO - Main Display: Yes 15:54:03 INFO - Mirror: Off 15:54:03 INFO - Online: Yes 15:54:03 INFO - Rotation: Supported 15:54:03 INFO - Return code: 0 15:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:03 INFO - Python 2.7.3 15:54:03 INFO - Return code: 0 15:54:03 INFO - grabbing minidump binary from tooltool 15:54:03 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:03 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 0x10a5a7d30>, '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 0x10a3cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a59fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:03 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 15:54:03 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 15:54:03 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 15:54:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:03 INFO - Return code: 0 15:54:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:54:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:54:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 15:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --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 15:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fKoY1Aij02/Render', 15:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:03 INFO - 'HOME': '/Users/cltbld', 15:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:03 INFO - 'LOGNAME': 'cltbld', 15:54:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:03 INFO - 'MOZ_NO_REMOTE': '1', 15:54:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:03 INFO - 'NO_EM_RESTART': '1', 15:54:03 INFO - 'PAGER': '/bin/cat', 15:54:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:03 INFO - 'PWD': '/builds/slave/test', 15:54:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:03 INFO - 'SHELL': '/bin/bash', 15:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzHe7F0zqN/Listeners', 15:54:03 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 15:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:03 INFO - 'USER': 'cltbld', 15:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:03 INFO - 'XPC_FLAGS': '0x0', 15:54:03 INFO - 'XPC_SERVICE_NAME': '0', 15:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 15:54:03 INFO - mozversion application_buildid: 20161013133620 15:54:03 INFO - mozversion application_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 15:54:03 INFO - mozversion application_display_name: Nightly 15:54:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:03 INFO - mozversion application_name: Firefox 15:54:03 INFO - mozversion application_remotingname: firefox 15:54:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:54:03 INFO - mozversion application_vendor: Mozilla 15:54:03 INFO - mozversion application_version: 52.0a1 15:54:03 INFO - mozversion platform_buildid: 20161013133620 15:54:03 INFO - mozversion platform_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 15:54:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:54:03 INFO - mozversion platform_version: 52.0a1 15:54:03 INFO - using testdate: 1476399243 15:54:03 INFO - actual date: 1476399243 15:54:03 INFO - starting webserver on 'localhost:49271' 15:54:03 INFO - SUITE-START | Running 2 tests 15:54:03 INFO - TEST-START | dromaeo_css 15:54:03 INFO - operating with platform_type : mac_ 15:54:03 INFO - Initialising browser for dromaeo_css test... 15:54:03 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpdzBiJD/profile http://localhost:49271/getInfo.html) 15:54:06 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 15:54:06 INFO - PROCESS | 1672 | colorDepth:24 15:54:06 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 15:54:06 INFO - PROCESS | 1672 | __metrics 15:54:06 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" 15:54:06 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:06 INFO - TEST-INFO | 1672: exit 0 15:54:06 INFO - Browser initialized. 15:54:06 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:06 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpdzBiJD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:18 INFO - PROCESS | 1677 | RSS: Main: 235466752 15:54:18 INFO - PROCESS | 1677 | 15:55:10 INFO - PROCESS | 1677 | 1476399310337 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] 15:57:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 15:57:25 INFO - PROCESS | 1677 | RSS: Main: 478175232 15:57:25 INFO - PROCESS | 1677 | 16:00:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:00:29 INFO - PROCESS | 1677 | RSS: Main: 374845440 16:00:29 INFO - PROCESS | 1677 | 16:03:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:03:32 INFO - PROCESS | 1677 | RSS: Main: 345485312 16:03:32 INFO - PROCESS | 1677 | 16:06:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:06:35 INFO - PROCESS | 1677 | RSS: Main: 359546880 16:06:35 INFO - PROCESS | 1677 | 16:09:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:09:39 INFO - PROCESS | 1677 | RSS: Main: 337649664 16:09:39 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:12:42 INFO - PROCESS | 1677 | RSS: Main: 462180352 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | __start_tp_report 16:12:42 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 16:12:42 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 16:12:42 INFO - PROCESS | 1677 | |i|pagename|runs| 16:12:42 INFO - PROCESS | 1677 | |0;dojo.html;2973.7026297370267;3307.966920330796;3311.552940353052;3336.9499457508127;3368.9326213475733;5502.477264659851;5556.611037227391;5596.076647353182;5624.437556244378;5644.689542075184;5544.473275038875;5606.803761868326;5612.607117501777;5623.943760562393;5626;4182.268103081956;5121.436641969381;5129.743512824362;5146.253793199984;5212.713300768456;4285.57144285572;5161.27742116104;5246.37043554772;5256.211568264772;5270.130428479296;5100.897982040376;5139.280500729901;5173.3533308336455;5182.352205974254;5208.140656791625;5210.921836172422;5215.165573508259;5241.109011468059;5241.580673546107;5319.069162896478;5030.968651426449;5075.0357432087785;5084.720340381277;5107.897842043139;5175.534201921808;5563.972180139073;5595.468430499137;5614.214010038598;5625.40933202012;5667.744951477152;6154.753809847601;6159;6166.84582885427;6167.352427995085;6181;5960.493358064527;6043.546733994968;6128.509719222451;6242.15730876335;6245.656488893154;5648.745806438679;5653.067243904709;5653.547716182696;5660.801871934463;5669.1496275558175;6218.098375735583;6226.439620434092;6232.532560057924;6290.654014029273;6303.432691057827;6076.210092687922;6079.240094988127;6086.847828804315;6104.254103856739;6137.662428566382;6196.884560779103;6198.752049918043;6212.316645169028;6237.064440333987;6248.781292654826;5947.791827286024;6006.339302676702;6097.222222222223;6099.085137229363;6158.291796443376;6150.7232174552255;6180.536459765535;6199.225096862892;6205.379462053758;6223.564350495512;4904.8038078477175;4910.729909854921;4915.18899381598;4927.852164435073;4942.802287908444;4305.655547556188;4345.217860785089;4349;4393.231184542692;4424.977875110604;5650.660960342392;5657.773689052474;5661.179129026351;5671.489565939003;5690.6870122142855;6116.640127388518;6138.9095594588325;6139.706800529493;6146.279041868284;6156.661383623854;5617.8033768817895;5644.238027866186;5661.688607126647;5664.291963504562;5666.150077488327;5299.629025968223;5330.360356757214;5334.413214546396;5343.305370301836;5363.597730170253;6152.538559608047;6296.433321001132;6331.841703957438;6334.588251763621;6334.588251763621;6127.387261273837;6133.172021777003;6142.385761423822;6146.2175968968495;6244.906326405016;6289.182406287154;6291.937080629135;6294.5593808434805;6312.14786003902;6313.936860631518;5967.283925928917;6120.908186377297;6143.631382117087;6156.538259630456;6164.969175154096;6119.125753810745;6120.724567394389;6138.541671868701;6147.801178770097;6149.477294430024;5818.650880947157;5961.821145365646;6014.248218972629;6031.638101713911;6033.668148251888;5245.790168393374;5948.464638182584;5952.4642782148085;6002.129691194665;6015.338312785678;5793.623414478046;5865.266841644794;5905.970470147794;5920.970395148169;5930.288365396007;5913.911291330547;5989.700514974146;6002.189704389852;6019.337872833898;6070.484008859296;5846.619969701956;5847.44449277318;5855.209546711139;5870.589058766016;5898.8230353089475 16:12:42 INFO - PROCESS | 1677 | |1;ext.html;461.76219247087744;485.3641729334571;486.5110563883297;530.1332321654099;537.7042626555397;30337.69662303379;39792.80103599482;40719.59280407195;40755.38866916999;42850.785746071226;41524.79237603808;41750;41807.95480112991;41837.74486765402;41959.58040419595;7963.283304502608;9571.856422153673;9572.760680982996;9572.80854382912;9598.520073996307;8646.48121112732;8873.95563022184;11383.203175777699;11660.47527861244;11693.064554835593;11481.59814406496;11555.133364997617;11560;11574.768504629945;11731.7067073323;11549.076073914108;11610.477528511154;11650.6504804856;11655.650330490098;11659.358735269558;8669.609867555975;8889.911100888972;9799.363041402286;10972.890271097267;11451.141164412618;40127.79936100301;40368;40416;40434.797826010974;40471.7976410119;3063.938721225585;3210.956439157283;3218.0667606394118;3347.548081009057;3597.8380972856285;23687;30617.08148755541;31291.74833006677;31335.37329253425;31383.686163138533;3086.213015680987;3132.1543183340373;3212.646608873022;3213.1806389370795;3213.373392188524;479326;482406;483346;485788;491054;60085.09872351918;60539.22181283689;60570;60579.69710151421;60605;60447.79104417887;62853;62865.08484066749;63115.6844215776;63161.684191578745;15834.208289585475;16057.518274451784;16073.919630401773;16078.598035048983;16084.43704470338;11261.43692815356;12578.371081445892;12607.432665530074;12651.746965060647;12668.303243321521;14517;15001.249937503082;16512.42206522766;16896.155192240338;16929;4571.290361591481;6214.347493513116;6225.533085018642;6265.279492858289;6271.122042913996;868.4398562926876;1001.9899801002042;1033.214756784834;1044.9425281609433;1054.504382940017;29257.707422925498;29491.05089491034;29535.409291814474;29733.55399669007;30193.245168870955;883.412530667112;980.6273616026007;1008.435276245305;1034.4414016431194;1132.841402203692;14766.11403315783;15191.848081519043;15350;15436.922815386075;15613.765793513106;594757;599872;600320;600809;601226;56058.159127613115;56224.71887640617;56245.43754562484;56389.7180514103;56415;1265.4115836136057;1307.235267368581;1319.3798914510164;1329.1626275446406;1330.1619979413101;28176.013839516338;29128.27179320534;29247.561286581145;29755;29877.701222987493;49940.75029624828;50341;50470.49529504658;50518.74740626274;50595.74702126466;591121;592568;594662;595236;595590;33675;34186.82906585451;37774;40342.79828600956;40760.59239407568;34493.97415420396;42235.7888210557;42694.78652606717;45185.548144519445;46272.07455850932;36075;36237.45643815292;36555.08612284714;37605.43591846179;37786.62213377831;31368;33904.66095339114;37117.25765484621;37875.81062094672;38150.42774358443;35753.284934301686;35957;36863.44704829376;36956.630433696395;37180.62819371772;31140.844295778377;31689.524657130623;33179.17052073718;33292.833535832164;33398.833005834815;23950.28149155528;24072.03711851506;24351.26946191617;24650.26049218526;24753.87623061873 16:12:42 INFO - PROCESS | 1677 | |2;jquery.html;358.44441116269786;368.6074330837658;374.37479409386333;385.7396257526169;398.1082375478926;15211.163386013764;15531.689366212697;19591.314303999345;20814.479638009037;21299.828509431994;15968.361265549363;17218.56953576158;19072.141753621087;20009.799902000974;20859;4943.456219815817;6053.455189032986;6058.727357268912;6063.787767428141;6071.635701857903;5584.134459158837;5866.706664666771;5931.851703707399;5942.881142377149;5947.672877991708;4148.713898691415;4361.193179261847;4362.345648152786;4390.121975604876;5921.526277897779;4266.914661706764;6207.441330280274;6341.460975817061;6496.545241833073;6545.443637290836;5686.516646085046;5700.914486282709;5707.315122185323;5725;5751.597388182829;25970.350741231432;26509.46981060368;26522.071727489638;26665.93336266547;26887.731122688914;2496.3135137837057;2508.974910250911;2519.6976362836576;3067.2331917020747;3140.654528001918;12825.935870320682;15403.922980385027;15535.533933981886;15982;16144.677106457922;1761.7621621081119;1782.117851663435;1791.5610675384485;1882.1718443884647;1895.5829717462136;124479;127902;130052;130660;130703;10466.581336746445;10605.469726513798;11007.339559626447;11264.155188360906;11301.32192068462;13789.448422063206;13805.240711760749;13814.723705526034;13822.93088534551;13834.377453014638;8217.178282171855;8511.872321915176;8522.914770852336;8641.611127499278;8663.436876603;7064.858702825914;7109.964450177716;8224.506529608243;8537.530435825965;8722.738317850475;5351.464853514695;6527.477801775846;6642.867142657216;6643.368879956396;6655.46756259498;1483.3547406878042;1814.1473507451476;1817.7182536706832;1821.3625231169249;1823.4347352320824;707.7664370757637;860.6815478272954;879.5690111845278;951.148721893915;964.8745663063756;21894.343169704935;22304.665430018562;22540.54918901613;22579;22615.54768904613;901.5582364641278;917.660465627722;954.5370495309769;962.841131213356;997.2570435025807;11148.721281967853;11950.282983021047;12034.699132521757;12058.155929085055;12070.637880863587;436530;576209;606845;616346;619528;114101.71796564189;123391;124457.37771311085;126485.36757316338;126996;1016.1413605503337;1020.9795804083876;1037.5590374090982;1043.2332235806675;1076.9299995500267;19509.902450487658;19935.401937941304;20084.397468075982;20163;20182;52321.73839130932;52733.7363313181;55736.44263557313;55823.441765581825;56455.58861028507;75801.24198757941;78479.82280265687;78557.60721196358;78829.21170788447;79495;7915.643796029078;8003.5193489204685;8154.959225203836;8216.589170541569;8310.87533686983;10997.175211859303;11572.42137893085;12805.103642744918;13344.933275333562;13419.993500487308;10919.181061420584;10943.781124377309;11107.83338249943;11271.887281127412;11686.298822070703;11030.393328367018;11202.495887685236;11510.36692981894;11747.412629368668;11767.470463829319;11136;11473.36896470702;11521.251118677259;11776.82334764962;11988.820167697317;8010.679572817022;8128.634211460617;8202.466839655403;8245.95877020611;8259;9827.5086245686;11272.436378181223;11589.478473468545;11598.304101753922;11719.824202637137 16:12:42 INFO - PROCESS | 1677 | |3;mootools.html;1281.9615411537654;1513.856183662552;1651.8348165183484;1834.2662934826076;1862.5902301493666;8172.7548173554815;8655.567221638916;8671.436356636823;8685.739427817176;8712.998005229401;7673.271039251276;7966.32286255669;7979.122296547375;8286.378521610874;8524.403291769579;2262.7171603549514;2287.49675071484;2294.265834932822;2297.3682237384687;2303.078768492608;2277.7836105569945;2283.315005498344;2313.9652905206435;2321.686572312733;2322.9651555226687;2285.1430713482446;2302.2517681753498;2318.0959425823944;2320.3155069254526;2322.5703244899746;2271.4662054417363;2285.211601997308;2291.759365266648;2293.759155288704;2293.9655905161435;1863;2269.1490690990877;2275.2719129878446;2275.9317220483413;2281.087564974007;8637.481751094892;8706.782330441727;8707.782305442415;8708.521031343274;8732.51971141587;4763.428388593356;4870.391201099863;4875.536824001714;4880.243562247857;4882.926756098661;3084.2135255509925;3218.388506183841;3230.176305042199;3267.836608169582;3416.931661366759;898.955052247385;1008.9596416143346;1035.254616675992;1056.7939251845894;1057.9947100264526;10170.44062576558;10177.592896284139;10184.134348580379;10192.133668638175;10194.98050194982;3669.2844895245703;4321.018200532442;4336.34954756789;4440.4227450431235;4467.441569803775;8856.822863542693;8858.557072146366;8869.467831930106;8872.157145071207;8873.112688731075;4859.173940430064;4861.1006963711825;4861.465238823726;4865.0756356292195;4865.0756356292195;4211.157768446323;4340.414044104069;4466.173757854807;4554.954450455453;4681.531846815291;3734.775913445202;3799.164183879542;3863.9034024149623;3884.533855937306;3895.435161901565;1238.3684320996356;1241.1498123785236;1247.5633528265034;1248.1699669719717;1259.420666493405;849.392684230778;856.8586183279814;906.1120102299651;907.9863802042843;950.9334346595672;5573.749181286852;5654.264945557051;5872.7357268923;5908.231929849092;5973.028900462837;924.1267002682534;931.5575101826713;942.8302905476943;948.8244674735058;991.9950400247952;3555.9644403555635;3959.208158368338;4020.4974378202724;4115.444415003996;4133.008078061243;7697.807554811063;10220.335678180894;10419.010194031554;10562.841557376645;10597.25819192649;8793.120687931283;10513.053825155772;10523.26337156407;10541.262111652264;10567.63013294531;7627.199144089791;8051.114377418479;8137.674493020213;8141.51150930946;8154.796130096676;4765.6187504998825;5787.652740835563;5817.894600025981;5882.941170588239;5932.8813423732145;9340.206082483064;9691.9030809691;9749.317547771589;9799.363041402286;9935.254855885692;9668.70993870185;9955.153811926068;9960.302778805413;10101.343412678152;10139.442330671884;6436.227652681709;6512.6092434454085;6638.668066596748;6889.276625954202;7024.016637670628;7441.218672039358;7945.8808117879435;8148.185181481805;8280.83438331242;8329.37529685288;7244.166920804175;7343.559386436831;7362.558246505227;7409.518381305198;7460.216677249028;7175.677094530654;7241.710331586888;7268.80496172353;7283.526570772883;7360.631968401452;6854.897176542456;6872.10662613857;6965.989931459809;6968.163820341591;6975.616341101085;4937.481564435682;4976.601871850316;4999.075171093214;5043.167877300204;5118.129917914038;4759.6668233223345;4958.330625365529;5014.7994080236385;5024.397072351341;5231.843044708665 16:12:42 INFO - PROCESS | 1677 | |4;prototype.html;286.4786089317443;296.3229021685449;305.3724595955311;307.68001278670187;310.9782315237934;4509.413776209092;5022.698638081718;5215.478452154783;5269;5322.525025862973;4552.704074235173;5045.899082018366;5115.514026167508;5187.636865419422;5203.843884683456;4005.2790497710403;4007.298722723526;4009.1981603679237;4023.5775243599364;4026;2927.531594944809;3413.0614081127765;3682.650148235913;4042.4744783178144;4064.146529228851;3984.482017337742;3987.342088555385;4006.939895901564;4021.46647612004;4033.6773058155277;3959.524857017162;3969.583193764642;3972.5431575368625;3980.044789250588;3984.780837053961;3456.5160877476924;3474.6525347465304;3474.878379256739;3487.1630808606005;3492.8777492787885;4392.901774556361;4848.702882040211;5113.974430127862;5114.309568208281;5149.76826042829;4202.684798640114;4410.6030457259;4557.680962332638;4581.8396356127705;4581.908361832778;5547.25112109864;5561;5564.27664403629;5568.7470319178265;5623.803166889139;2974.776891733107;3513.4554144107447;3751.1559899022773;3758;3762.285165818486;4811.628685824523;5739.684317362543;5779.884402311972;5805.82582522525;5812.360640329603;3207.743380529552;3824.1778017726324;3869.28418242626;3871.6709079727975;3875.302445559826;3605.5673319201337;3845.65389114981;3910.9804450977563;3919.9804000980384;3931.292367373843;4359.128174365076;4488.8104652267175;4530.252508336153;4542.432195975503;4626.884327891829;5591.776328946878;5603.579731520153;5631.381407645383;5639.407862174413;5644.238027866268;1188.9702757431132;1208.8670246272902;1237.6843904804218;1250.8061250506187;1311.8163457116011;748.330244431231;750.3754371785134;758.836850077236;786.4101923557332;805.5218673733647;3898.064464528493;4272.551382104896;4364.716293440916;4378.869582584407;4423.447069116361;3957.782321972262;4705.435347758223;4760.809567617326;4779.330893674888;4794.609563226625;3748.887533374003;3968.5634580196156;4005.379166229239;4433.603414924289;4455.6658250631335;2025.7062725904957;2248.5952528545017;2316.447979853502;2357.2103345379146;2464.4208610976407;4534.798278456212;4556.476005259371;4937.925931111036;4949.406071271471;4986.351774269322;3982.9402558961638;4477.261251893467;4770.42754869411;4790;5918.348981612019;5236.397814251333;6035.547333949883;6045.879082418327;6068.9696551517845;6073.969630151998;5708.372079071216;5738.397468265772;5778.971105144616;5796.217815448524;5805.332386775575;5442.319710036246;5635.435876676184;5686.77252909879;5694.579803583543;5706.942930570807;5917.437843404869;5924.229850119457;5957.242613428963;6012.6392416455155;6013.428724271187;3212.887548935776;3768.1144930941755;3853.7801107786927;3870.612938706107;3901.6098390160755;5241.737913104405;5357.973210134081;5744.655320680772;5760.67504473965;5779.4509521597065;4931.3096166536;5568.888622227451;5625.69058701759;5636.464535869086;5646.858828529155;4847.709137451764;5319.6808191508635;5518.42056584069;5542.750576223999;5691.345495268097;4810.302506136521;4986.877952460667;5408.214250024919;5440.591955603267;5478.780848766164;4514.887127821699;4656.371389862461;5452.809151679672;5531.474509921551;5533.723313834212;5404.83785486436;5450.945490545044;5480.6437581557075;5482.424345443671;5515.227868098389 16:12:42 INFO - PROCESS | 1677 | |5;yui.html;639.3606393606394;728.5919884864476;732.7325526182943;772.3589420780753;786.9803254918627;13794.793078103836;14465.132092074484;14481.855181448196;14485.855141448596;14789.334479948402;12281.140320177592;12296.262224266527;12296.877031229686;12329.938350308259;12360.258384496914;641.9743210271583;675.6891829758292;753.3408267765705;765.7281665008925;839.9794249986265;822.5023860564332;831.2934006094802;832.4422636833336;838.0237023867218;838.5094719589048;857.7855536115972;859.6518410043942;860.2558786649565;861.2980420956932;861.4056301152216;685.6537448588481;851.5912362066211;852.9872051919164;853.4921721575653;854.9957250213771;526.4761562245552;631.1794666932968;652.4975768658154;653.3727621483382;657.2015001772869;13168.407421666048;13219.86780132196;13243.536476223382;13244.73510529784;13251.867481325256;12969;13393.933030334883;13421.463141474329;13587.796183057262;13970.091944023607;11650.883491165065;11993.460294286779;12025.458854351575;12088.516459341616;12334.938325308405;4323.978380108079;4331.45856767904;4340.739555626641;4362.454693163355;4467.419235499365;119456;120442.3977880105;120615;120863.39568302102;123681.76318236793;10204.010669951744;10497;10775.78448431027;10829.891701082888;11078.169137314733;21025.264115755876;21033.36899892975;21097.261595844073;21106;21132.47168820792;7446.776596702108;7549.962250188714;7579.848403032019;7589.316961473494;7844.097928738268;3550.3254381667402;4271.466066741657;4319.97840010798;4335.653147748172;4449.7330160190495;3325.86696532136;3430.5711786026745;3432.7768695034742;3435.1068722131927;3441.9655803442147;627.8932581461163;631.6873147791872;635.7202830754453;655.5214693273937;655.52474456019;547.345921623656;564.6470955652717;588.608575297431;607.6232735703892;613.4478968928;8702.91297087021;8752.518611476302;8764.21122099014;8847.336449766293;9085.273178145733;545.2935034860207;548.0682839173421;620.5687047501942;625.352759893508;640.6124294801671;4230.407742915994;4458.799354029076;4503.977480112579;4624.237000894882;4656.8602941911795;92767;110019;140710;144969.5503044956;147535;124531;127690;128332;129526;130123.34938325438;84486.73269900956;90953;98651.50674246726;100727.99272007332;111793.76412471868;9463.337566370288;9589.280803939871;9626.95186524063;9721.85417218728;9746.80506389854;56330.71834640801;57934.710326449785;59388;61305.69347153236;61884.143475695804;85804;95000;95523;95940.52029739806;96475.03524964661;10995.890041099487;12432.689182770504;12749.777284513568;13302.600921972356;13346.265955372548;14487.130772153705;14499.710005800036;14500.984931054725;14530.346134424188;14661.85338146605;13264.403101860633;13301.933490332487;13316.201027938354;14095.859041409454;14131.576052718436;13225;13934.303284835514;13994.650133746738;14007.929960350133;14062.859371406565;10687.679369618923;11850.822237666269;11981.801819818296;12449.25304481734;13283.203007819562;8656.48061116335;10119.190464762949;10227.48862556884;10228.386296822215;10261.127804136731;8197.196616744306;8797.988231353476;9286.489243091424;9359.719208423758;10670.46647667629 16:12:42 INFO - PROCESS | 1677 | __end_tp_report 16:12:42 INFO - PROCESS | 1677 | __start_cc_report 16:12:42 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1689 16:12:42 INFO - PROCESS | 1677 | __end_cc_report 16:12:42 INFO - PROCESS | 1677 | __startTimestamp1476400362964__endTimestamp 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | ------- Summary: start ------- 16:12:42 INFO - PROCESS | 1677 | Number of tests: 6 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5665.32 Median:5870.59 stddev:653.32 (11.1%) stddev-sans-first:620.26 16:12:42 INFO - PROCESS | 1677 | Values: 2973.7 3308.0 3311.6 3336.9 3368.9 5502.5 5556.6 5596.1 5624.4 5644.7 5544.5 5606.8 5612.6 5623.9 5626.0 4182.3 5121.4 5129.7 5146.3 5212.7 4285.6 5161.3 5246.4 5256.2 5270.1 5100.9 5139.3 5173.4 5182.4 5208.1 5210.9 5215.2 5241.1 5241.6 5319.1 5031.0 5075.0 5084.7 5107.9 5175.5 5564.0 5595.5 5614.2 5625.4 5667.7 6154.8 6159.0 6166.8 6167.4 6181.0 5960.5 6043.5 6128.5 6242.2 6245.7 5648.7 5653.1 5653.5 5660.8 5669.1 6218.1 6226.4 6232.5 6290.7 6303.4 6076.2 6079.2 6086.8 6104.3 6137.7 6196.9 6198.8 6212.3 6237.1 6248.8 5947.8 6006.3 6097.2 6099.1 6158.3 6150.7 6180.5 6199.2 6205.4 6223.6 4904.8 4910.7 4915.2 4927.9 4942.8 4305.7 4345.2 4349.0 4393.2 4425.0 5650.7 5657.8 5661.2 5671.5 5690.7 6116.6 6138.9 6139.7 6146.3 6156.7 5617.8 5644.2 5661.7 5664.3 5666.2 5299.6 5330.4 5334.4 5343.3 5363.6 6152.5 6296.4 6331.8 6334.6 6334.6 6127.4 6133.2 6142.4 6146.2 6244.9 6289.2 6291.9 6294.6 6312.1 6313.9 5967.3 6120.9 6143.6 6156.5 6165.0 6119.1 6120.7 6138.5 6147.8 6149.5 5818.7 5961.8 6014.2 6031.6 6033.7 5245.8 5948.5 5952.5 6002.1 6015.3 5793.6 5865.3 5906.0 5921.0 5930.3 5913.9 5989.7 6002.2 6019.3 6070.5 5846.6 5847.4 5855.2 5870.6 5898.8 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:69193.63 Median:36156.23 stddev:149986.85 (414.8%) stddev-sans-first:150318.82 16:12:42 INFO - PROCESS | 1677 | Values: 461.8 485.4 486.5 530.1 537.7 30337.7 39792.8 40719.6 40755.4 42850.8 41524.8 41750.0 41808.0 41837.7 41959.6 7963.3 9571.9 9572.8 9572.8 9598.5 8646.5 8874.0 11383.2 11660.5 11693.1 11481.6 11555.1 11560.0 11574.8 11731.7 11549.1 11610.5 11650.7 11655.7 11659.4 8669.6 8889.9 9799.4 10972.9 11451.1 40127.8 40368.0 40416.0 40434.8 40471.8 3063.9 3211.0 3218.1 3347.5 3597.8 23687.0 30617.1 31291.7 31335.4 31383.7 3086.2 3132.2 3212.6 3213.2 3213.4 479326.0 482406.0 483346.0 485788.0 491054.0 60085.1 60539.2 60570.0 60579.7 60605.0 60447.8 62853.0 62865.1 63115.7 63161.7 15834.2 16057.5 16073.9 16078.6 16084.4 11261.4 12578.4 12607.4 12651.7 12668.3 14517.0 15001.2 16512.4 16896.2 16929.0 4571.3 6214.3 6225.5 6265.3 6271.1 868.4 1002.0 1033.2 1044.9 1054.5 29257.7 29491.1 29535.4 29733.6 30193.2 883.4 980.6 1008.4 1034.4 1132.8 14766.1 15191.8 15350.0 15436.9 15613.8 594757.0 599872.0 600320.0 600809.0 601226.0 56058.2 56224.7 56245.4 56389.7 56415.0 1265.4 1307.2 1319.4 1329.2 1330.2 28176.0 29128.3 29247.6 29755.0 29877.7 49940.8 50341.0 50470.5 50518.7 50595.7 591121.0 592568.0 594662.0 595236.0 595590.0 33675.0 34186.8 37774.0 40342.8 40760.6 34494.0 42235.8 42694.8 45185.5 46272.1 36075.0 36237.5 36555.1 37605.4 37786.6 31368.0 33904.7 37117.3 37875.8 38150.4 35753.3 35957.0 36863.4 36956.6 37180.6 31140.8 31689.5 33179.2 33292.8 33398.8 23950.3 24072.0 24351.3 24650.3 24753.9 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:34668.35 Median:2514.34 stddev:96393.84 (3833.8%) stddev-sans-first:96629.83 16:12:42 INFO - PROCESS | 1677 | Values: 358.4 368.6 374.4 385.7 398.1 15211.2 15531.7 19591.3 20814.5 21299.8 15968.4 17218.6 19072.1 20009.8 20859.0 4943.5 6053.5 6058.7 6063.8 6071.6 5584.1 5866.7 5931.9 5942.9 5947.7 4148.7 4361.2 4362.3 4390.1 5921.5 4266.9 6207.4 6341.5 6496.5 6545.4 5686.5 5700.9 5707.3 5725.0 5751.6 25970.4 26509.5 26522.1 26665.9 26887.7 2496.3 2509.0 2519.7 3067.2 3140.7 12825.9 15403.9 15535.5 15982.0 16144.7 1761.8 1782.1 1791.6 1882.2 1895.6 124479.0 127902.0 130052.0 130660.0 130703.0 10466.6 10605.5 11007.3 11264.2 11301.3 13789.4 13805.2 13814.7 13822.9 13834.4 8217.2 8511.9 8522.9 8641.6 8663.4 7064.9 7110.0 8224.5 8537.5 8722.7 5351.5 6527.5 6642.9 6643.4 6655.5 1483.4 1814.1 1817.7 1821.4 1823.4 707.8 860.7 879.6 951.1 964.9 21894.3 22304.7 22540.5 22579.0 22615.5 901.6 917.7 954.5 962.8 997.3 11148.7 11950.3 12034.7 12058.2 12070.6 436530.0 576209.0 606845.0 616346.0 619528.0 114101.7 123391.0 124457.4 126485.4 126996.0 1016.1 1021.0 1037.6 1043.2 1076.9 19509.9 19935.4 20084.4 20163.0 20182.0 52321.7 52733.7 55736.4 55823.4 56455.6 75801.2 78479.8 78557.6 78829.2 79495.0 7915.6 8003.5 8155.0 8216.6 8310.9 10997.2 11572.4 12805.1 13344.9 13420.0 10919.2 10943.8 11107.8 11271.9 11686.3 11030.4 11202.5 11510.4 11747.4 11767.5 11136.0 11473.4 11521.3 11776.8 11988.8 8010.7 8128.6 8202.5 8246.0 8259.0 9827.5 11272.4 11589.5 11598.3 11719.8 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5458.00 Median:4910.20 stddev:3015.02 (61.4%) stddev-sans-first:3007.14 16:12:42 INFO - PROCESS | 1677 | Values: 1282.0 1513.9 1651.8 1834.3 1862.6 8172.8 8655.6 8671.4 8685.7 8713.0 7673.3 7966.3 7979.1 8286.4 8524.4 2262.7 2287.5 2294.3 2297.4 2303.1 2277.8 2283.3 2314.0 2321.7 2323.0 2285.1 2302.3 2318.1 2320.3 2322.6 2271.5 2285.2 2291.8 2293.8 2294.0 1863.0 2269.1 2275.3 2275.9 2281.1 8637.5 8706.8 8707.8 8708.5 8732.5 4763.4 4870.4 4875.5 4880.2 4882.9 3084.2 3218.4 3230.2 3267.8 3416.9 899.0 1009.0 1035.3 1056.8 1058.0 10170.4 10177.6 10184.1 10192.1 10195.0 3669.3 4321.0 4336.3 4440.4 4467.4 8856.8 8858.6 8869.5 8872.2 8873.1 4859.2 4861.1 4861.5 4865.1 4865.1 4211.2 4340.4 4466.2 4555.0 4681.5 3734.8 3799.2 3863.9 3884.5 3895.4 1238.4 1241.1 1247.6 1248.2 1259.4 849.4 856.9 906.1 908.0 950.9 5573.7 5654.3 5872.7 5908.2 5973.0 924.1 931.6 942.8 948.8 992.0 3556.0 3959.2 4020.5 4115.4 4133.0 7697.8 10220.3 10419.0 10562.8 10597.3 8793.1 10513.1 10523.3 10541.3 10567.6 7627.2 8051.1 8137.7 8141.5 8154.8 4765.6 5787.7 5817.9 5882.9 5932.9 9340.2 9691.9 9749.3 9799.4 9935.3 9668.7 9955.2 9960.3 10101.3 10139.4 6436.2 6512.6 6638.7 6889.3 7024.0 7441.2 7945.9 8148.2 8280.8 8329.4 7244.2 7343.6 7362.6 7409.5 7460.2 7175.7 7241.7 7268.8 7283.5 7360.6 6854.9 6872.1 6966.0 6968.2 6975.6 4937.5 4976.6 4999.1 5043.2 5118.1 4759.7 4958.3 5014.8 5024.4 5231.8 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:4372.48 Median:4733.12 stddev:1400.62 (29.6%) stddev-sans-first:1370.56 16:12:42 INFO - PROCESS | 1677 | Values: 286.5 296.3 305.4 307.7 311.0 4509.4 5022.7 5215.5 5269.0 5322.5 4552.7 5045.9 5115.5 5187.6 5203.8 4005.3 4007.3 4009.2 4023.6 4026.0 2927.5 3413.1 3682.7 4042.5 4064.1 3984.5 3987.3 4006.9 4021.5 4033.7 3959.5 3969.6 3972.5 3980.0 3984.8 3456.5 3474.7 3474.9 3487.2 3492.9 4392.9 4848.7 5114.0 5114.3 5149.8 4202.7 4410.6 4557.7 4581.8 4581.9 5547.3 5561.0 5564.3 5568.7 5623.8 2974.8 3513.5 3751.2 3758.0 3762.3 4811.6 5739.7 5779.9 5805.8 5812.4 3207.7 3824.2 3869.3 3871.7 3875.3 3605.6 3845.7 3911.0 3920.0 3931.3 4359.1 4488.8 4530.3 4542.4 4626.9 5591.8 5603.6 5631.4 5639.4 5644.2 1189.0 1208.9 1237.7 1250.8 1311.8 748.3 750.4 758.8 786.4 805.5 3898.1 4272.6 4364.7 4378.9 4423.4 3957.8 4705.4 4760.8 4779.3 4794.6 3748.9 3968.6 4005.4 4433.6 4455.7 2025.7 2248.6 2316.4 2357.2 2464.4 4534.8 4556.5 4937.9 4949.4 4986.4 3982.9 4477.3 4770.4 4790.0 5918.3 5236.4 6035.5 6045.9 6069.0 6074.0 5708.4 5738.4 5779.0 5796.2 5805.3 5442.3 5635.4 5686.8 5694.6 5706.9 5917.4 5924.2 5957.2 6012.6 6013.4 3212.9 3768.1 3853.8 3870.6 3901.6 5241.7 5358.0 5744.7 5760.7 5779.5 4931.3 5568.9 5625.7 5636.5 5646.9 4847.7 5319.7 5518.4 5542.8 5691.3 4810.3 4986.9 5408.2 5440.6 5478.8 4514.9 4656.4 5452.8 5531.5 5533.7 5404.8 5450.9 5480.6 5482.4 5515.2 16:12:42 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:23850.09 Median:4327.72 stddev:38080.39 (879.9%) stddev-sans-first:38147.34 16:12:42 INFO - PROCESS | 1677 | Values: 639.4 728.6 732.7 772.4 787.0 13794.8 14465.1 14481.9 14485.9 14789.3 12281.1 12296.3 12296.9 12329.9 12360.3 642.0 675.7 753.3 765.7 840.0 822.5 831.3 832.4 838.0 838.5 857.8 859.7 860.3 861.3 861.4 685.7 851.6 853.0 853.5 855.0 526.5 631.2 652.5 653.4 657.2 13168.4 13219.9 13243.5 13244.7 13251.9 12969.0 13393.9 13421.5 13587.8 13970.1 11650.9 11993.5 12025.5 12088.5 12334.9 4324.0 4331.5 4340.7 4362.5 4467.4 119456.0 120442.4 120615.0 120863.4 123681.8 10204.0 10497.0 10775.8 10829.9 11078.2 21025.3 21033.4 21097.3 21106.0 21132.5 7446.8 7550.0 7579.8 7589.3 7844.1 3550.3 4271.5 4320.0 4335.7 4449.7 3325.9 3430.6 3432.8 3435.1 3442.0 627.9 631.7 635.7 655.5 655.5 547.3 564.6 588.6 607.6 613.4 8702.9 8752.5 8764.2 8847.3 9085.3 545.3 548.1 620.6 625.4 640.6 4230.4 4458.8 4504.0 4624.2 4656.9 92767.0 110019.0 140710.0 144969.6 147535.0 124531.0 127690.0 128332.0 129526.0 130123.3 84486.7 90953.0 98651.5 100728.0 111793.8 9463.3 9589.3 9627.0 9721.9 9746.8 56330.7 57934.7 59388.0 61305.7 61884.1 85804.0 95000.0 95523.0 95940.5 96475.0 10995.9 12432.7 12749.8 13302.6 13346.3 14487.1 14499.7 14501.0 14530.3 14661.9 13264.4 13301.9 13316.2 14095.9 14131.6 13225.0 13934.3 13994.7 14007.9 14062.9 10687.7 11850.8 11981.8 12449.3 13283.2 8656.5 10119.2 10227.5 10228.4 10261.1 8197.2 8798.0 9286.5 9359.7 10670.5 16:12:42 INFO - PROCESS | 1677 | -------- Summary: end -------- 16:12:42 INFO - PROCESS | 1677 | 16:12:43 INFO - TEST-INFO | 1677: exit 0 16:12:43 INFO - TEST-OK | dromaeo_css | took 1119855ms 16:12:43 INFO - TEST-START | kraken 16:12:43 INFO - operating with platform_type : mac_ 16:12:43 INFO - Initialising browser for kraken test... 16:12:43 INFO - TEST-INFO | started process 1795 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmppVYdIz/profile http://localhost:49271/getInfo.html) 16:12:45 INFO - PROCESS | 1795 | __metrics Screen width/height:1600/1200 16:12:45 INFO - PROCESS | 1795 | colorDepth:24 16:12:45 INFO - PROCESS | 1795 | Browser inner width/height: 1024/689 16:12:45 INFO - PROCESS | 1795 | __metrics 16:12:45 INFO - PROCESS | 1795 | 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:12:45 INFO - PROCESS | 1795 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:46 INFO - TEST-INFO | 1795: exit 0 16:12:46 INFO - Browser initialized. 16:12:46 INFO - Running cycle 1/1 for kraken test... 16:12:46 INFO - TEST-INFO | started process 1796 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmppVYdIz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:58 INFO - PROCESS | 1796 | RSS: Main: 234950656 16:12:58 INFO - PROCESS | 1796 | 16:13:01 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:02 INFO - PROCESS | 1796 | RSS: Main: 293879808 16:13:02 INFO - PROCESS | 1796 | 16:13:04 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:13:05 INFO - PROCESS | 1796 | RSS: Main: 294752256 16:13:05 INFO - PROCESS | 1796 | 16:13:09 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:13:09 INFO - PROCESS | 1796 | RSS: Main: 383803392 16:13:09 INFO - PROCESS | 1796 | 16:13:11 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:13:12 INFO - PROCESS | 1796 | RSS: Main: 286314496 16:13:12 INFO - PROCESS | 1796 | 16:13:14 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:14 INFO - PROCESS | 1796 | RSS: Main: 290590720 16:13:14 INFO - PROCESS | 1796 | 16:13:17 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:18 INFO - PROCESS | 1796 | RSS: Main: 329625600 16:13:18 INFO - PROCESS | 1796 | 16:13:21 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:21 INFO - PROCESS | 1796 | RSS: Main: 327774208 16:13:21 INFO - PROCESS | 1796 | 16:13:24 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:13:25 INFO - PROCESS | 1796 | RSS: Main: 329641984 16:13:25 INFO - PROCESS | 1796 | 16:13:26 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:27 INFO - PROCESS | 1796 | RSS: Main: 301752320 16:13:27 INFO - PROCESS | 1796 | 16:13:29 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:29 INFO - PROCESS | 1796 | RSS: Main: 306012160 16:13:29 INFO - PROCESS | 1796 | 16:13:32 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:32 INFO - PROCESS | 1796 | RSS: Main: 308932608 16:13:32 INFO - PROCESS | 1796 | 16:13:35 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:36 INFO - PROCESS | 1796 | RSS: Main: 319131648 16:13:36 INFO - PROCESS | 1796 | 16:13:39 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:40 INFO - PROCESS | 1796 | RSS: Main: 318902272 16:13:40 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:13:42 INFO - PROCESS | 1796 | RSS: Main: 363134976 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | __start_tp_report 16:13:42 INFO - PROCESS | 1796 | _x_x_mozilla_page_load 16:13:42 INFO - PROCESS | 1796 | _x_x_mozilla_page_load_details 16:13:42 INFO - PROCESS | 1796 | |i|pagename|runs| 16:13:42 INFO - PROCESS | 1796 | |0;ai-astar;113;113;113;111;111;113;112;111;112;111 16:13:42 INFO - PROCESS | 1796 | |1;audio-beat-detection;147;113;117;153;114;114;112;113;147;115 16:13:42 INFO - PROCESS | 1796 | |2;audio-dft;184;181;181;184;185;183;178;184;188;182 16:13:42 INFO - PROCESS | 1796 | |3;audio-fft;79;59;60;87;63;58;60;58;83;57 16:13:42 INFO - PROCESS | 1796 | |4;audio-oscillator;88;78;127;102;81;69;91;67;69;91 16:13:42 INFO - PROCESS | 1796 | |5;imaging-gaussian-blur;89;87;88;85;88;85;88;85;89;86 16:13:42 INFO - PROCESS | 1796 | |6;imaging-darkroom;95;96;96;96;95;96;97;95;96;116 16:13:42 INFO - PROCESS | 1796 | |7;imaging-desaturate;86;86;84;85;85;85;87;83;85;85 16:13:42 INFO - PROCESS | 1796 | |8;json-parse-financial;57;52;53;54;55;55;54;55;55;55 16:13:42 INFO - PROCESS | 1796 | |9;json-stringify-tinderbox;73;73;65;76;74;71;70;72;71;72 16:13:42 INFO - PROCESS | 1796 | |10;stanford-crypto-aes;85;90;95;105;113;105;87;84;86;85 16:13:42 INFO - PROCESS | 1796 | |11;stanford-crypto-ccm;147;146;147;143;142;145;149;137;204;166 16:13:42 INFO - PROCESS | 1796 | |12;stanford-crypto-pbkdf2;171;174;159;212;241;195;171;170;198;239 16:13:42 INFO - PROCESS | 1796 | |13;stanford-crypto-sha256-iterative;69;69;70;68;67;71;66;68;69;67 16:13:42 INFO - PROCESS | 1796 | __end_tp_report 16:13:42 INFO - PROCESS | 1796 | __start_cc_report 16:13:42 INFO - PROCESS | 1796 | _x_x_mozilla_cycle_collect,2006 16:13:42 INFO - PROCESS | 1796 | __end_cc_report 16:13:42 INFO - PROCESS | 1796 | __startTimestamp1476400422326__endTimestamp 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | ------- Summary: start ------- 16:13:42 INFO - PROCESS | 1796 | Number of tests: 14 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:0.94 (0.8%) stddev-sans-first:0.93 16:13:42 INFO - PROCESS | 1796 | Values: 113.0 113.0 113.0 111.0 111.0 113.0 112.0 111.0 112.0 111.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:116.00 stddev:17.04 (14.7%) stddev-sans-first:16.01 16:13:42 INFO - PROCESS | 1796 | Values: 147.0 113.0 117.0 153.0 114.0 114.0 112.0 113.0 147.0 115.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#2] audio-dft Cycles:10 Average:183.00 Median:184.00 stddev:2.71 (1.5%) stddev-sans-first:2.85 16:13:42 INFO - PROCESS | 1796 | Values: 184.0 181.0 181.0 184.0 185.0 183.0 178.0 184.0 188.0 182.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.50 stddev:11.72 (19.1%) stddev-sans-first:11.51 16:13:42 INFO - PROCESS | 1796 | Values: 79.0 59.0 60.0 87.0 63.0 58.0 60.0 58.0 83.0 57.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:79.50 stddev:18.31 (23.0%) stddev-sans-first:19.41 16:13:42 INFO - PROCESS | 1796 | Values: 88.0 78.0 127.0 102.0 81.0 69.0 91.0 67.0 69.0 91.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.63 (1.9%) stddev-sans-first:1.56 16:13:42 INFO - PROCESS | 1796 | Values: 89.0 87.0 88.0 85.0 88.0 85.0 88.0 85.0 89.0 86.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:96.00 stddev:6.43 (6.7%) stddev-sans-first:6.74 16:13:42 INFO - PROCESS | 1796 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 97.0 95.0 96.0 116.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.10 (1.3%) stddev-sans-first:1.12 16:13:42 INFO - PROCESS | 1796 | Values: 86.0 86.0 84.0 85.0 85.0 85.0 87.0 83.0 85.0 85.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.09 16:13:42 INFO - PROCESS | 1796 | Values: 57.0 52.0 53.0 54.0 55.0 55.0 54.0 55.0 55.0 55.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:2.91 (4.0%) stddev-sans-first:3.05 16:13:42 INFO - PROCESS | 1796 | Values: 73.0 73.0 65.0 76.0 74.0 71.0 70.0 72.0 71.0 72.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:85.50 stddev:10.50 (12.3%) stddev-sans-first:10.68 16:13:42 INFO - PROCESS | 1796 | Values: 85.0 90.0 95.0 105.0 113.0 105.0 87.0 84.0 86.0 85.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:147.00 stddev:19.57 (13.3%) stddev-sans-first:20.65 16:13:42 INFO - PROCESS | 1796 | Values: 147.0 146.0 147.0 143.0 142.0 145.0 149.0 137.0 204.0 166.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.00 Median:196.50 stddev:29.48 (15.0%) stddev-sans-first:30.18 16:13:42 INFO - PROCESS | 1796 | Values: 171.0 174.0 159.0 212.0 241.0 195.0 171.0 170.0 198.0 239.0 16:13:42 INFO - PROCESS | 1796 | 16:13:42 INFO - PROCESS | 1796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.58 16:13:42 INFO - PROCESS | 1796 | Values: 69.0 69.0 70.0 68.0 67.0 71.0 66.0 68.0 69.0 67.0 16:13:42 INFO - PROCESS | 1796 | -------- Summary: end -------- 16:13:42 INFO - PROCESS | 1796 | 16:13:43 INFO - TEST-INFO | 1796: exit 0 16:13:43 INFO - TEST-OK | kraken | took 59611ms 16:13:43 INFO - SUITE-END | took 1179s 16:13:43 INFO - Completed test suite (00:19:39) 16:13:43 INFO - javascript benchmark 16:13:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2973.7026297370267, 3307.966920330796, 3311.552940353052, 3336.9499457508127, 3368.9326213475733, 5502.477264659851, 5556.611037227391, 5596.076647353182, 5624.437556244378, 5644.689542075184, 5544.473275038875, 5606.803761868326, 5612.607117501777, 5623.943760562393, 5626.0, 4182.268103081956, 5121.436641969381, 5129.743512824362, 5146.253793199984, 5212.713300768456, 4285.57144285572, 5161.27742116104, 5246.37043554772, 5256.211568264772, 5270.130428479296, 5100.897982040376, 5139.280500729901, 5173.3533308336455, 5182.352205974254, 5208.140656791625, 5210.921836172422, 5215.165573508259, 5241.109011468059, 5241.580673546107, 5319.069162896478, 5030.968651426449, 5075.0357432087785, 5084.720340381277, 5107.897842043139, 5175.534201921808, 5563.972180139073, 5595.468430499137, 5614.214010038598, 5625.40933202012, 5667.744951477152, 6154.753809847601, 6159.0, 6166.84582885427, 6167.352427995085, 6181.0, 5960.493358064527, 6043.546733994968, 6128.509719222451, 6242.15730876335, 6245.656488893154, 5648.745806438679, 5653.067243904709, 5653.547716182696, 5660.801871934463, 5669.1496275558175, 6218.098375735583, 6226.439620434092, 6232.532560057924, 6290.654014029273, 6303.432691057827, 6076.210092687922, 6079.240094988127, 6086.847828804315, 6104.254103856739, 6137.662428566382, 6196.884560779103, 6198.752049918043, 6212.316645169028, 6237.064440333987, 6248.781292654826, 5947.791827286024, 6006.339302676702, 6097.222222222223, 6099.085137229363, 6158.291796443376, 6150.7232174552255, 6180.536459765535, 6199.225096862892, 6205.379462053758, 6223.564350495512, 4904.8038078477175, 4910.729909854921, 4915.18899381598, 4927.852164435073, 4942.802287908444, 4305.655547556188, 4345.217860785089, 4349.0, 4393.231184542692, 4424.977875110604, 5650.660960342392, 5657.773689052474, 5661.179129026351, 5671.489565939003, 5690.6870122142855, 6116.640127388518, 6138.9095594588325, 6139.706800529493, 6146.279041868284, 6156.661383623854, 5617.8033768817895, 5644.238027866186, 5661.688607126647, 5664.291963504562, 5666.150077488327, 5299.629025968223, 5330.360356757214, 5334.413214546396, 5343.305370301836, 5363.597730170253, 6152.538559608047, 6296.433321001132, 6331.841703957438, 6334.588251763621, 6334.588251763621, 6127.387261273837, 6133.172021777003, 6142.385761423822, 6146.2175968968495, 6244.906326405016, 6289.182406287154, 6291.937080629135, 6294.5593808434805, 6312.14786003902, 6313.936860631518, 5967.283925928917, 6120.908186377297, 6143.631382117087, 6156.538259630456, 6164.969175154096, 6119.125753810745, 6120.724567394389, 6138.541671868701, 6147.801178770097, 6149.477294430024, 5818.650880947157, 5961.821145365646, 6014.248218972629, 6031.638101713911, 6033.668148251888, 5245.790168393374, 5948.464638182584, 5952.4642782148085, 6002.129691194665, 6015.338312785678, 5793.623414478046, 5865.266841644794, 5905.970470147794, 5920.970395148169, 5930.288365396007, 5913.911291330547, 5989.700514974146, 6002.189704389852, 6019.337872833898, 6070.484008859296, 5846.619969701956, 5847.44449277318, 5855.209546711139, 5870.589058766016, 5898.8230353089475], "value": 5622.00398432565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.76219247087744, 485.3641729334571, 486.5110563883297, 530.1332321654099, 537.7042626555397, 30337.69662303379, 39792.80103599482, 40719.59280407195, 40755.38866916999, 42850.785746071226, 41524.79237603808, 41750.0, 41807.95480112991, 41837.74486765402, 41959.58040419595, 7963.283304502608, 9571.856422153673, 9572.760680982996, 9572.80854382912, 9598.520073996307, 8646.48121112732, 8873.95563022184, 11383.203175777699, 11660.47527861244, 11693.064554835593, 11481.59814406496, 11555.133364997617, 11560.0, 11574.768504629945, 11731.7067073323, 11549.076073914108, 11610.477528511154, 11650.6504804856, 11655.650330490098, 11659.358735269558, 8669.609867555975, 8889.911100888972, 9799.363041402286, 10972.890271097267, 11451.141164412618, 40127.79936100301, 40368.0, 40416.0, 40434.797826010974, 40471.7976410119, 3063.938721225585, 3210.956439157283, 3218.0667606394118, 3347.548081009057, 3597.8380972856285, 23687.0, 30617.08148755541, 31291.74833006677, 31335.37329253425, 31383.686163138533, 3086.213015680987, 3132.1543183340373, 3212.646608873022, 3213.1806389370795, 3213.373392188524, 479326.0, 482406.0, 483346.0, 485788.0, 491054.0, 60085.09872351918, 60539.22181283689, 60570.0, 60579.69710151421, 60605.0, 60447.79104417887, 62853.0, 62865.08484066749, 63115.6844215776, 63161.684191578745, 15834.208289585475, 16057.518274451784, 16073.919630401773, 16078.598035048983, 16084.43704470338, 11261.43692815356, 12578.371081445892, 12607.432665530074, 12651.746965060647, 12668.303243321521, 14517.0, 15001.249937503082, 16512.42206522766, 16896.155192240338, 16929.0, 4571.290361591481, 6214.347493513116, 6225.533085018642, 6265.279492858289, 6271.122042913996, 868.4398562926876, 1001.9899801002042, 1033.214756784834, 1044.9425281609433, 1054.504382940017, 29257.707422925498, 29491.05089491034, 29535.409291814474, 29733.55399669007, 30193.245168870955, 883.412530667112, 980.6273616026007, 1008.435276245305, 1034.4414016431194, 1132.841402203692, 14766.11403315783, 15191.848081519043, 15350.0, 15436.922815386075, 15613.765793513106, 594757.0, 599872.0, 600320.0, 600809.0, 601226.0, 56058.159127613115, 56224.71887640617, 56245.43754562484, 56389.7180514103, 56415.0, 1265.4115836136057, 1307.235267368581, 1319.3798914510164, 1329.1626275446406, 1330.1619979413101, 28176.013839516338, 29128.27179320534, 29247.561286581145, 29755.0, 29877.701222987493, 49940.75029624828, 50341.0, 50470.49529504658, 50518.74740626274, 50595.74702126466, 591121.0, 592568.0, 594662.0, 595236.0, 595590.0, 33675.0, 34186.82906585451, 37774.0, 40342.79828600956, 40760.59239407568, 34493.97415420396, 42235.7888210557, 42694.78652606717, 45185.548144519445, 46272.07455850932, 36075.0, 36237.45643815292, 36555.08612284714, 37605.43591846179, 37786.62213377831, 31368.0, 33904.66095339114, 37117.25765484621, 37875.81062094672, 38150.42774358443, 35753.284934301686, 35957.0, 36863.44704829376, 36956.630433696395, 37180.62819371772, 31140.844295778377, 31689.524657130623, 33179.17052073718, 33292.833535832164, 33398.833005834815, 23950.28149155528, 24072.03711851506, 24351.26946191617, 24650.26049218526, 24753.87623061873], "value": 19800.200826006218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.44441116269786, 368.6074330837658, 374.37479409386333, 385.7396257526169, 398.1082375478926, 15211.163386013764, 15531.689366212697, 19591.314303999345, 20814.479638009037, 21299.828509431994, 15968.361265549363, 17218.56953576158, 19072.141753621087, 20009.799902000974, 20859.0, 4943.456219815817, 6053.455189032986, 6058.727357268912, 6063.787767428141, 6071.635701857903, 5584.134459158837, 5866.706664666771, 5931.851703707399, 5942.881142377149, 5947.672877991708, 4148.713898691415, 4361.193179261847, 4362.345648152786, 4390.121975604876, 5921.526277897779, 4266.914661706764, 6207.441330280274, 6341.460975817061, 6496.545241833073, 6545.443637290836, 5686.516646085046, 5700.914486282709, 5707.315122185323, 5725.0, 5751.597388182829, 25970.350741231432, 26509.46981060368, 26522.071727489638, 26665.93336266547, 26887.731122688914, 2496.3135137837057, 2508.974910250911, 2519.6976362836576, 3067.2331917020747, 3140.654528001918, 12825.935870320682, 15403.922980385027, 15535.533933981886, 15982.0, 16144.677106457922, 1761.7621621081119, 1782.117851663435, 1791.5610675384485, 1882.1718443884647, 1895.5829717462136, 124479.0, 127902.0, 130052.0, 130660.0, 130703.0, 10466.581336746445, 10605.469726513798, 11007.339559626447, 11264.155188360906, 11301.32192068462, 13789.448422063206, 13805.240711760749, 13814.723705526034, 13822.93088534551, 13834.377453014638, 8217.178282171855, 8511.872321915176, 8522.914770852336, 8641.611127499278, 8663.436876603, 7064.858702825914, 7109.964450177716, 8224.506529608243, 8537.530435825965, 8722.738317850475, 5351.464853514695, 6527.477801775846, 6642.867142657216, 6643.368879956396, 6655.46756259498, 1483.3547406878042, 1814.1473507451476, 1817.7182536706832, 1821.3625231169249, 1823.4347352320824, 707.7664370757637, 860.6815478272954, 879.5690111845278, 951.148721893915, 964.8745663063756, 21894.343169704935, 22304.665430018562, 22540.54918901613, 22579.0, 22615.54768904613, 901.5582364641278, 917.660465627722, 954.5370495309769, 962.841131213356, 997.2570435025807, 11148.721281967853, 11950.282983021047, 12034.699132521757, 12058.155929085055, 12070.637880863587, 436530.0, 576209.0, 606845.0, 616346.0, 619528.0, 114101.71796564189, 123391.0, 124457.37771311085, 126485.36757316338, 126996.0, 1016.1413605503337, 1020.9795804083876, 1037.5590374090982, 1043.2332235806675, 1076.9299995500267, 19509.902450487658, 19935.401937941304, 20084.397468075982, 20163.0, 20182.0, 52321.73839130932, 52733.7363313181, 55736.44263557313, 55823.441765581825, 56455.58861028507, 75801.24198757941, 78479.82280265687, 78557.60721196358, 78829.21170788447, 79495.0, 7915.643796029078, 8003.5193489204685, 8154.959225203836, 8216.589170541569, 8310.87533686983, 10997.175211859303, 11572.42137893085, 12805.103642744918, 13344.933275333562, 13419.993500487308, 10919.181061420584, 10943.781124377309, 11107.83338249943, 11271.887281127412, 11686.298822070703, 11030.393328367018, 11202.495887685236, 11510.36692981894, 11747.412629368668, 11767.470463829319, 11136.0, 11473.36896470702, 11521.251118677259, 11776.82334764962, 11988.820167697317, 8010.679572817022, 8128.634211460617, 8202.466839655403, 8245.95877020611, 8259.0, 9827.5086245686, 11272.436378181223, 11589.478473468545, 11598.304101753922, 11719.824202637137], "value": 9741.757654032845, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.9615411537654, 1513.856183662552, 1651.8348165183484, 1834.2662934826076, 1862.5902301493666, 8172.7548173554815, 8655.567221638916, 8671.436356636823, 8685.739427817176, 8712.998005229401, 7673.271039251276, 7966.32286255669, 7979.122296547375, 8286.378521610874, 8524.403291769579, 2262.7171603549514, 2287.49675071484, 2294.265834932822, 2297.3682237384687, 2303.078768492608, 2277.7836105569945, 2283.315005498344, 2313.9652905206435, 2321.686572312733, 2322.9651555226687, 2285.1430713482446, 2302.2517681753498, 2318.0959425823944, 2320.3155069254526, 2322.5703244899746, 2271.4662054417363, 2285.211601997308, 2291.759365266648, 2293.759155288704, 2293.9655905161435, 1863.0, 2269.1490690990877, 2275.2719129878446, 2275.9317220483413, 2281.087564974007, 8637.481751094892, 8706.782330441727, 8707.782305442415, 8708.521031343274, 8732.51971141587, 4763.428388593356, 4870.391201099863, 4875.536824001714, 4880.243562247857, 4882.926756098661, 3084.2135255509925, 3218.388506183841, 3230.176305042199, 3267.836608169582, 3416.931661366759, 898.955052247385, 1008.9596416143346, 1035.254616675992, 1056.7939251845894, 1057.9947100264526, 10170.44062576558, 10177.592896284139, 10184.134348580379, 10192.133668638175, 10194.98050194982, 3669.2844895245703, 4321.018200532442, 4336.34954756789, 4440.4227450431235, 4467.441569803775, 8856.822863542693, 8858.557072146366, 8869.467831930106, 8872.157145071207, 8873.112688731075, 4859.173940430064, 4861.1006963711825, 4861.465238823726, 4865.0756356292195, 4865.0756356292195, 4211.157768446323, 4340.414044104069, 4466.173757854807, 4554.954450455453, 4681.531846815291, 3734.775913445202, 3799.164183879542, 3863.9034024149623, 3884.533855937306, 3895.435161901565, 1238.3684320996356, 1241.1498123785236, 1247.5633528265034, 1248.1699669719717, 1259.420666493405, 849.392684230778, 856.8586183279814, 906.1120102299651, 907.9863802042843, 950.9334346595672, 5573.749181286852, 5654.264945557051, 5872.7357268923, 5908.231929849092, 5973.028900462837, 924.1267002682534, 931.5575101826713, 942.8302905476943, 948.8244674735058, 991.9950400247952, 3555.9644403555635, 3959.208158368338, 4020.4974378202724, 4115.444415003996, 4133.008078061243, 7697.807554811063, 10220.335678180894, 10419.010194031554, 10562.841557376645, 10597.25819192649, 8793.120687931283, 10513.053825155772, 10523.26337156407, 10541.262111652264, 10567.63013294531, 7627.199144089791, 8051.114377418479, 8137.674493020213, 8141.51150930946, 8154.796130096676, 4765.6187504998825, 5787.652740835563, 5817.894600025981, 5882.941170588239, 5932.8813423732145, 9340.206082483064, 9691.9030809691, 9749.317547771589, 9799.363041402286, 9935.254855885692, 9668.70993870185, 9955.153811926068, 9960.302778805413, 10101.343412678152, 10139.442330671884, 6436.227652681709, 6512.6092434454085, 6638.668066596748, 6889.276625954202, 7024.016637670628, 7441.218672039358, 7945.8808117879435, 8148.185181481805, 8280.83438331242, 8329.37529685288, 7244.166920804175, 7343.559386436831, 7362.558246505227, 7409.518381305198, 7460.216677249028, 7175.677094530654, 7241.710331586888, 7268.80496172353, 7283.526570772883, 7360.631968401452, 6854.897176542456, 6872.10662613857, 6965.989931459809, 6968.163820341591, 6975.616341101085, 4937.481564435682, 4976.601871850316, 4999.075171093214, 5043.167877300204, 5118.129917914038, 4759.6668233223345, 4958.330625365529, 5014.7994080236385, 5024.397072351341, 5231.843044708665], "value": 4413.606242237982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.4786089317443, 296.3229021685449, 305.3724595955311, 307.68001278670187, 310.9782315237934, 4509.413776209092, 5022.698638081718, 5215.478452154783, 5269.0, 5322.525025862973, 4552.704074235173, 5045.899082018366, 5115.514026167508, 5187.636865419422, 5203.843884683456, 4005.2790497710403, 4007.298722723526, 4009.1981603679237, 4023.5775243599364, 4026.0, 2927.531594944809, 3413.0614081127765, 3682.650148235913, 4042.4744783178144, 4064.146529228851, 3984.482017337742, 3987.342088555385, 4006.939895901564, 4021.46647612004, 4033.6773058155277, 3959.524857017162, 3969.583193764642, 3972.5431575368625, 3980.044789250588, 3984.780837053961, 3456.5160877476924, 3474.6525347465304, 3474.878379256739, 3487.1630808606005, 3492.8777492787885, 4392.901774556361, 4848.702882040211, 5113.974430127862, 5114.309568208281, 5149.76826042829, 4202.684798640114, 4410.6030457259, 4557.680962332638, 4581.8396356127705, 4581.908361832778, 5547.25112109864, 5561.0, 5564.27664403629, 5568.7470319178265, 5623.803166889139, 2974.776891733107, 3513.4554144107447, 3751.1559899022773, 3758.0, 3762.285165818486, 4811.628685824523, 5739.684317362543, 5779.884402311972, 5805.82582522525, 5812.360640329603, 3207.743380529552, 3824.1778017726324, 3869.28418242626, 3871.6709079727975, 3875.302445559826, 3605.5673319201337, 3845.65389114981, 3910.9804450977563, 3919.9804000980384, 3931.292367373843, 4359.128174365076, 4488.8104652267175, 4530.252508336153, 4542.432195975503, 4626.884327891829, 5591.776328946878, 5603.579731520153, 5631.381407645383, 5639.407862174413, 5644.238027866268, 1188.9702757431132, 1208.8670246272902, 1237.6843904804218, 1250.8061250506187, 1311.8163457116011, 748.330244431231, 750.3754371785134, 758.836850077236, 786.4101923557332, 805.5218673733647, 3898.064464528493, 4272.551382104896, 4364.716293440916, 4378.869582584407, 4423.447069116361, 3957.782321972262, 4705.435347758223, 4760.809567617326, 4779.330893674888, 4794.609563226625, 3748.887533374003, 3968.5634580196156, 4005.379166229239, 4433.603414924289, 4455.6658250631335, 2025.7062725904957, 2248.5952528545017, 2316.447979853502, 2357.2103345379146, 2464.4208610976407, 4534.798278456212, 4556.476005259371, 4937.925931111036, 4949.406071271471, 4986.351774269322, 3982.9402558961638, 4477.261251893467, 4770.42754869411, 4790.0, 5918.348981612019, 5236.397814251333, 6035.547333949883, 6045.879082418327, 6068.9696551517845, 6073.969630151998, 5708.372079071216, 5738.397468265772, 5778.971105144616, 5796.217815448524, 5805.332386775575, 5442.319710036246, 5635.435876676184, 5686.77252909879, 5694.579803583543, 5706.942930570807, 5917.437843404869, 5924.229850119457, 5957.242613428963, 6012.6392416455155, 6013.428724271187, 3212.887548935776, 3768.1144930941755, 3853.7801107786927, 3870.612938706107, 3901.6098390160755, 5241.737913104405, 5357.973210134081, 5744.655320680772, 5760.67504473965, 5779.4509521597065, 4931.3096166536, 5568.888622227451, 5625.69058701759, 5636.464535869086, 5646.858828529155, 4847.709137451764, 5319.6808191508635, 5518.42056584069, 5542.750576223999, 5691.345495268097, 4810.302506136521, 4986.877952460667, 5408.214250024919, 5440.591955603267, 5478.780848766164, 4514.887127821699, 4656.371389862461, 5452.809151679672, 5531.474509921551, 5533.723313834212, 5404.83785486436, 5450.945490545044, 5480.6437581557075, 5482.424345443671, 5515.227868098389], "value": 3919.7252161503743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.3606393606394, 728.5919884864476, 732.7325526182943, 772.3589420780753, 786.9803254918627, 13794.793078103836, 14465.132092074484, 14481.855181448196, 14485.855141448596, 14789.334479948402, 12281.140320177592, 12296.262224266527, 12296.877031229686, 12329.938350308259, 12360.258384496914, 641.9743210271583, 675.6891829758292, 753.3408267765705, 765.7281665008925, 839.9794249986265, 822.5023860564332, 831.2934006094802, 832.4422636833336, 838.0237023867218, 838.5094719589048, 857.7855536115972, 859.6518410043942, 860.2558786649565, 861.2980420956932, 861.4056301152216, 685.6537448588481, 851.5912362066211, 852.9872051919164, 853.4921721575653, 854.9957250213771, 526.4761562245552, 631.1794666932968, 652.4975768658154, 653.3727621483382, 657.2015001772869, 13168.407421666048, 13219.86780132196, 13243.536476223382, 13244.73510529784, 13251.867481325256, 12969.0, 13393.933030334883, 13421.463141474329, 13587.796183057262, 13970.091944023607, 11650.883491165065, 11993.460294286779, 12025.458854351575, 12088.516459341616, 12334.938325308405, 4323.978380108079, 4331.45856767904, 4340.739555626641, 4362.454693163355, 4467.419235499365, 119456.0, 120442.3977880105, 120615.0, 120863.39568302102, 123681.76318236793, 10204.010669951744, 10497.0, 10775.78448431027, 10829.891701082888, 11078.169137314733, 21025.264115755876, 21033.36899892975, 21097.261595844073, 21106.0, 21132.47168820792, 7446.776596702108, 7549.962250188714, 7579.848403032019, 7589.316961473494, 7844.097928738268, 3550.3254381667402, 4271.466066741657, 4319.97840010798, 4335.653147748172, 4449.7330160190495, 3325.86696532136, 3430.5711786026745, 3432.7768695034742, 3435.1068722131927, 3441.9655803442147, 627.8932581461163, 631.6873147791872, 635.7202830754453, 655.5214693273937, 655.52474456019, 547.345921623656, 564.6470955652717, 588.608575297431, 607.6232735703892, 613.4478968928, 8702.91297087021, 8752.518611476302, 8764.21122099014, 8847.336449766293, 9085.273178145733, 545.2935034860207, 548.0682839173421, 620.5687047501942, 625.352759893508, 640.6124294801671, 4230.407742915994, 4458.799354029076, 4503.977480112579, 4624.237000894882, 4656.8602941911795, 92767.0, 110019.0, 140710.0, 144969.5503044956, 147535.0, 124531.0, 127690.0, 128332.0, 129526.0, 130123.34938325438, 84486.73269900956, 90953.0, 98651.50674246726, 100727.99272007332, 111793.76412471868, 9463.337566370288, 9589.280803939871, 9626.95186524063, 9721.85417218728, 9746.80506389854, 56330.71834640801, 57934.710326449785, 59388.0, 61305.69347153236, 61884.143475695804, 85804.0, 95000.0, 95523.0, 95940.52029739806, 96475.03524964661, 10995.890041099487, 12432.689182770504, 12749.777284513568, 13302.600921972356, 13346.265955372548, 14487.130772153705, 14499.710005800036, 14500.984931054725, 14530.346134424188, 14661.85338146605, 13264.403101860633, 13301.933490332487, 13316.201027938354, 14095.859041409454, 14131.576052718436, 13225.0, 13934.303284835514, 13994.650133746738, 14007.929960350133, 14062.859371406565, 10687.679369618923, 11850.822237666269, 11981.801819818296, 12449.25304481734, 13283.203007819562, 8656.48061116335, 10119.190464762949, 10227.48862556884, 10228.386296822215, 10261.127804136731, 8197.196616744306, 8797.988231353476, 9286.489243091424, 9359.719208423758, 10670.46647667629], "value": 7473.6335990532025, "unit": "score"}], "name": "dromaeo_css", "value": 7207.833881358958, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 111.0, 111.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 117.0, 153.0, 114.0, 114.0, 112.0, 113.0, 147.0, 115.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 181.0, 184.0, 185.0, 183.0, 178.0, 184.0, 188.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 60.0, 87.0, 63.0, 58.0, 60.0, 58.0, 83.0, 57.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 127.0, 102.0, 81.0, 69.0, 91.0, 67.0, 69.0, 91.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 85.0, 88.0, 85.0, 88.0, 85.0, 89.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 116.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 85.0, 85.0, 85.0, 87.0, 83.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 53.0, 54.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 65.0, 76.0, 74.0, 71.0, 70.0, 72.0, 71.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 95.0, 105.0, 113.0, 105.0, 87.0, 84.0, 86.0, 85.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 143.0, 142.0, 145.0, 149.0, 137.0, 204.0, 166.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 159.0, 212.0, 241.0, 195.0, 171.0, 170.0, 198.0, 239.0], "value": 193.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 68.0, 67.0, 71.0, 66.0, 68.0, 69.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1475.8, "alertThreshold": 2.0}]} 16:13:43 INFO - Return code: 0 16:13:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:43 INFO - # TBPL SUCCESS # 16:13:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:13:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:13:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:13:43 INFO - 2016-10-13 16:13:43.641 screenresolution[1806:9885] starting screenresolution argv=screenresolution get 16:13:43 INFO - 2016-10-13 16:13:43.644 screenresolution[1806:9885] Display 0: 1600x1200x32@60 16:13:43 INFO - 2016-10-13 16:13:43.651 screenresolution[1807:9888] starting screenresolution argv=screenresolution list 16:13:43 INFO - Available Modes on Display 0 16:13:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:13:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:13:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:13:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:13:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:13:43 INFO - Intel Iris: 16:13:43 INFO - Chipset Model: Intel Iris 16:13:43 INFO - Type: GPU 16:13:43 INFO - Bus: Built-In 16:13:43 INFO - VRAM (Dynamic, Max): 1536 MB 16:13:43 INFO - Vendor: Intel (0x8086) 16:13:43 INFO - Device ID: 0x0a2e 16:13:43 INFO - Revision ID: 0x0009 16:13:43 INFO - Displays: 16:13:43 INFO - Display: 16:13:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:13:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:13:43 INFO - Display Serial Number: 1600x1200 60 16:13:43 INFO - Main Display: Yes 16:13:43 INFO - Mirror: Off 16:13:43 INFO - Online: Yes 16:13:43 INFO - Rotation: Supported 16:13:43 INFO - Return code: 0 16:13:43 INFO - Running post-action listener: _resource_record_post_action 16:13:43 INFO - [mozharness: 2016-10-13 23:13:43.884525Z] Finished run-tests step (success) 16:13:43 INFO - Running post-run listener: _resource_record_post_run 16:13:43 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37385216; Write bytes: 712301056; Read time: 239; Write time: 2026 16:13:43 INFO - TinderboxPrint: CPU usage
53.6% 16:13:43 INFO - TinderboxPrint: I/O read bytes / time
37,385,216 / 239 16:13:43 INFO - TinderboxPrint: I/O write bytes / time
712,301,056 / 2,026 16:13:43 INFO - TinderboxPrint: CPU idle
2,253.5 (46.4%) 16:13:43 INFO - TinderboxPrint: CPU system
979.0 (20.1%) 16:13:43 INFO - TinderboxPrint: CPU user
1,629.1 (33.5%) 16:13:43 INFO - TinderboxPrint: Swap in / out
444,297,216 / 0 16:13:43 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 270336; Write bytes: 410457600; Read time: 4; Write time: 844 16:13:43 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34358272; Write bytes: 300237824; Read time: 216; Write time: 1177 16:13:44 INFO - Running post-run listener: _upload_blobber_files 16:13:44 INFO - Blob upload gear active. 16:13:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:44 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:13:44 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:44 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:45 INFO - (blobuploader) - INFO - Done attempting. 16:13:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:46 INFO - (blobuploader) - INFO - Done attempting. 16:13:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:48 INFO - (blobuploader) - INFO - Done attempting. 16:13:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:48 INFO - Return code: 0 16:13:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c8e15d496dbe5cb8af9d7899ec07f0fe835d065d02767283dd0b6831a47e81d79e797df0124f7c968ee1a9c1547195895ccc97bbbb2e746cecbf7362b6a2f2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74d0267e6b1def47d6d4c185a9739596170125c1d34ffe37f24b11adc59558b595afffaf638e0c4d9e791403fd61da6d06eeec559d1c1a56a109d15c6d24ae41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c1e56cef2a162980352ef66b82dd557abdec97efe5a95fe8932d2b0bca3ae1ce4ea6772b01bc7db25af1c1dd1dd293efb3d5145cd7eed86bfe9f9325a23a591"} 16:13:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:48 INFO - Contents: 16:13:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c8e15d496dbe5cb8af9d7899ec07f0fe835d065d02767283dd0b6831a47e81d79e797df0124f7c968ee1a9c1547195895ccc97bbbb2e746cecbf7362b6a2f2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74d0267e6b1def47d6d4c185a9739596170125c1d34ffe37f24b11adc59558b595afffaf638e0c4d9e791403fd61da6d06eeec559d1c1a56a109d15c6d24ae41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c1e56cef2a162980352ef66b82dd557abdec97efe5a95fe8932d2b0bca3ae1ce4ea6772b01bc7db25af1c1dd1dd293efb3d5145cd7eed86bfe9f9325a23a591"} 16:13:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:48 INFO - Copying logs to upload dir... 16:13:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.599906 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-10-13 16:13:48.656590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 16:13:48.660014) ========= 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.fKoY1Aij02/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.PzHe7F0zqN/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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/Fx-Team/sha512/2c8e15d496dbe5cb8af9d7899ec07f0fe835d065d02767283dd0b6831a47e81d79e797df0124f7c968ee1a9c1547195895ccc97bbbb2e746cecbf7362b6a2f2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74d0267e6b1def47d6d4c185a9739596170125c1d34ffe37f24b11adc59558b595afffaf638e0c4d9e791403fd61da6d06eeec559d1c1a56a109d15c6d24ae41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c1e56cef2a162980352ef66b82dd557abdec97efe5a95fe8932d2b0bca3ae1ce4ea6772b01bc7db25af1c1dd1dd293efb3d5145cd7eed86bfe9f9325a23a591"} build_url:https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010992 build_url: 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c8e15d496dbe5cb8af9d7899ec07f0fe835d065d02767283dd0b6831a47e81d79e797df0124f7c968ee1a9c1547195895ccc97bbbb2e746cecbf7362b6a2f2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74d0267e6b1def47d6d4c185a9739596170125c1d34ffe37f24b11adc59558b595afffaf638e0c4d9e791403fd61da6d06eeec559d1c1a56a109d15c6d24ae41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c1e56cef2a162980352ef66b82dd557abdec97efe5a95fe8932d2b0bca3ae1ce4ea6772b01bc7db25af1c1dd1dd293efb3d5145cd7eed86bfe9f9325a23a591"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 16:13:48.696212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:13:48.697077) ========= 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.fKoY1Aij02/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.PzHe7F0zqN/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005109 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:13:48.748892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 16:13:48.749502) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 16:13:48.750163) ========= ========= Total master_lag: 0.19 =========