builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0035 starttime: 1473421457.26 results: success (0) buildid: 20160909030427 builduid: 5a61a8341f3d41d893c4ea981bd2f9e6 revision: b13e7776b612f4507e9a394070622285f7a9fd20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.263296) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.266302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.266872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.323088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.323429) ========= 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.rtPbxDkeQR/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.2xtubkXRF7/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-09-09 04:44:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2016-09-09 04:44:17 (14.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.490236 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.837968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.838323) ========= 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.rtPbxDkeQR/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.2xtubkXRF7/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.027546 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:17.886990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-09 04:44:17.887347) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b13e7776b612f4507e9a394070622285f7a9fd20 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b13e7776b612f4507e9a394070622285f7a9fd20 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rtPbxDkeQR/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.2xtubkXRF7/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-09-09 04:44:17,969 truncating revision to first 12 chars 2016-09-09 04:44:17,969 Setting DEBUG logging. 2016-09-09 04:44:17,969 attempt 1/10 2016-09-09 04:44:17,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b13e7776b612?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-09 04:44:19,549 unpacking tar archive at: mozilla-central-b13e7776b612/testing/mozharness/ program finished with exit code 0 elapsedTime=1.832655 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-09 04:44:19.742365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:19.742672) ========= script_repo_revision: b13e7776b612f4507e9a394070622285f7a9fd20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:19.743089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:19.743380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 04:44:19.762674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 15 secs) (at 2016-09-09 04:44:19.762948) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rtPbxDkeQR/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.2xtubkXRF7/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:44:19 INFO - MultiFileLogger online at 20160909 04:44:19 in /builds/slave/test 04:44:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:44:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:19 INFO - {'append_to_log': False, 04:44:19 INFO - 'base_work_dir': '/builds/slave/test', 04:44:19 INFO - 'blob_upload_branch': 'Firefox', 04:44:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:19 INFO - 'branch': 'Firefox', 04:44:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:19 INFO - 'config_files': ('talos/mac_config.py',), 04:44:19 INFO - 'default_actions': ('clobber', 04:44:19 INFO - 'read-buildbot-config', 04:44:19 INFO - 'download-and-extract', 04:44:19 INFO - 'populate-webroot', 04:44:19 INFO - 'create-virtualenv', 04:44:19 INFO - 'install', 04:44:19 INFO - 'run-tests'), 04:44:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:19 INFO - 'download_minidump_stackwalk': True, 04:44:19 INFO - 'download_symbols': 'ondemand', 04:44:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:19 INFO - 'installer_path': 'installer.exe', 04:44:19 INFO - 'log_level': 'info', 04:44:19 INFO - 'log_name': 'talos', 04:44:19 INFO - 'log_to_console': True, 04:44:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:44:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:44:19 INFO - 'opt_config_files': (), 04:44:19 INFO - 'pip_index': False, 04:44:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:19 INFO - 'cmd': ('bash', 04:44:19 INFO - '-c', 04:44:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:19 INFO - 'enabled': True, 04:44:19 INFO - 'halt_on_failure': False, 04:44:19 INFO - 'name': 'check_screen_resolution'},), 04:44:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:19 INFO - 'cmd': ('bash', 04:44:19 INFO - '-c', 04:44:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:19 INFO - 'enabled': True, 04:44:19 INFO - 'halt_on_failure': False, 04:44:19 INFO - 'name': 'check_screen_resolution'},), 04:44:19 INFO - 'run_cmd_checks_enabled': True, 04:44:19 INFO - 'sps_profile': False, 04:44:19 INFO - 'sps_profile_interval': 0, 04:44:19 INFO - 'suite': 'dromaeojs', 04:44:19 INFO - 'system_bits': '32', 04:44:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:19 INFO - 'title': 't-yosemite-r7-0035', 04:44:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:19 INFO - 'use_talos_json': True, 04:44:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:19 INFO - 'work_dir': 'build'} 04:44:19 INFO - [mozharness: 2016-09-09 11:44:19.962594Z] Running clobber step. 04:44:19 INFO - Running pre-action listener: _resource_record_pre_action 04:44:19 INFO - Running main action method: clobber 04:44:19 INFO - rmtree: /builds/slave/test/build 04:44:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:22 INFO - Running post-action listener: _resource_record_post_action 04:44:22 INFO - [mozharness: 2016-09-09 11:44:22.197111Z] Finished clobber step (success) 04:44:22 INFO - [mozharness: 2016-09-09 11:44:22.197356Z] Running read-buildbot-config step. 04:44:22 INFO - Running pre-action listener: _resource_record_pre_action 04:44:22 INFO - Running main action method: read_buildbot_config 04:44:22 INFO - Using buildbot properties: 04:44:22 INFO - { 04:44:22 INFO - "project": "", 04:44:22 INFO - "product": "firefox", 04:44:22 INFO - "script_repo_revision": "production", 04:44:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:44:22 INFO - "repository": "", 04:44:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:44:22 INFO - "buildid": "20160909030427", 04:44:22 INFO - "pgo_build": "False", 04:44:22 INFO - "basedir": "/builds/slave/test", 04:44:22 INFO - "buildnumber": 41, 04:44:22 INFO - "slavename": "t-yosemite-r7-0035", 04:44:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:44:22 INFO - "platform": "yosemite_r7", 04:44:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:44:22 INFO - "branch": "mozilla-central", 04:44:22 INFO - "repo_path": "mozilla-central", 04:44:22 INFO - "revision": "b13e7776b612f4507e9a394070622285f7a9fd20", 04:44:22 INFO - "stage_platform": "macosx64", 04:44:22 INFO - "builduid": "5a61a8341f3d41d893c4ea981bd2f9e6", 04:44:22 INFO - "slavebuilddir": "test" 04:44:22 INFO - } 04:44:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:44:22 INFO - Running post-action listener: _resource_record_post_action 04:44:22 INFO - [mozharness: 2016-09-09 11:44:22.203641Z] Finished read-buildbot-config step (success) 04:44:22 INFO - [mozharness: 2016-09-09 11:44:22.203872Z] Running download-and-extract step. 04:44:22 INFO - Running pre-action listener: _resource_record_pre_action 04:44:22 INFO - Running main action method: download_and_extract 04:44:22 INFO - mkdir: /builds/slave/test/build/tests 04:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:22 INFO - trying https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:44:22 INFO - Downloading https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:44:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 04:44:23 INFO - Downloaded 1199 bytes. 04:44:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:44:23 INFO - Using the following test package requirements: 04:44:23 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:44:23 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:44:23 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:44:23 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'jsshell-mac.zip'], 04:44:23 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:44:23 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:44:23 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:44:23 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:44:23 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:44:23 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:23 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:44:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:44:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:44:24 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 04:44:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:44:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:44:32 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 04:44:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:44:40 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 04:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:41 INFO - trying https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:44:41 INFO - Downloading https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 04:45:13 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg: The read operation timed out 04:45:13 INFO - retry: attempt #1 caught exception: The read operation timed out 04:45:13 INFO - retry: Failed, sleeping 30 seconds before retrying 04:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #2 04:45:46 INFO - Downloaded 111542878 bytes. 04:45:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:45:46 INFO - mkdir: /builds/slave/test/properties 04:45:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:46 INFO - Contents: 04:45:46 INFO - build_url:https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:45:47 INFO - Running post-action listener: _resource_record_post_action 04:45:47 INFO - Running post-action listener: set_extra_try_arguments 04:45:47 INFO - [mozharness: 2016-09-09 11:45:47.443007Z] Finished download-and-extract step (success) 04:45:47 INFO - [mozharness: 2016-09-09 11:45:47.443125Z] Running populate-webroot step. 04:45:47 INFO - Running pre-action listener: _resource_record_pre_action 04:45:47 INFO - Running main action method: populate_webroot 04:45:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:47 INFO - '--tppagecycles', 04:45:47 INFO - '7'], 04:45:47 INFO - 'tests': ['tsvgm']}}, 04:45:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['damp', 'tps']}, 04:45:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'tests': ['damp', 'tps']}, 04:45:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['dromaeo_dom']}, 04:45:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['basic_compositor_video']}, 04:45:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:45:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['a11yr', 04:45:47 INFO - 'ts_paint', 04:45:47 INFO - 'tpaint', 04:45:47 INFO - 'sessionrestore', 04:45:47 INFO - 'sessionrestore_no_auto_restore', 04:45:47 INFO - 'tabpaint']}, 04:45:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:47 INFO - 'ts_paint', 04:45:47 INFO - 'tpaint', 04:45:47 INFO - 'sessionrestore', 04:45:47 INFO - 'sessionrestore_no_auto_restore', 04:45:47 INFO - 'tabpaint']}, 04:45:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:47 INFO - 'ts_paint', 04:45:47 INFO - 'tpaint', 04:45:47 INFO - 'sessionrestore', 04:45:47 INFO - 'sessionrestore_no_auto_restore', 04:45:47 INFO - 'tabpaint']}, 04:45:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:47 INFO - 'ts_paint', 04:45:47 INFO - 'tpaint', 04:45:47 INFO - 'sessionrestore', 04:45:47 INFO - 'sessionrestore_no_auto_restore', 04:45:47 INFO - 'tabpaint']}, 04:45:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['a11yr', 04:45:47 INFO - 'ts_paint', 04:45:47 INFO - 'tpaint', 04:45:47 INFO - 'sessionrestore', 04:45:47 INFO - 'sessionrestore_no_auto_restore', 04:45:47 INFO - 'tabpaint']}, 04:45:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['a11yr', 04:45:47 INFO - 'ts_paint', 04:45:47 INFO - 'tpaint', 04:45:47 INFO - 'sessionrestore', 04:45:47 INFO - 'sessionrestore_no_auto_restore', 04:45:47 INFO - 'tabpaint']}, 04:45:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['tsvgx', 04:45:47 INFO - 'tsvgr_opacity', 04:45:47 INFO - 'tart', 04:45:47 INFO - 'tscrollx', 04:45:47 INFO - 'cart']}, 04:45:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:47 INFO - 'tsvgr_opacity', 04:45:47 INFO - 'tart', 04:45:47 INFO - 'tscrollx', 04:45:47 INFO - 'cart']}, 04:45:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'talos_options': ['--disable-e10s'], 04:45:47 INFO - 'tests': ['tp5o']}, 04:45:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'tests': ['tp5o']}, 04:45:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'talos_options': ['--disable-e10s', 04:45:47 INFO - '--xperf_path', 04:45:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:47 INFO - 'tests': ['tp5n']}, 04:45:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:47 INFO - 'talos_options': ['--xperf_path', 04:45:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:47 INFO - 'tests': ['tp5n']}}, 04:45:47 INFO - 'talos.zip': {'path': '', 04:45:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:47 INFO - Running post-action listener: _resource_record_post_action 04:45:47 INFO - [mozharness: 2016-09-09 11:45:47.462019Z] Finished populate-webroot step (success) 04:45:47 INFO - [mozharness: 2016-09-09 11:45:47.462108Z] Running create-virtualenv step. 04:45:47 INFO - Running pre-action listener: _resource_record_pre_action 04:45:47 INFO - Running main action method: create_virtualenv 04:45:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:47 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 04:45:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:47 INFO - Using real prefix '/tools/python27' 04:45:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:51 INFO - Installing pip.................done. 04:45:51 INFO - Return code: 0 04:45:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:51 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:45:51 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 04:45:51 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 04:45:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:45:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:51 INFO - 'HOME': '/Users/cltbld', 04:45:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:51 INFO - 'LOGNAME': 'cltbld', 04:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:51 INFO - 'MOZ_NO_REMOTE': '1', 04:45:51 INFO - 'NO_EM_RESTART': '1', 04:45:51 INFO - 'PAGER': '/bin/cat', 04:45:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:51 INFO - 'PWD': '/builds/slave/test', 04:45:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:51 INFO - 'SHELL': '/bin/bash', 04:45:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:45:51 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:45:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:51 INFO - 'USER': 'cltbld', 04:45:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:51 INFO - 'XPC_FLAGS': '0x0', 04:45:51 INFO - 'XPC_SERVICE_NAME': '0', 04:45:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:51 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 04:45:51 INFO - Cleaning up... 04:45:51 INFO - Return code: 0 04:45:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:51 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:45:51 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 04:45:51 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 04:45:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:45:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:51 INFO - 'HOME': '/Users/cltbld', 04:45:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:51 INFO - 'LOGNAME': 'cltbld', 04:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:51 INFO - 'MOZ_NO_REMOTE': '1', 04:45:51 INFO - 'NO_EM_RESTART': '1', 04:45:51 INFO - 'PAGER': '/bin/cat', 04:45:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:51 INFO - 'PWD': '/builds/slave/test', 04:45:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:51 INFO - 'SHELL': '/bin/bash', 04:45:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:45:51 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:45:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:51 INFO - 'USER': 'cltbld', 04:45:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:51 INFO - 'XPC_FLAGS': '0x0', 04:45:51 INFO - 'XPC_SERVICE_NAME': '0', 04:45:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:51 INFO - Downloading/unpacking psutil>=3.1.1 04:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:55 INFO - Installing collected packages: psutil 04:45:55 INFO - Running setup.py install for psutil 04:45:55 INFO - building 'psutil._psutil_osx' extension 04:45:55 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 04:45:55 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 04:45:56 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 04:45:56 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 04:45:56 INFO - building 'psutil._psutil_posix' extension 04:45:56 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 04:45:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:45:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:45:56 INFO - ^ 04:45:56 INFO - 1 warning generated. 04:45:56 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 04:45:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:56 INFO - Successfully installed psutil 04:45:56 INFO - Cleaning up... 04:45:56 INFO - Return code: 0 04:45:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:56 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:45:56 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 04:45:56 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 04:45:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:45:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:56 INFO - 'HOME': '/Users/cltbld', 04:45:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:56 INFO - 'LOGNAME': 'cltbld', 04:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:56 INFO - 'MOZ_NO_REMOTE': '1', 04:45:56 INFO - 'NO_EM_RESTART': '1', 04:45:56 INFO - 'PAGER': '/bin/cat', 04:45:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:56 INFO - 'PWD': '/builds/slave/test', 04:45:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:56 INFO - 'SHELL': '/bin/bash', 04:45:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:45:56 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:45:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:56 INFO - 'USER': 'cltbld', 04:45:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:56 INFO - 'XPC_FLAGS': '0x0', 04:45:56 INFO - 'XPC_SERVICE_NAME': '0', 04:45:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:59 INFO - Installing collected packages: mozsystemmonitor 04:45:59 INFO - Running setup.py install for mozsystemmonitor 04:45:59 INFO - Successfully installed mozsystemmonitor 04:45:59 INFO - Cleaning up... 04:45:59 INFO - Return code: 0 04:45:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45:59 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')]} 04:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:59 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')]} 04:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:59 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:45:59 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 04:45:59 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 04:45:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:45:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:59 INFO - 'HOME': '/Users/cltbld', 04:45:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:59 INFO - 'LOGNAME': 'cltbld', 04:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:59 INFO - 'MOZ_NO_REMOTE': '1', 04:45:59 INFO - 'NO_EM_RESTART': '1', 04:45:59 INFO - 'PAGER': '/bin/cat', 04:45:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:59 INFO - 'PWD': '/builds/slave/test', 04:45:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:59 INFO - 'SHELL': '/bin/bash', 04:45:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:45:59 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:45:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:59 INFO - 'USER': 'cltbld', 04:45:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:59 INFO - 'XPC_FLAGS': '0x0', 04:45:59 INFO - 'XPC_SERVICE_NAME': '0', 04:45:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46:02 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 04:46:02 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 04:46:02 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 04:46:02 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 04:46:02 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 04:46:02 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 04:46:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:02 INFO - warning: no files found matching '*.txt' 04:46:02 INFO - no previously-included directories found matching 'build' 04:46:02 INFO - no previously-included directories found matching 'dist' 04:46:02 INFO - no previously-included directories found matching '.git*' 04:46:02 INFO - Installing collected packages: jsonschema, functools32 04:46:02 INFO - Running setup.py install for functools32 04:46:02 INFO - warning: no files found matching '*.txt' 04:46:02 INFO - no previously-included directories found matching 'build' 04:46:02 INFO - no previously-included directories found matching 'dist' 04:46:02 INFO - no previously-included directories found matching '.git*' 04:46:02 INFO - Successfully installed jsonschema functools32 04:46:02 INFO - Cleaning up... 04:46:03 INFO - Return code: 0 04:46:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:46:03 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 04:46:03 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 04:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:03 INFO - 'HOME': '/Users/cltbld', 04:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:03 INFO - 'LOGNAME': 'cltbld', 04:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:03 INFO - 'MOZ_NO_REMOTE': '1', 04:46:03 INFO - 'NO_EM_RESTART': '1', 04:46:03 INFO - 'PAGER': '/bin/cat', 04:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:03 INFO - 'PWD': '/builds/slave/test', 04:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:03 INFO - 'SHELL': '/bin/bash', 04:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:46:03 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:03 INFO - 'USER': 'cltbld', 04:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:03 INFO - 'XPC_FLAGS': '0x0', 04:46:03 INFO - 'XPC_SERVICE_NAME': '0', 04:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:46:03 INFO - Cleaning up... 04:46:03 INFO - Return code: 0 04:46:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:46:03 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 04:46:03 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 04:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:03 INFO - 'HOME': '/Users/cltbld', 04:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:03 INFO - 'LOGNAME': 'cltbld', 04:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:03 INFO - 'MOZ_NO_REMOTE': '1', 04:46:03 INFO - 'NO_EM_RESTART': '1', 04:46:03 INFO - 'PAGER': '/bin/cat', 04:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:03 INFO - 'PWD': '/builds/slave/test', 04:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:03 INFO - 'SHELL': '/bin/bash', 04:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:46:03 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:03 INFO - 'USER': 'cltbld', 04:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:03 INFO - 'XPC_FLAGS': '0x0', 04:46:03 INFO - 'XPC_SERVICE_NAME': '0', 04:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:07 INFO - Downloading docopt-0.6.1.tar.gz 04:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:07 INFO - Running setup.py install for blobuploader 04:46:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:07 INFO - Running setup.py install for requests 04:46:07 INFO - Running setup.py install for docopt 04:46:08 INFO - Successfully installed blobuploader requests docopt 04:46:08 INFO - Cleaning up... 04:46:08 INFO - Return code: 0 04:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:08 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:46:08 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 04:46:08 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 04:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:08 INFO - 'HOME': '/Users/cltbld', 04:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:08 INFO - 'LOGNAME': 'cltbld', 04:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:08 INFO - 'MOZ_NO_REMOTE': '1', 04:46:08 INFO - 'NO_EM_RESTART': '1', 04:46:08 INFO - 'PAGER': '/bin/cat', 04:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:08 INFO - 'PWD': '/builds/slave/test', 04:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:08 INFO - 'SHELL': '/bin/bash', 04:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:46:08 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:08 INFO - 'USER': 'cltbld', 04:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:08 INFO - 'XPC_FLAGS': '0x0', 04:46:08 INFO - 'XPC_SERVICE_NAME': '0', 04:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:08 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-SuvFhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:08 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-3EpVZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:08 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-E_jddE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:08 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-KKWhcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:08 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-P56Kjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:08 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-mVhxUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-mq2bqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-QEb4JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-nCjHUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ThxlzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-j4tuod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Jn6Lj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-uPK0ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-DlpP44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-P1Ffz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:09 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-3XYw02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:10 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-TQT2zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:10 INFO - Running setup.py install for manifestparser 04:46:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:10 INFO - Running setup.py install for mozcrash 04:46:10 INFO - Running setup.py install for mozdebug 04:46:10 INFO - Running setup.py install for mozdevice 04:46:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:10 INFO - Running setup.py install for mozfile 04:46:10 INFO - Running setup.py install for mozhttpd 04:46:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Running setup.py install for mozinfo 04:46:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Running setup.py install for mozInstall 04:46:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Running setup.py install for mozleak 04:46:11 INFO - Running setup.py install for mozlog 04:46:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Running setup.py install for moznetwork 04:46:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:11 INFO - Running setup.py install for mozprocess 04:46:11 INFO - Running setup.py install for mozprofile 04:46:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Running setup.py install for mozrunner 04:46:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Running setup.py install for mozscreenshot 04:46:12 INFO - Running setup.py install for moztest 04:46:12 INFO - Running setup.py install for mozversion 04:46:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:12 INFO - Cleaning up... 04:46:12 INFO - Return code: 0 04:46:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:12 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')]} 04:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:12 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')]} 04:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:12 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:46:12 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 04:46:12 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 04:46:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:46:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:12 INFO - 'HOME': '/Users/cltbld', 04:46:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:12 INFO - 'LOGNAME': 'cltbld', 04:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:12 INFO - 'MOZ_NO_REMOTE': '1', 04:46:12 INFO - 'NO_EM_RESTART': '1', 04:46:12 INFO - 'PAGER': '/bin/cat', 04:46:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:12 INFO - 'PWD': '/builds/slave/test', 04:46:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:12 INFO - 'SHELL': '/bin/bash', 04:46:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:46:12 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:46:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:12 INFO - 'USER': 'cltbld', 04:46:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:12 INFO - 'XPC_FLAGS': '0x0', 04:46:12 INFO - 'XPC_SERVICE_NAME': '0', 04:46:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-mbmU0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ExIIzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-XXqC8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-E4uGBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-e0HfgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-XicKNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-nOc5lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-WwO5d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-TUwXjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:13 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)) 04:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:13 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ADIX6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:14 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-CADVBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:14 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-iyFsvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:14 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-lqw7TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:14 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-99SEhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:14 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-2eXa4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:14 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-F7aJD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:14 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-IMg1xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:14 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)) 04:46:14 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)) 04:46:14 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)) 04:46:14 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)) 04:46:14 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)) 04:46:14 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)) 04:46:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46:17 INFO - Downloading blessings-1.6.tar.gz 04:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:17 INFO - Installing collected packages: blessings 04:46:17 INFO - Running setup.py install for blessings 04:46:17 INFO - Successfully installed blessings 04:46:17 INFO - Cleaning up... 04:46:17 INFO - Return code: 0 04:46:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:17 INFO - Reading from file tmpfile_stdout 04:46:17 INFO - Current package versions: 04:46:17 INFO - blessings == 1.6 04:46:17 INFO - blobuploader == 1.2.4 04:46:17 INFO - docopt == 0.6.1 04:46:17 INFO - functools32 == 3.2.3-2 04:46:17 INFO - jsonschema == 2.5.1 04:46:17 INFO - manifestparser == 1.1 04:46:17 INFO - mozInstall == 1.12 04:46:17 INFO - mozcrash == 0.17 04:46:17 INFO - mozdebug == 0.1 04:46:17 INFO - mozdevice == 0.48 04:46:17 INFO - mozfile == 1.2 04:46:17 INFO - mozhttpd == 0.7 04:46:17 INFO - mozinfo == 0.9 04:46:17 INFO - mozleak == 0.1 04:46:17 INFO - mozlog == 3.3 04:46:17 INFO - moznetwork == 0.27 04:46:17 INFO - mozprocess == 0.23 04:46:17 INFO - mozprofile == 0.28 04:46:17 INFO - mozrunner == 6.12 04:46:17 INFO - mozscreenshot == 0.1 04:46:17 INFO - mozsystemmonitor == 0.3 04:46:17 INFO - moztest == 0.7 04:46:17 INFO - mozversion == 1.4 04:46:17 INFO - psutil == 3.1.1 04:46:17 INFO - requests == 1.2.3 04:46:17 INFO - wsgiref == 0.1.2 04:46:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:17 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:46:17 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 04:46:17 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 04:46:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:46:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:17 INFO - 'HOME': '/Users/cltbld', 04:46:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:17 INFO - 'LOGNAME': 'cltbld', 04:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:17 INFO - 'MOZ_NO_REMOTE': '1', 04:46:17 INFO - 'NO_EM_RESTART': '1', 04:46:17 INFO - 'PAGER': '/bin/cat', 04:46:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:17 INFO - 'PWD': '/builds/slave/test', 04:46:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:17 INFO - 'SHELL': '/bin/bash', 04:46:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:46:17 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:46:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:17 INFO - 'USER': 'cltbld', 04:46:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:17 INFO - 'XPC_FLAGS': '0x0', 04:46:17 INFO - 'XPC_SERVICE_NAME': '0', 04:46:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 INFO - Cleaning up... 04:46:18 INFO - Return code: 0 04:46:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:18 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 0x10f65da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb8c9e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, '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.rtPbxDkeQR/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.2xtubkXRF7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 04:46:18 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 04:46:18 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 04:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:18 INFO - 'HOME': '/Users/cltbld', 04:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:18 INFO - 'LOGNAME': 'cltbld', 04:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:18 INFO - 'MOZ_NO_REMOTE': '1', 04:46:18 INFO - 'NO_EM_RESTART': '1', 04:46:18 INFO - 'PAGER': '/bin/cat', 04:46:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:18 INFO - 'PWD': '/builds/slave/test', 04:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:18 INFO - 'SHELL': '/bin/bash', 04:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:46:18 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:18 INFO - 'USER': 'cltbld', 04:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:18 INFO - 'XPC_FLAGS': '0x0', 04:46:18 INFO - 'XPC_SERVICE_NAME': '0', 04:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:18 INFO - Cleaning up... 04:46:18 INFO - Return code: 0 04:46:18 INFO - Running post-action listener: _resource_record_post_action 04:46:18 INFO - Running post-action listener: _start_resource_monitoring 04:46:18 INFO - Starting resource monitoring. 04:46:18 INFO - [mozharness: 2016-09-09 11:46:18.491913Z] Finished create-virtualenv step (success) 04:46:18 INFO - [mozharness: 2016-09-09 11:46:18.492915Z] Running install step. 04:46:18 INFO - Running pre-action listener: _resource_record_pre_action 04:46:18 INFO - Running main action method: install 04:46:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:18 INFO - Reading from file tmpfile_stdout 04:46:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:18 INFO - Reading from file tmpfile_stdout 04:46:18 INFO - Output received: 04:46:18 INFO - Usage: mozinstall [options] installer 04:46:18 INFO - Options: 04:46:18 INFO - -h, --help show this help message and exit 04:46:18 INFO - -d DEST, --destination=DEST 04:46:18 INFO - Directory to install application into. [default: 04:46:18 INFO - "/builds/slave/test"] 04:46:18 INFO - --app=APP Application being installed. [default: firefox] 04:46:18 INFO - mkdir: /builds/slave/test/build/application 04:46:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:46:52 INFO - Reading from file tmpfile_stdout 04:46:52 INFO - Output received: 04:46:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:46:52 INFO - Running post-action listener: _resource_record_post_action 04:46:52 INFO - [mozharness: 2016-09-09 11:46:52.348520Z] Finished install step (success) 04:46:52 INFO - [mozharness: 2016-09-09 11:46:52.348671Z] Running run-tests step. 04:46:52 INFO - Running pre-action listener: _resource_record_pre_action 04:46:52 INFO - Running main action method: run_tests 04:46:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:52 INFO - 2016-09-09 04:46:52.363 screenresolution[1751:8534] starting screenresolution argv=screenresolution get 04:46:52 INFO - 2016-09-09 04:46:52.365 screenresolution[1751:8534] Display 0: 1600x1200x32@60 04:46:52 INFO - 2016-09-09 04:46:52.371 screenresolution[1752:8536] starting screenresolution argv=screenresolution list 04:46:52 INFO - Available Modes on Display 0 04:46:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:52 INFO - Intel Iris: 04:46:52 INFO - Chipset Model: Intel Iris 04:46:52 INFO - Type: GPU 04:46:52 INFO - Bus: Built-In 04:46:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:52 INFO - Vendor: Intel (0x8086) 04:46:52 INFO - Device ID: 0x0a2e 04:46:52 INFO - Revision ID: 0x0009 04:46:52 INFO - Displays: 04:46:52 INFO - Display: 04:46:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:52 INFO - Display Serial Number: 1600x1200 60 04:46:52 INFO - Main Display: Yes 04:46:52 INFO - Mirror: Off 04:46:52 INFO - Online: Yes 04:46:52 INFO - Rotation: Supported 04:46:52 INFO - Return code: 0 04:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:52 INFO - Python 2.7.3 04:46:52 INFO - Return code: 0 04:46:52 INFO - grabbing minidump binary from tooltool 04:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:52 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 0x10f5c1d30>, '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 0x10f326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:52 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 04:46:52 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 04:46:52 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 04:46:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:52 INFO - Return code: 0 04:46:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:46:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:46:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 04:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --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 04:46:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtPbxDkeQR/Render', 04:46:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:52 INFO - 'HOME': '/Users/cltbld', 04:46:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:52 INFO - 'LOGNAME': 'cltbld', 04:46:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:52 INFO - 'MOZ_NO_REMOTE': '1', 04:46:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:52 INFO - 'NO_EM_RESTART': '1', 04:46:52 INFO - 'PAGER': '/bin/cat', 04:46:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:52 INFO - 'PWD': '/builds/slave/test', 04:46:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:52 INFO - 'SHELL': '/bin/bash', 04:46:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2xtubkXRF7/Listeners', 04:46:52 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 04:46:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:52 INFO - 'USER': 'cltbld', 04:46:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:52 INFO - 'XPC_FLAGS': '0x0', 04:46:52 INFO - 'XPC_SERVICE_NAME': '0', 04:46:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 04:46:52 INFO - mozversion application_buildid: 20160909030427 04:46:52 INFO - mozversion application_changeset: b13e7776b612f4507e9a394070622285f7a9fd20 04:46:52 INFO - mozversion application_display_name: Nightly 04:46:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:52 INFO - mozversion application_name: Firefox 04:46:52 INFO - mozversion application_remotingname: firefox 04:46:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:46:52 INFO - mozversion application_vendor: Mozilla 04:46:52 INFO - mozversion application_version: 51.0a1 04:46:52 INFO - mozversion platform_buildid: 20160909030427 04:46:52 INFO - mozversion platform_changeset: b13e7776b612f4507e9a394070622285f7a9fd20 04:46:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:46:52 INFO - mozversion platform_version: 51.0a1 04:46:52 INFO - using testdate: 1473421612 04:46:52 INFO - actual date: 1473421612 04:46:52 INFO - starting webserver on 'localhost:49268' 04:46:52 INFO - SUITE-START | Running 2 tests 04:46:52 INFO - TEST-START | dromaeo_css 04:46:52 INFO - operating with platform_type : mac_ 04:46:52 INFO - Initialising browser for dromaeo_css test... 04:46:52 INFO - TEST-INFO | started process 1763 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpvFwKdi/profile http://localhost:49268/getInfo.html) 04:46:55 INFO - PROCESS | 1763 | __metrics Screen width/height:1600/1200 04:46:55 INFO - PROCESS | 1763 | colorDepth:24 04:46:55 INFO - PROCESS | 1763 | Browser inner width/height: 1024/689 04:46:55 INFO - PROCESS | 1763 | __metrics 04:46:55 INFO - PROCESS | 1763 | 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" 04:46:55 INFO - PROCESS | 1763 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:56 INFO - TEST-INFO | 1763: exit 0 04:46:56 INFO - Browser initialized. 04:46:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:56 INFO - TEST-INFO | started process 1766 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpvFwKdi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:08 INFO - PROCESS | 1766 | RSS: Main: 232456192 04:47:08 INFO - PROCESS | 1766 | 04:47:59 INFO - PROCESS | 1766 | 1473421679416 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] 04:50:11 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 04:50:12 INFO - PROCESS | 1766 | RSS: Main: 353071104 04:50:12 INFO - PROCESS | 1766 | 04:53:15 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 04:53:16 INFO - PROCESS | 1766 | RSS: Main: 370003968 04:53:16 INFO - PROCESS | 1766 | 04:56:18 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 04:56:18 INFO - PROCESS | 1766 | RSS: Main: 333438976 04:56:18 INFO - PROCESS | 1766 | 04:59:21 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 04:59:21 INFO - PROCESS | 1766 | RSS: Main: 355221504 04:59:21 INFO - PROCESS | 1766 | 05:02:25 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 05:02:26 INFO - PROCESS | 1766 | RSS: Main: 327024640 05:02:26 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 05:05:29 INFO - PROCESS | 1766 | RSS: Main: 532926464 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | __start_tp_report 05:05:29 INFO - PROCESS | 1766 | _x_x_mozilla_page_load 05:05:29 INFO - PROCESS | 1766 | _x_x_mozilla_page_load_details 05:05:29 INFO - PROCESS | 1766 | |i|pagename|runs| 05:05:29 INFO - PROCESS | 1766 | |0;dojo.html;2944.6466424029113;3345.364380767655;3359.7816141950757;3401.489776533518;3434.8969530914064;4695.17834378984;5589.329280486348;5674.829755107348;5784.450477204664;5794.159846822208;5687;5753.856153596163;5761.567882408825;5762.366139724627;5847.941520584793;5195.532402083812;5245.26566280721;5247.580193584504;5258.710770907618;5286.259923610698;5203.895922081575;5211.817586384477;5212.817551385702;5216.347956505437;5217.008768334004;5188.662736922088;5199.532042116209;5200.531952124308;5214.322138122039;5214.58283337334;5272.472752724716;5292.550133238679;5303.390110137345;5314;5355.571554275688;5125;5130.3074084998425;5143.794248230066;5172;5188.9740551297;5646.181303710939;5717.571182161355;5718.399568045378;5740.971295143498;5803.883922321572;6247.937520624827;6255.78104766331;6257.186565746424;6264.7807326743805;6266.49868010558;6096.526685943581;6209.875802483925;6227.676799746022;6265.530085243625;6291.1506946562085;5803.47768700819;5819.563532735062;5834.5624078194305;5868.2664666916635;5883.764649414061;6250.968745156245;6262.906056409158;6264.686765661699;6264.718087686065;6269.247690277105;6056.424639659225;6058.351068843514;6107;6147.877042459126;6189.102580125947;6171.537134714914;6228.813135605939;6244.375562443719;6302.495800336053;6306.369363063749;6175.2898416681755;6236.937630623635;6242.219722534684;6245.875082498324;6268.435840774352;6104.938950610526;6134.570580059442;6135.141080248769;6247.750089996349;6249.468795152372;4895.192293271571;4904.901901961941;4912.72979986097;4913.041956818458;4929.186684197139;4235.661147108224;4423.336499525097;4461.709988850715;4479.193745125844;4522.570355816192;5780.364159942403;5788.27646544182;5789.594728369058;5793.333766616809;5802.593818432669;6156.507479401637;6236.719347629368;6238.750449982041;6252.062190671436;6259.499240060784;5345.893082138336;5619.494245517923;5672.461116193955;5700.942990570041;5755.6834374108985;5095.770690318945;5431.646942948696;5431.728413579305;5442.346918369821;5454.209139674725;6299.937000629935;6347.365263473615;6352.968235158887;6369.20384951881;6443.645599491885;6126.334466363025;6177.7837775677635;6197.659128747962;6222.284437289589;6231.781887633911;6330.746770129143;6342.429181373698;6359.427651511386;6360.236771587439;6602.570832895846;6192.473639740492;6209.130721698875;6214.751409943552;6221.222347206599;6223.937760622336;5193.37679478465;6132.04958718918;6159.784407545893;6166.075088736546;6243.719032643633;6113.081058499921;6126.448619624255;6131.866048757656;6134.907976380268;6135.785247516315;6096;6117.204763380732;6117.663528505975;6133.570650054453;6140.846478837886;4992.725400102884;5842.094475356326;5878.382769809279;5966.403359663999;5995.280566332068;6100.420460056288;6125.124131082423;6146.477549408171;6148.600340977822;6164.229471316085;5999.970000149971;6010.789622363372;6017.127516510169;6017.518598512021;6022.066579680157 05:05:29 INFO - PROCESS | 1766 | |1;ext.html;475.3914988814318;492.4189456441399;526.4524894110124;536.5787856532625;544.6840832317256;30575.847120764392;31351.745930162793;32609.510857337158;32633;32741.508877366858;33514;42091.789541052254;43419.565804341946;43439.78280108595;45732.771336143276;9771.120599146057;9880.209583233323;9903.25725570585;9904.653337133203;9934.403935763841;9774.218062555014;9885.110340069392;9887.901120988807;9918.553665085052;9918.652847150352;8291.709790157345;8677.95661021694;8801.515916624583;8970.910290897105;8979.595918183664;11815.704607384841;11989.10081743864;12016.279023258588;12281.508739650493;12296.815547766791;11984.340861252627;12021.338826364547;12032.639020829301;12036.976856967169;12043.879561204363;40628.79685601553;40882.79558602188;40909.590904090874;40996.795016025026;41068.1786364274;3304.240024794287;3312.4865645824934;3401.7448691348;3560.394732895414;3584.408572585546;30483;30970.690293097006;31772.523412148836;31808.840955795073;31927.840360798047;3189.3106396516396;3233.805971641709;3280.0815771583993;3300.9601975377677;3380.8140552269615;375920;376564;376902;377306;380665;60462.79074418487;60487;60905;60981.695091524256;61000;63360.36639633545;64000.03999940005;64021;64089;64140;16193.02841829494;16383.918080409521;16404.671906562042;16405.67188656244;16417.93283436573;12684;12736.80894786579;12739.108262421541;12766.17019893704;12783.424745886457;16344.509664710078;16992.150392480326;17006.659866802594;17009.489715308562;17106.828931710774;5544.445555444504;6145.7708458307625;6688.83277918056;6697.22981857083;6828.863422731518;824.7525742277413;845.8519759042143;902.1700035966795;924.3852837862746;938.1416004355938;32085.51871721926;32583.51124733131;32837.507437388456;33919.32161356759;34456.82771586126;1031.4275577054807;1036.8237399642078;1104.5195340027115;1140.9389267980857;1151.5681619392728;15352.616184595474;15540.68918621644;15787.894847360574;15880.126593037494;16210.351585936667;679479;693688;693692.0630793729;696610;698862;58824.82350352969;59295;59402;59410.40589594049;59484.40515594875;1258.6098309524077;1387.569853345466;1397.7623803953352;1426.1300606630155;1426.522115091456;29956.95150669716;30377.848110759303;31543;31738.88913888003;32281.838590806896;52297.73851130872;52565.68585785386;52737.7363113182;52830;52982.73508632432;576866;584330.861802605;585052.5231616873;585161;585708;42917.78541107274;43439.56560434355;43524.12951741011;43743.78128109339;44652.55347446484;44805;47666;48770.26844597263;49151.75424122856;49227.26159107545;39273;39566.60433395629;39606.40590391204;40480.59519404768;40886.38670419886;36617.08457288589;38568;39840.80477585677;40623;41207.79396103;38017.809910950265;38257.23485530329;38464.423033653955;38941.415878761276;39149.412758808074;28604.85697571499;33130.006099817045;33876.83061584676;35328;35368.646313536534;21366.572668546854;25020;25813;26023.869880650476;26228.73771262263 05:05:29 INFO - PROCESS | 1766 | |2;jquery.html;358.90847833802377;370.6090074970906;376.09549034571853;386.3798603241798;407.6086956521739;15247.923760381196;15415.997960132598;19763;20486.2829800957;20534.075966581502;19179;19648.312309069148;19986.60026799467;20575.588488230227;20623.96880155994;5400.945990540104;5495.53287970521;5574.749136288857;5589.776408943658;6044.788432404866;3896.8051597420017;6036.15493830864;6149.600275982069;6152.815415537541;6155.90766138506;5865.8826823463505;6134.938650613503;6142.723577439026;6208.565400421972;6214.228944750747;5919.881602367928;6147.907781383283;6181.6600086995195;6184.84537886552;6196.132541444202;5998.530360061769;5998.670073145975;5999.400059994009;6011.909821352683;6015.969920150415;13257.0057245706;16937.40719074839;19257.61484770311;24580.877095614585;24854.502909941883;2073.792620737929;2105.389437063265;2221.6334304839684;2266.9546609067725;2886.2891347579734;9919.107280344731;9956.402615843073;10002.59989600415;10374.17006639467;10507.159427245802;1792.9910350448295;1824.8540116790625;1836;1839.5309196155029;1875.0624687656173;83461;104280;104631;110436;118970.40514797371;9265.861012084824;11149.275297105825;11270;11579.305241685357;11652.41737913101;14389.928050359891;14412.783808242884;14425.134491930517;14430.422783088768;14431.42274309016;8219.383546233938;8469.576521173916;8503.937007874016;8609.062960833888;8610.138986101465;8325.129799067614;8366.832663346699;8386.8322633547;8526.275266602408;8595.097514760984;3812.504374431306;4365.345198220292;4469.709468884512;4482.910341793146;4555.63554915606;1878.7181922711702;1895.478743345591;1905.9428217153506;1911.120884393167;1918.5011896906906;709.7728726807476;762.4777027735907;794;794.0110024388869;947.625687853294;16565.546592765026;18858.434246972614;19045.85724856513;21348.14607415686;21399.786002140092;893.8078313162571;905.3843386497114;905.7735566108473;913.1005959130251;930.8231436027269;8757.766769473743;10793.514291856885;11286.984171424447;11293.887061129448;11331.433428328715;561347;577694;608575.9571202116;609160;610218;132116;133475;135146;136661;140433.8934915977;940.1585580905188;966.2752935298527;993.3295025857661;993.6373223773415;994.5773046455228;16221.756673649668;18453.955097408776;18885.71671424957;18969.715454268473;19038.238470461027;47238.76380618075;47370.76314618405;50519.49480505148;55708;56029.719851400485;78819;79269.20730792618;79806;81386.18613814023;84662.57668711618;7137.964310178623;7334.596597186993;7473.663685134074;7474.140473845578;7679.808004799701;12562.811557826823;13027.348632568523;13129.934350328187;13328.40022198984;13469.461221551028;9333.57998890038;11089.33463992163;11454.770904582028;11507.309561426342;11826.940865295619;11407.37259450705;11587.246828956091;11701.648950531498;11791.941040294743;11869.76260474803;11319.490622921823;11423.885761142283;11836.70408239801;11882.346470943836;11941.52233910634;6075.453209211192;7393.112826460644;7482.850342993219;7549;7671.808204794925;10142.340747851365;10412.32319899204;10430.739231519272;11690;11765.352905589933 05:05:29 INFO - PROCESS | 1766 | |3;mootools.html;1520.5970417839271;1550.1474189195942;1750.2473936207425;1868.2246867549968;1898.1932678611595;7066.293370662937;8301;8853.203211710945;8862.069482704304;8868.778280542982;7195.712171513133;7698.384129269659;7907.486013409139;8364.163583641634;8598.22615964563;2064.8451366147524;2376.477175021497;2415.5168966206743;2415.867127307997;2422.236995346469;2349.9765002349927;2378.6550950112223;2423.5395274897714;2425.260295609838;2431.5623187826272;1982.5836574319337;2390.2112302940077;2403.9399015024587;2414.022320960014;2416.9637455438096;2369.052379048377;2380.2264264114233;2383.2731017039796;2385.8807059647033;2414.2998530426157;2370.134900761227;2388.9283321500384;2394.078279862248;2396.029608008759;2396.400899775056;8747.300215982707;8776;8844.778880527974;8869.46783193004;8870.645174193025;5180.093483640386;5336.893262134736;5340.91988620171;5347.652402593819;5353.277307563507;3646.4894914711963;3652.981735091334;3720.572134204574;3721.1999420124803;3725.497057897176;934.2992755433424;1104.5636973395544;1107.379867274329;1121.4616983847718;1134.1323887226279;11513;11620.418979051097;11622.07023438123;11648.825267620992;11658.475368608433;4475.731456112644;4654.301854721819;4747.335373047776;4773.856784296477;4775.2359622460235;9852.556634951445;9859.950700246452;9865.950670246746;9881;9891.060349266952;5304.443033481429;5308.124159513714;5311.070562651597;5313.149896016619;5317.255584218213;4358.564143585616;4482.260427029503;4699.154152252628;4774.904501909942;4890.290907818347;3827.6937844972335;3843.8270277837005;3943.8225279862477;3976.721629485966;4033.253848038122;1295.112847699329;1302.9739405211842;1304.1848844472204;1313.8817506424468;1314.90795644304;831.1543700227659;845.8158577990862;906.619219927632;910.8406028944908;941.5339406993583;5197.818076367309;5584.636998595079;5853.619514731528;5913.76344946206;5924;789.2738680414033;924.8057907839294;928.5821380378857;932.785459344341;994.472929347447;3794.2032173243374;3821.407681809324;3838.405047217686;3904.72666913319;3966.2067586482817;9594.328397012281;10841.78316433667;10859.565617375374;10875.728106797393;10876.61931832398;10714.678559643224;10730.034296913314;10796.974287442681;10820.13438924884;10821.621243256448;5978.611390259706;6812.523123381316;8170.632321545545;8172.141925097898;8185.836283274301;5842.357340692605;5938.168656388196;5980.37206093354;6010.4891084258325;6045.637261764308;9336.906630933603;9746.308443406253;10006.749831253986;10093.293469457067;10143.746406339606;9953.651622193478;10164.237682173718;10167.593296268362;10235.795284094425;10303.330283531546;6593.736250549924;6855.931440685529;7373.963130184315;7432.3682486987045;7518.586477743776;8159.83680326402;8314.376421768513;8340.874886876823;8342;8349.874751878848;7296.160941491797;7390.889136663062;7393.852122957618;7509.9249007509225;7529.736459223901;7263.600501972231;7506.699732010658;7528.887066694114;7544.773656790305;7750.99237099196;6654.367835055662;6831.351021652935;6853.417459515997;6930.168379794457;6930.61881596517;4996.875078123076;5089.618278629044;5095.566876815512;5144.0997825381155;5157.535821776059;4321.935170972375;4930.7534623267975;5087.491250874883;5123.205903085028;5127.564157046693 05:05:29 INFO - PROCESS | 1766 | |4;prototype.html;299.08927316321797;308.07270116947984;313.1654141712337;314.33518109199053;316.15901701474075;4411.823527058914;5212.452692467288;5238.10952138136;5287.709175995324;5303.886183901385;4274.935875961863;4397.648188144949;4863.440704319004;4948.604111671058;5150.22746588012;3491.5810102787636;3867.149227170018;3944.4477773111644;4037.1925614876995;4045.919081618366;3051.7711171662213;3360.286254010448;3983.5618082010956;4012.699047571429;4027.7180597358197;3680.7055435565226;3777.6033516480784;3951.9802400988096;3968.1666849961543;3979;3456.222349971249;3599.892003239907;3856.5564960029674;3952.980235098835;3999.1601763629674;3276.262840860787;3449.9827500862584;3456;3461;3470.861165553375;4509.7970591323465;5052.368453943257;5055.469175736532;5075.822346217901;5083.87290317745;4467;4496.797644106023;4501.572350626685;4504.639628829718;4528.547145285478;5419.756110975016;5443.972780136113;5447.809326673548;5477.808876449412;5487.396386397493;3789.9344857052974;3793.336166170937;3793.506844110276;3814.7329686921926;3839.3856982882603;5376.354837419495;5650.491455768959;5685.749135190252;5755.22304488897;5779.844031193778;3483.6168021517615;3757.9812100939866;3879.80600969956;3883.262180185756;3883.359245724424;3306.9007929762147;3711.740178187555;3944.881653550398;3950.170464202492;3967.8573570272306;3413.9829300853335;4034.7693953343924;4195.958040419557;4223.472065991751;4519.864404067883;4562.133194692998;5462.016836969384;5479.137093388267;5532;5704.117641178401;1103.7130346110068;1227.5085770788357;1334.7463981843418;1335;1335.1774827360582;822.9465084769471;833.6832003838502;863.8013256950936;889.7286327669993;927.5918595817953;4960.082384758759;4963.337282010567;4974.950250497449;4986.6010719143105;5009.9729555441045;5118.744062796845;5268.7839039350765;5469.398366179717;5526.944730552643;5583.888322233533;4213.789310534461;4365.934510982338;4604;4875.975620121948;4955.529224723646;2918.941621167607;2931.2818359502057;2941.6911224321566;2947.5556977081505;2957.896473623413;4602.792874320664;4740.691855029412;4846.975765121152;5365.980463711882;5731.398203188605;4256.59562341577;4870.439899411542;5174.421801350549;5185.496206100264;5343.49236822509;5701.543876489871;5872.911906321408;5925.822225333247;6024.548158888101;6031.517478601789;5474.616776825584;5689.260396148474;5760.481556659921;5825.863956528437;5838.474537291664;5582.748776305158;5583.106702927512;5597.188407680782;5611.961787069406;5638.295213098363;4924.261360795909;5892.587518873809;5908.970455147869;5940.287165540163;5956.463918247378;3585.946210806892;3681.4293784463453;3751.699864010818;3793.962060379361;3840.2703486337505;4964.404271487445;5010.49895010496;5647.548196144381;5652;5667.971660141673;5498.752556135064;5504.256925315031;5515.696636685021;5520.751566179451;5524.447555244604;5245.606579506476;5462.481064298885;5496.5053145217125;5527.419620939743;5531.1426728857095;4568.908621827612;4749.596284315872;4869.956277326671;5377.919331210113;5434.592405569677;4355.673324500612;5407.513323800877;5582.692951887685;5593.356763972195;5610.438956104357;4731.195696731495;5408.972955135357;5411.107167317348;5417.295751552273;5455.5450047478 05:05:29 INFO - PROCESS | 1766 | |5;yui.html;661.7319985405911;685.9657017149148;721.8270310745042;776.3401109057298;801.7314199743086;11875.584354547582;13428;14209.218492982882;16179.948303360288;16197.676046479064;15209.163496007715;15237.314320855561;15471.5358539244;16270.83729162708;16319.184040797942;872.9039805621377;907.1382186922417;913.8674892140635;913.8811954445913;919.103873723118;707.130229817325;725.0574253470494;732.088549755555;733.7798660401885;873.0047745570055;933.551895090357;940.5673390240497;945.2768631996528;947.2516711797706;957.4016239850093;939.9295052871062;942.88213973253;943.9244860411151;947.8056998315398;951.6241084771546;705.728294606575;706.4524993130365;706.6254884911006;709.120690343975;715.3526058916689;15415.152166630944;15532.844671553254;15546.76679849803;15577.688446231012;15584.532464025984;11696.883031169664;14160.079594826304;14270.714585708332;14293.428262869473;14494.855051449456;11765.411729413496;11880.227785193934;12006.399680016051;12020.218685785396;12531.248125112523;3738.607446218135;3757.643023912724;3848.8460461581503;3849.2301539692176;3850.172212974224;115267;116382.25426618608;117854;118961;120027;10302.793944121076;11015.7190486334;11021.559137634405;11088.611898583511;11455.369954652408;18477.7228341575;22572.322830315115;22597.661035084486;22605.09579616797;22625.2081177158;7455.254474552501;7459.403247740168;7542.811429714191;7549.169591344948;7729.961350193325;4347.500037495665;4359.629431498295;4383.276759334738;4436.977815110904;4459.888502787457;3328.350971560571;3487.442009278503;3548.4677298405445;3863.5318578939823;4025.3358195897936;702.0522294901943;706.5266271598042;709.7764204275637;716.2443621978758;719.7548241542162;574.2391331485798;605.5609682979805;606.8543549548165;612.7273363353354;665.171861033017;9031.683891063782;9241.953790231006;9311.953440232755;9486.118963311292;9929.602815887283;566.6316894018921;654.9115869357671;655.1777519213357;664.3190729502298;668.882945484548;4130.690198235085;4315.956840431619;4370.453693288339;4730.5032971538185;4758.357621721093;90805;117840.41079794717;153294;164869;173129.26870731384;143816;147437;148057.25971370074;149017.50982490252;153912.2304388471;124269;126121;126501;127329.3633531845;130005.34997324953;8841.469511829311;8951.820963580562;8961.686340978034;9109.134632209929;9166.22087122602;62452.687736562846;67250.11561239864;68365.65817170883;70230.29769702238;71262;88982;101037;103110.48444757728;104436;110709;11479.4260286987;11956.701082473008;12029.518819247132;12390.5663301784;12469;12294;12861.935690321488;13054.477820887058;13104.868951310365;13146.60560183196;13536.932315338361;13764.105333153313;13769.449222031006;13915.539850178986;13977.231252281223;13168.60494185176;13252.337383130998;13534.255615940823;13656.863431365558;13676.521321753691;13029.47882084706;13278.53525126616;13432.798508022192;13437.529686460926;13662.248576328397;11129.443527823414;11270.370315014256;11431.428428578703;11445.656630301104;11935.582254621047;8057.073436554637;9872.753181170241;10385;11353.432328383713;11586.826197606873 05:05:29 INFO - PROCESS | 1766 | __end_tp_report 05:05:29 INFO - PROCESS | 1766 | __start_cc_report 05:05:29 INFO - PROCESS | 1766 | _x_x_mozilla_cycle_collect,1175 05:05:29 INFO - PROCESS | 1766 | __end_cc_report 05:05:29 INFO - PROCESS | 1766 | __startTimestamp1473422729311__endTimestamp 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | ------- Summary: start ------- 05:05:29 INFO - PROCESS | 1766 | Number of tests: 6 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | [#0] dojo.html Cycles:165 Average:5739.11 Median:6010.79 stddev:658.18 (10.9%) stddev-sans-first:622.62 05:05:29 INFO - PROCESS | 1766 | Values: 2944.6 3345.4 3359.8 3401.5 3434.9 4695.2 5589.3 5674.8 5784.5 5794.2 5687.0 5753.9 5761.6 5762.4 5847.9 5195.5 5245.3 5247.6 5258.7 5286.3 5203.9 5211.8 5212.8 5216.3 5217.0 5188.7 5199.5 5200.5 5214.3 5214.6 5272.5 5292.6 5303.4 5314.0 5355.6 5125.0 5130.3 5143.8 5172.0 5189.0 5646.2 5717.6 5718.4 5741.0 5803.9 6247.9 6255.8 6257.2 6264.8 6266.5 6096.5 6209.9 6227.7 6265.5 6291.2 5803.5 5819.6 5834.6 5868.3 5883.8 6251.0 6262.9 6264.7 6264.7 6269.2 6056.4 6058.4 6107.0 6147.9 6189.1 6171.5 6228.8 6244.4 6302.5 6306.4 6175.3 6236.9 6242.2 6245.9 6268.4 6104.9 6134.6 6135.1 6247.8 6249.5 4895.2 4904.9 4912.7 4913.0 4929.2 4235.7 4423.3 4461.7 4479.2 4522.6 5780.4 5788.3 5789.6 5793.3 5802.6 6156.5 6236.7 6238.8 6252.1 6259.5 5345.9 5619.5 5672.5 5700.9 5755.7 5095.8 5431.6 5431.7 5442.3 5454.2 6299.9 6347.4 6353.0 6369.2 6443.6 6126.3 6177.8 6197.7 6222.3 6231.8 6330.7 6342.4 6359.4 6360.2 6602.6 6192.5 6209.1 6214.8 6221.2 6223.9 5193.4 6132.0 6159.8 6166.1 6243.7 6113.1 6126.4 6131.9 6134.9 6135.8 6096.0 6117.2 6117.7 6133.6 6140.8 4992.7 5842.1 5878.4 5966.4 5995.3 6100.4 6125.1 6146.5 6148.6 6164.2 6000.0 6010.8 6017.1 6017.5 6022.1 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | [#1] ext.html Cycles:180 Average:69423.18 Median:38754.71 stddev:151591.32 (391.2%) stddev-sans-first:151928.18 05:05:29 INFO - PROCESS | 1766 | Values: 475.4 492.4 526.5 536.6 544.7 30575.8 31351.7 32609.5 32633.0 32741.5 33514.0 42091.8 43419.6 43439.8 45732.8 9771.1 9880.2 9903.3 9904.7 9934.4 9774.2 9885.1 9887.9 9918.6 9918.7 8291.7 8678.0 8801.5 8970.9 8979.6 11815.7 11989.1 12016.3 12281.5 12296.8 11984.3 12021.3 12032.6 12037.0 12043.9 40628.8 40882.8 40909.6 40996.8 41068.2 3304.2 3312.5 3401.7 3560.4 3584.4 30483.0 30970.7 31772.5 31808.8 31927.8 3189.3 3233.8 3280.1 3301.0 3380.8 375920.0 376564.0 376902.0 377306.0 380665.0 60462.8 60487.0 60905.0 60981.7 61000.0 63360.4 64000.0 64021.0 64089.0 64140.0 16193.0 16383.9 16404.7 16405.7 16417.9 12684.0 12736.8 12739.1 12766.2 12783.4 16344.5 16992.2 17006.7 17009.5 17106.8 5544.4 6145.8 6688.8 6697.2 6828.9 824.8 845.9 902.2 924.4 938.1 32085.5 32583.5 32837.5 33919.3 34456.8 1031.4 1036.8 1104.5 1140.9 1151.6 15352.6 15540.7 15787.9 15880.1 16210.4 679479.0 693688.0 693692.1 696610.0 698862.0 58824.8 59295.0 59402.0 59410.4 59484.4 1258.6 1387.6 1397.8 1426.1 1426.5 29957.0 30377.8 31543.0 31738.9 32281.8 52297.7 52565.7 52737.7 52830.0 52982.7 576866.0 584330.9 585052.5 585161.0 585708.0 42917.8 43439.6 43524.1 43743.8 44652.6 44805.0 47666.0 48770.3 49151.8 49227.3 39273.0 39566.6 39606.4 40480.6 40886.4 36617.1 38568.0 39840.8 40623.0 41207.8 38017.8 38257.2 38464.4 38941.4 39149.4 28604.9 33130.0 33876.8 35328.0 35368.6 21366.6 25020.0 25813.0 26023.9 26228.7 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | [#2] jquery.html Cycles:180 Average:34458.77 Median:373.35 stddev:99150.95 (26556.9%) stddev-sans-first:99396.03 05:05:29 INFO - PROCESS | 1766 | Values: 358.9 370.6 376.1 386.4 407.6 15247.9 15416.0 19763.0 20486.3 20534.1 19179.0 19648.3 19986.6 20575.6 20624.0 5400.9 5495.5 5574.7 5589.8 6044.8 3896.8 6036.2 6149.6 6152.8 6155.9 5865.9 6134.9 6142.7 6208.6 6214.2 5919.9 6147.9 6181.7 6184.8 6196.1 5998.5 5998.7 5999.4 6011.9 6016.0 13257.0 16937.4 19257.6 24580.9 24854.5 2073.8 2105.4 2221.6 2267.0 2886.3 9919.1 9956.4 10002.6 10374.2 10507.2 1793.0 1824.9 1836.0 1839.5 1875.1 83461.0 104280.0 104631.0 110436.0 118970.4 9265.9 11149.3 11270.0 11579.3 11652.4 14389.9 14412.8 14425.1 14430.4 14431.4 8219.4 8469.6 8503.9 8609.1 8610.1 8325.1 8366.8 8386.8 8526.3 8595.1 3812.5 4365.3 4469.7 4482.9 4555.6 1878.7 1895.5 1905.9 1911.1 1918.5 709.8 762.5 794.0 794.0 947.6 16565.5 18858.4 19045.9 21348.1 21399.8 893.8 905.4 905.8 913.1 930.8 8757.8 10793.5 11287.0 11293.9 11331.4 561347.0 577694.0 608576.0 609160.0 610218.0 132116.0 133475.0 135146.0 136661.0 140433.9 940.2 966.3 993.3 993.6 994.6 16221.8 18454.0 18885.7 18969.7 19038.2 47238.8 47370.8 50519.5 55708.0 56029.7 78819.0 79269.2 79806.0 81386.2 84662.6 7138.0 7334.6 7473.7 7474.1 7679.8 12562.8 13027.3 13129.9 13328.4 13469.5 9333.6 11089.3 11454.8 11507.3 11826.9 11407.4 11587.2 11701.6 11791.9 11869.8 11319.5 11423.9 11836.7 11882.3 11941.5 6075.5 7393.1 7482.9 7549.0 7671.8 10142.3 10412.3 10430.7 11690.0 11765.4 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | [#3] mootools.html Cycles:180 Average:5656.00 Median:5109.39 stddev:3151.93 (61.7%) stddev-sans-first:3145.45 05:05:29 INFO - PROCESS | 1766 | Values: 1520.6 1550.1 1750.2 1868.2 1898.2 7066.3 8301.0 8853.2 8862.1 8868.8 7195.7 7698.4 7907.5 8364.2 8598.2 2064.8 2376.5 2415.5 2415.9 2422.2 2350.0 2378.7 2423.5 2425.3 2431.6 1982.6 2390.2 2403.9 2414.0 2417.0 2369.1 2380.2 2383.3 2385.9 2414.3 2370.1 2388.9 2394.1 2396.0 2396.4 8747.3 8776.0 8844.8 8869.5 8870.6 5180.1 5336.9 5340.9 5347.7 5353.3 3646.5 3653.0 3720.6 3721.2 3725.5 934.3 1104.6 1107.4 1121.5 1134.1 11513.0 11620.4 11622.1 11648.8 11658.5 4475.7 4654.3 4747.3 4773.9 4775.2 9852.6 9860.0 9866.0 9881.0 9891.1 5304.4 5308.1 5311.1 5313.1 5317.3 4358.6 4482.3 4699.2 4774.9 4890.3 3827.7 3843.8 3943.8 3976.7 4033.3 1295.1 1303.0 1304.2 1313.9 1314.9 831.2 845.8 906.6 910.8 941.5 5197.8 5584.6 5853.6 5913.8 5924.0 789.3 924.8 928.6 932.8 994.5 3794.2 3821.4 3838.4 3904.7 3966.2 9594.3 10841.8 10859.6 10875.7 10876.6 10714.7 10730.0 10797.0 10820.1 10821.6 5978.6 6812.5 8170.6 8172.1 8185.8 5842.4 5938.2 5980.4 6010.5 6045.6 9336.9 9746.3 10006.7 10093.3 10143.7 9953.7 10164.2 10167.6 10235.8 10303.3 6593.7 6855.9 7374.0 7432.4 7518.6 8159.8 8314.4 8340.9 8342.0 8349.9 7296.2 7390.9 7393.9 7509.9 7529.7 7263.6 7506.7 7528.9 7544.8 7751.0 6654.4 6831.4 6853.4 6930.2 6930.6 4996.9 5089.6 5095.6 5144.1 5157.5 4321.9 4930.8 5087.5 5123.2 5127.6 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | [#4] prototype.html Cycles:180 Average:4411.51 Median:4936.43 stddev:1362.92 (27.6%) stddev-sans-first:1331.33 05:05:29 INFO - PROCESS | 1766 | Values: 299.1 308.1 313.2 314.3 316.2 4411.8 5212.5 5238.1 5287.7 5303.9 4274.9 4397.6 4863.4 4948.6 5150.2 3491.6 3867.1 3944.4 4037.2 4045.9 3051.8 3360.3 3983.6 4012.7 4027.7 3680.7 3777.6 3952.0 3968.2 3979.0 3456.2 3599.9 3856.6 3953.0 3999.2 3276.3 3450.0 3456.0 3461.0 3470.9 4509.8 5052.4 5055.5 5075.8 5083.9 4467.0 4496.8 4501.6 4504.6 4528.5 5419.8 5444.0 5447.8 5477.8 5487.4 3789.9 3793.3 3793.5 3814.7 3839.4 5376.4 5650.5 5685.7 5755.2 5779.8 3483.6 3758.0 3879.8 3883.3 3883.4 3306.9 3711.7 3944.9 3950.2 3967.9 3414.0 4034.8 4196.0 4223.5 4519.9 4562.1 5462.0 5479.1 5532.0 5704.1 1103.7 1227.5 1334.7 1335.0 1335.2 822.9 833.7 863.8 889.7 927.6 4960.1 4963.3 4975.0 4986.6 5010.0 5118.7 5268.8 5469.4 5526.9 5583.9 4213.8 4365.9 4604.0 4876.0 4955.5 2918.9 2931.3 2941.7 2947.6 2957.9 4602.8 4740.7 4847.0 5366.0 5731.4 4256.6 4870.4 5174.4 5185.5 5343.5 5701.5 5872.9 5925.8 6024.5 6031.5 5474.6 5689.3 5760.5 5825.9 5838.5 5582.7 5583.1 5597.2 5612.0 5638.3 4924.3 5892.6 5909.0 5940.3 5956.5 3585.9 3681.4 3751.7 3794.0 3840.3 4964.4 5010.5 5647.5 5652.0 5668.0 5498.8 5504.3 5515.7 5520.8 5524.4 5245.6 5462.5 5496.5 5527.4 5531.1 4568.9 4749.6 4870.0 5377.9 5434.6 4355.7 5407.5 5582.7 5593.4 5610.4 4731.2 5409.0 5411.1 5417.3 5455.5 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - PROCESS | 1766 | [#5] yui.html Cycles:180 Average:26200.78 Median:12976.78 stddev:42896.64 (330.6%) stddev-sans-first:42974.12 05:05:29 INFO - PROCESS | 1766 | Values: 661.7 686.0 721.8 776.3 801.7 11875.6 13428.0 14209.2 16179.9 16197.7 15209.2 15237.3 15471.5 16270.8 16319.2 872.9 907.1 913.9 913.9 919.1 707.1 725.1 732.1 733.8 873.0 933.6 940.6 945.3 947.3 957.4 939.9 942.9 943.9 947.8 951.6 705.7 706.5 706.6 709.1 715.4 15415.2 15532.8 15546.8 15577.7 15584.5 11696.9 14160.1 14270.7 14293.4 14494.9 11765.4 11880.2 12006.4 12020.2 12531.2 3738.6 3757.6 3848.8 3849.2 3850.2 115267.0 116382.3 117854.0 118961.0 120027.0 10302.8 11015.7 11021.6 11088.6 11455.4 18477.7 22572.3 22597.7 22605.1 22625.2 7455.3 7459.4 7542.8 7549.2 7730.0 4347.5 4359.6 4383.3 4437.0 4459.9 3328.4 3487.4 3548.5 3863.5 4025.3 702.1 706.5 709.8 716.2 719.8 574.2 605.6 606.9 612.7 665.2 9031.7 9242.0 9312.0 9486.1 9929.6 566.6 654.9 655.2 664.3 668.9 4130.7 4316.0 4370.5 4730.5 4758.4 90805.0 117840.4 153294.0 164869.0 173129.3 143816.0 147437.0 148057.3 149017.5 153912.2 124269.0 126121.0 126501.0 127329.4 130005.3 8841.5 8951.8 8961.7 9109.1 9166.2 62452.7 67250.1 68365.7 70230.3 71262.0 88982.0 101037.0 103110.5 104436.0 110709.0 11479.4 11956.7 12029.5 12390.6 12469.0 12294.0 12861.9 13054.5 13104.9 13146.6 13536.9 13764.1 13769.4 13915.5 13977.2 13168.6 13252.3 13534.3 13656.9 13676.5 13029.5 13278.5 13432.8 13437.5 13662.2 11129.4 11270.4 11431.4 11445.7 11935.6 8057.1 9872.8 10385.0 11353.4 11586.8 05:05:29 INFO - PROCESS | 1766 | -------- Summary: end -------- 05:05:29 INFO - PROCESS | 1766 | 05:05:29 INFO - TEST-INFO | 1766: exit 0 05:05:29 INFO - TEST-OK | dromaeo_css | took 1116976ms 05:05:29 INFO - TEST-START | kraken 05:05:29 INFO - operating with platform_type : mac_ 05:05:29 INFO - Initialising browser for kraken test... 05:05:29 INFO - TEST-INFO | started process 1883 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpcwQ_Ld/profile http://localhost:49268/getInfo.html) 05:05:32 INFO - PROCESS | 1883 | __metrics Screen width/height:1600/1200 05:05:32 INFO - PROCESS | 1883 | colorDepth:24 05:05:32 INFO - PROCESS | 1883 | Browser inner width/height: 1024/689 05:05:32 INFO - PROCESS | 1883 | __metrics 05:05:32 INFO - PROCESS | 1883 | 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" 05:05:32 INFO - PROCESS | 1883 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:33 INFO - TEST-INFO | 1883: exit 0 05:05:33 INFO - Browser initialized. 05:05:33 INFO - Running cycle 1/1 for kraken test... 05:05:33 INFO - TEST-INFO | started process 1884 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpcwQ_Ld/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:45 INFO - PROCESS | 1884 | RSS: Main: 232259584 05:05:45 INFO - PROCESS | 1884 | 05:05:47 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:48 INFO - PROCESS | 1884 | RSS: Main: 291926016 05:05:48 INFO - PROCESS | 1884 | 05:05:51 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 05:05:51 INFO - PROCESS | 1884 | RSS: Main: 287342592 05:05:51 INFO - PROCESS | 1884 | 05:05:55 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 05:05:55 INFO - PROCESS | 1884 | RSS: Main: 375447552 05:05:55 INFO - PROCESS | 1884 | 05:05:57 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 05:05:58 INFO - PROCESS | 1884 | RSS: Main: 278544384 05:05:58 INFO - PROCESS | 1884 | 05:06:00 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:01 INFO - PROCESS | 1884 | RSS: Main: 282435584 05:06:01 INFO - PROCESS | 1884 | 05:06:04 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:04 INFO - PROCESS | 1884 | RSS: Main: 321777664 05:06:04 INFO - PROCESS | 1884 | 05:06:07 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:08 INFO - PROCESS | 1884 | RSS: Main: 321671168 05:06:08 INFO - PROCESS | 1884 | 05:06:10 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 05:06:11 INFO - PROCESS | 1884 | RSS: Main: 321339392 05:06:11 INFO - PROCESS | 1884 | 05:06:13 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:13 INFO - PROCESS | 1884 | RSS: Main: 297570304 05:06:13 INFO - PROCESS | 1884 | 05:06:15 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:16 INFO - PROCESS | 1884 | RSS: Main: 303460352 05:06:16 INFO - PROCESS | 1884 | 05:06:18 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:19 INFO - PROCESS | 1884 | RSS: Main: 300806144 05:06:19 INFO - PROCESS | 1884 | 05:06:22 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:22 INFO - PROCESS | 1884 | RSS: Main: 317464576 05:06:22 INFO - PROCESS | 1884 | 05:06:25 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:26 INFO - PROCESS | 1884 | RSS: Main: 313741312 05:06:26 INFO - PROCESS | 1884 | 05:06:27 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 05:06:28 INFO - PROCESS | 1884 | RSS: Main: 357199872 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | __start_tp_report 05:06:28 INFO - PROCESS | 1884 | _x_x_mozilla_page_load 05:06:28 INFO - PROCESS | 1884 | _x_x_mozilla_page_load_details 05:06:28 INFO - PROCESS | 1884 | |i|pagename|runs| 05:06:28 INFO - PROCESS | 1884 | |0;ai-astar;110;110;114;109;111;109;110;110;111;121 05:06:28 INFO - PROCESS | 1884 | |1;audio-beat-detection;145;117;129;187;136;135;127;107;162;106 05:06:28 INFO - PROCESS | 1884 | |2;audio-dft;184;180;182;181;183;177;181;180;179;182 05:06:28 INFO - PROCESS | 1884 | |3;audio-fft;75;74;78;171;58;58;57;60;145;57 05:06:28 INFO - PROCESS | 1884 | |4;audio-oscillator;83;83;137;71;72;85;117;70;70;118 05:06:28 INFO - PROCESS | 1884 | |5;imaging-gaussian-blur;123;129;116;84;85;83;87;83;86;83 05:06:28 INFO - PROCESS | 1884 | |6;imaging-darkroom;96;96;96;95;95;94;95;95;94;95 05:06:28 INFO - PROCESS | 1884 | |7;imaging-desaturate;84;86;83;85;84;84;83;83;84;83 05:06:28 INFO - PROCESS | 1884 | |8;json-parse-financial;53;53;54;53;53;53;53;54;55;53 05:06:28 INFO - PROCESS | 1884 | |9;json-stringify-tinderbox;64;64;68;70;70;74;68;68;67;69 05:06:28 INFO - PROCESS | 1884 | |10;stanford-crypto-aes;84;84;101;105;104;81;84;82;86;83 05:06:28 INFO - PROCESS | 1884 | |11;stanford-crypto-ccm;141;152;149;135;152;132;155;152;176;138 05:06:28 INFO - PROCESS | 1884 | |12;stanford-crypto-pbkdf2;166;166;162;168;168;166;164;167;169;167 05:06:28 INFO - PROCESS | 1884 | |13;stanford-crypto-sha256-iterative;67;66;67;67;67;67;65;66;66;66 05:06:28 INFO - PROCESS | 1884 | __end_tp_report 05:06:28 INFO - PROCESS | 1884 | __start_cc_report 05:06:28 INFO - PROCESS | 1884 | _x_x_mozilla_cycle_collect,2041 05:06:28 INFO - PROCESS | 1884 | __end_cc_report 05:06:28 INFO - PROCESS | 1884 | __startTimestamp1473422788122__endTimestamp 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | ------- Summary: start ------- 05:06:28 INFO - PROCESS | 1884 | Number of tests: 14 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#0] ai-astar Cycles:10 Average:111.50 Median:110.50 stddev:3.63 (3.3%) stddev-sans-first:3.81 05:06:28 INFO - PROCESS | 1884 | Values: 110.0 110.0 114.0 109.0 111.0 109.0 110.0 110.0 111.0 121.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:135.50 stddev:24.91 (18.4%) stddev-sans-first:26.16 05:06:28 INFO - PROCESS | 1884 | Values: 145.0 117.0 129.0 187.0 136.0 135.0 127.0 107.0 162.0 106.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#2] audio-dft Cycles:10 Average:180.90 Median:181.50 stddev:2.02 (1.1%) stddev-sans-first:1.81 05:06:28 INFO - PROCESS | 1884 | Values: 184.0 180.0 182.0 181.0 183.0 177.0 181.0 180.0 179.0 182.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#3] audio-fft Cycles:10 Average:83.30 Median:59.00 stddev:40.67 (68.9%) stddev-sans-first:43.03 05:06:28 INFO - PROCESS | 1884 | Values: 75.0 74.0 78.0 171.0 58.0 58.0 57.0 60.0 145.0 57.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:71.50 stddev:24.33 (34.0%) stddev-sans-first:25.65 05:06:28 INFO - PROCESS | 1884 | Values: 83.0 83.0 137.0 71.0 72.0 85.0 117.0 70.0 70.0 118.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:83.50 stddev:18.77 (22.5%) stddev-sans-first:17.16 05:06:28 INFO - PROCESS | 1884 | Values: 123.0 129.0 116.0 84.0 85.0 83.0 87.0 83.0 86.0 83.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 05:06:28 INFO - PROCESS | 1884 | Values: 96.0 96.0 96.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 05:06:28 INFO - PROCESS | 1884 | Values: 84.0 86.0 83.0 85.0 84.0 84.0 83.0 83.0 84.0 83.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 05:06:28 INFO - PROCESS | 1884 | Values: 53.0 53.0 54.0 53.0 53.0 53.0 53.0 54.0 55.0 53.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:2.94 (4.3%) stddev-sans-first:2.69 05:06:28 INFO - PROCESS | 1884 | Values: 64.0 64.0 68.0 70.0 70.0 74.0 68.0 68.0 67.0 69.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:83.50 stddev:9.75 (11.7%) stddev-sans-first:10.15 05:06:28 INFO - PROCESS | 1884 | Values: 84.0 84.0 101.0 105.0 104.0 81.0 84.0 82.0 86.0 83.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:152.00 stddev:12.72 (8.4%) stddev-sans-first:13.22 05:06:28 INFO - PROCESS | 1884 | Values: 141.0 152.0 149.0 135.0 152.0 132.0 155.0 152.0 176.0 138.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:167.00 stddev:2.06 (1.2%) stddev-sans-first:2.18 05:06:28 INFO - PROCESS | 1884 | Values: 166.0 166.0 162.0 168.0 168.0 166.0 164.0 167.0 169.0 167.0 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - PROCESS | 1884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:06:28 INFO - PROCESS | 1884 | Values: 67.0 66.0 67.0 67.0 67.0 67.0 65.0 66.0 66.0 66.0 05:06:28 INFO - PROCESS | 1884 | -------- Summary: end -------- 05:06:28 INFO - PROCESS | 1884 | 05:06:28 INFO - TEST-INFO | 1884: exit 0 05:06:28 INFO - TEST-OK | kraken | took 58985ms 05:06:28 INFO - SUITE-END | took 1175s 05:06:29 INFO - Completed test suite (00:19:36) 05:06:29 INFO - javascript benchmark 05:06:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2944.6466424029113, 3345.364380767655, 3359.7816141950757, 3401.489776533518, 3434.8969530914064, 4695.17834378984, 5589.329280486348, 5674.829755107348, 5784.450477204664, 5794.159846822208, 5687.0, 5753.856153596163, 5761.567882408825, 5762.366139724627, 5847.941520584793, 5195.532402083812, 5245.26566280721, 5247.580193584504, 5258.710770907618, 5286.259923610698, 5203.895922081575, 5211.817586384477, 5212.817551385702, 5216.347956505437, 5217.008768334004, 5188.662736922088, 5199.532042116209, 5200.531952124308, 5214.322138122039, 5214.58283337334, 5272.472752724716, 5292.550133238679, 5303.390110137345, 5314.0, 5355.571554275688, 5125.0, 5130.3074084998425, 5143.794248230066, 5172.0, 5188.9740551297, 5646.181303710939, 5717.571182161355, 5718.399568045378, 5740.971295143498, 5803.883922321572, 6247.937520624827, 6255.78104766331, 6257.186565746424, 6264.7807326743805, 6266.49868010558, 6096.526685943581, 6209.875802483925, 6227.676799746022, 6265.530085243625, 6291.1506946562085, 5803.47768700819, 5819.563532735062, 5834.5624078194305, 5868.2664666916635, 5883.764649414061, 6250.968745156245, 6262.906056409158, 6264.686765661699, 6264.718087686065, 6269.247690277105, 6056.424639659225, 6058.351068843514, 6107.0, 6147.877042459126, 6189.102580125947, 6171.537134714914, 6228.813135605939, 6244.375562443719, 6302.495800336053, 6306.369363063749, 6175.2898416681755, 6236.937630623635, 6242.219722534684, 6245.875082498324, 6268.435840774352, 6104.938950610526, 6134.570580059442, 6135.141080248769, 6247.750089996349, 6249.468795152372, 4895.192293271571, 4904.901901961941, 4912.72979986097, 4913.041956818458, 4929.186684197139, 4235.661147108224, 4423.336499525097, 4461.709988850715, 4479.193745125844, 4522.570355816192, 5780.364159942403, 5788.27646544182, 5789.594728369058, 5793.333766616809, 5802.593818432669, 6156.507479401637, 6236.719347629368, 6238.750449982041, 6252.062190671436, 6259.499240060784, 5345.893082138336, 5619.494245517923, 5672.461116193955, 5700.942990570041, 5755.6834374108985, 5095.770690318945, 5431.646942948696, 5431.728413579305, 5442.346918369821, 5454.209139674725, 6299.937000629935, 6347.365263473615, 6352.968235158887, 6369.20384951881, 6443.645599491885, 6126.334466363025, 6177.7837775677635, 6197.659128747962, 6222.284437289589, 6231.781887633911, 6330.746770129143, 6342.429181373698, 6359.427651511386, 6360.236771587439, 6602.570832895846, 6192.473639740492, 6209.130721698875, 6214.751409943552, 6221.222347206599, 6223.937760622336, 5193.37679478465, 6132.04958718918, 6159.784407545893, 6166.075088736546, 6243.719032643633, 6113.081058499921, 6126.448619624255, 6131.866048757656, 6134.907976380268, 6135.785247516315, 6096.0, 6117.204763380732, 6117.663528505975, 6133.570650054453, 6140.846478837886, 4992.725400102884, 5842.094475356326, 5878.382769809279, 5966.403359663999, 5995.280566332068, 6100.420460056288, 6125.124131082423, 6146.477549408171, 6148.600340977822, 6164.229471316085, 5999.970000149971, 6010.789622363372, 6017.127516510169, 6017.518598512021, 6022.066579680157], "value": 5695.918230112035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.3914988814318, 492.4189456441399, 526.4524894110124, 536.5787856532625, 544.6840832317256, 30575.847120764392, 31351.745930162793, 32609.510857337158, 32633.0, 32741.508877366858, 33514.0, 42091.789541052254, 43419.565804341946, 43439.78280108595, 45732.771336143276, 9771.120599146057, 9880.209583233323, 9903.25725570585, 9904.653337133203, 9934.403935763841, 9774.218062555014, 9885.110340069392, 9887.901120988807, 9918.553665085052, 9918.652847150352, 8291.709790157345, 8677.95661021694, 8801.515916624583, 8970.910290897105, 8979.595918183664, 11815.704607384841, 11989.10081743864, 12016.279023258588, 12281.508739650493, 12296.815547766791, 11984.340861252627, 12021.338826364547, 12032.639020829301, 12036.976856967169, 12043.879561204363, 40628.79685601553, 40882.79558602188, 40909.590904090874, 40996.795016025026, 41068.1786364274, 3304.240024794287, 3312.4865645824934, 3401.7448691348, 3560.394732895414, 3584.408572585546, 30483.0, 30970.690293097006, 31772.523412148836, 31808.840955795073, 31927.840360798047, 3189.3106396516396, 3233.805971641709, 3280.0815771583993, 3300.9601975377677, 3380.8140552269615, 375920.0, 376564.0, 376902.0, 377306.0, 380665.0, 60462.79074418487, 60487.0, 60905.0, 60981.695091524256, 61000.0, 63360.36639633545, 64000.03999940005, 64021.0, 64089.0, 64140.0, 16193.02841829494, 16383.918080409521, 16404.671906562042, 16405.67188656244, 16417.93283436573, 12684.0, 12736.80894786579, 12739.108262421541, 12766.17019893704, 12783.424745886457, 16344.509664710078, 16992.150392480326, 17006.659866802594, 17009.489715308562, 17106.828931710774, 5544.445555444504, 6145.7708458307625, 6688.83277918056, 6697.22981857083, 6828.863422731518, 824.7525742277413, 845.8519759042143, 902.1700035966795, 924.3852837862746, 938.1416004355938, 32085.51871721926, 32583.51124733131, 32837.507437388456, 33919.32161356759, 34456.82771586126, 1031.4275577054807, 1036.8237399642078, 1104.5195340027115, 1140.9389267980857, 1151.5681619392728, 15352.616184595474, 15540.68918621644, 15787.894847360574, 15880.126593037494, 16210.351585936667, 679479.0, 693688.0, 693692.0630793729, 696610.0, 698862.0, 58824.82350352969, 59295.0, 59402.0, 59410.40589594049, 59484.40515594875, 1258.6098309524077, 1387.569853345466, 1397.7623803953352, 1426.1300606630155, 1426.522115091456, 29956.95150669716, 30377.848110759303, 31543.0, 31738.88913888003, 32281.838590806896, 52297.73851130872, 52565.68585785386, 52737.7363113182, 52830.0, 52982.73508632432, 576866.0, 584330.861802605, 585052.5231616873, 585161.0, 585708.0, 42917.78541107274, 43439.56560434355, 43524.12951741011, 43743.78128109339, 44652.55347446484, 44805.0, 47666.0, 48770.26844597263, 49151.75424122856, 49227.26159107545, 39273.0, 39566.60433395629, 39606.40590391204, 40480.59519404768, 40886.38670419886, 36617.08457288589, 38568.0, 39840.80477585677, 40623.0, 41207.79396103, 38017.809910950265, 38257.23485530329, 38464.423033653955, 38941.415878761276, 39149.412758808074, 28604.85697571499, 33130.006099817045, 33876.83061584676, 35328.0, 35368.646313536534, 21366.572668546854, 25020.0, 25813.0, 26023.869880650476, 26228.73771262263], "value": 20300.163102314305, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.90847833802377, 370.6090074970906, 376.09549034571853, 386.3798603241798, 407.6086956521739, 15247.923760381196, 15415.997960132598, 19763.0, 20486.2829800957, 20534.075966581502, 19179.0, 19648.312309069148, 19986.60026799467, 20575.588488230227, 20623.96880155994, 5400.945990540104, 5495.53287970521, 5574.749136288857, 5589.776408943658, 6044.788432404866, 3896.8051597420017, 6036.15493830864, 6149.600275982069, 6152.815415537541, 6155.90766138506, 5865.8826823463505, 6134.938650613503, 6142.723577439026, 6208.565400421972, 6214.228944750747, 5919.881602367928, 6147.907781383283, 6181.6600086995195, 6184.84537886552, 6196.132541444202, 5998.530360061769, 5998.670073145975, 5999.400059994009, 6011.909821352683, 6015.969920150415, 13257.0057245706, 16937.40719074839, 19257.61484770311, 24580.877095614585, 24854.502909941883, 2073.792620737929, 2105.389437063265, 2221.6334304839684, 2266.9546609067725, 2886.2891347579734, 9919.107280344731, 9956.402615843073, 10002.59989600415, 10374.17006639467, 10507.159427245802, 1792.9910350448295, 1824.8540116790625, 1836.0, 1839.5309196155029, 1875.0624687656173, 83461.0, 104280.0, 104631.0, 110436.0, 118970.40514797371, 9265.861012084824, 11149.275297105825, 11270.0, 11579.305241685357, 11652.41737913101, 14389.928050359891, 14412.783808242884, 14425.134491930517, 14430.422783088768, 14431.42274309016, 8219.383546233938, 8469.576521173916, 8503.937007874016, 8609.062960833888, 8610.138986101465, 8325.129799067614, 8366.832663346699, 8386.8322633547, 8526.275266602408, 8595.097514760984, 3812.504374431306, 4365.345198220292, 4469.709468884512, 4482.910341793146, 4555.63554915606, 1878.7181922711702, 1895.478743345591, 1905.9428217153506, 1911.120884393167, 1918.5011896906906, 709.7728726807476, 762.4777027735907, 794.0, 794.0110024388869, 947.625687853294, 16565.546592765026, 18858.434246972614, 19045.85724856513, 21348.14607415686, 21399.786002140092, 893.8078313162571, 905.3843386497114, 905.7735566108473, 913.1005959130251, 930.8231436027269, 8757.766769473743, 10793.514291856885, 11286.984171424447, 11293.887061129448, 11331.433428328715, 561347.0, 577694.0, 608575.9571202116, 609160.0, 610218.0, 132116.0, 133475.0, 135146.0, 136661.0, 140433.8934915977, 940.1585580905188, 966.2752935298527, 993.3295025857661, 993.6373223773415, 994.5773046455228, 16221.756673649668, 18453.955097408776, 18885.71671424957, 18969.715454268473, 19038.238470461027, 47238.76380618075, 47370.76314618405, 50519.49480505148, 55708.0, 56029.719851400485, 78819.0, 79269.20730792618, 79806.0, 81386.18613814023, 84662.57668711618, 7137.964310178623, 7334.596597186993, 7473.663685134074, 7474.140473845578, 7679.808004799701, 12562.811557826823, 13027.348632568523, 13129.934350328187, 13328.40022198984, 13469.461221551028, 9333.57998890038, 11089.33463992163, 11454.770904582028, 11507.309561426342, 11826.940865295619, 11407.37259450705, 11587.246828956091, 11701.648950531498, 11791.941040294743, 11869.76260474803, 11319.490622921823, 11423.885761142283, 11836.70408239801, 11882.346470943836, 11941.52233910634, 6075.453209211192, 7393.112826460644, 7482.850342993219, 7549.0, 7671.808204794925, 10142.340747851365, 10412.32319899204, 10430.739231519272, 11690.0, 11765.352905589933], "value": 9344.52654266668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.5970417839271, 1550.1474189195942, 1750.2473936207425, 1868.2246867549968, 1898.1932678611595, 7066.293370662937, 8301.0, 8853.203211710945, 8862.069482704304, 8868.778280542982, 7195.712171513133, 7698.384129269659, 7907.486013409139, 8364.163583641634, 8598.22615964563, 2064.8451366147524, 2376.477175021497, 2415.5168966206743, 2415.867127307997, 2422.236995346469, 2349.9765002349927, 2378.6550950112223, 2423.5395274897714, 2425.260295609838, 2431.5623187826272, 1982.5836574319337, 2390.2112302940077, 2403.9399015024587, 2414.022320960014, 2416.9637455438096, 2369.052379048377, 2380.2264264114233, 2383.2731017039796, 2385.8807059647033, 2414.2998530426157, 2370.134900761227, 2388.9283321500384, 2394.078279862248, 2396.029608008759, 2396.400899775056, 8747.300215982707, 8776.0, 8844.778880527974, 8869.46783193004, 8870.645174193025, 5180.093483640386, 5336.893262134736, 5340.91988620171, 5347.652402593819, 5353.277307563507, 3646.4894914711963, 3652.981735091334, 3720.572134204574, 3721.1999420124803, 3725.497057897176, 934.2992755433424, 1104.5636973395544, 1107.379867274329, 1121.4616983847718, 1134.1323887226279, 11513.0, 11620.418979051097, 11622.07023438123, 11648.825267620992, 11658.475368608433, 4475.731456112644, 4654.301854721819, 4747.335373047776, 4773.856784296477, 4775.2359622460235, 9852.556634951445, 9859.950700246452, 9865.950670246746, 9881.0, 9891.060349266952, 5304.443033481429, 5308.124159513714, 5311.070562651597, 5313.149896016619, 5317.255584218213, 4358.564143585616, 4482.260427029503, 4699.154152252628, 4774.904501909942, 4890.290907818347, 3827.6937844972335, 3843.8270277837005, 3943.8225279862477, 3976.721629485966, 4033.253848038122, 1295.112847699329, 1302.9739405211842, 1304.1848844472204, 1313.8817506424468, 1314.90795644304, 831.1543700227659, 845.8158577990862, 906.619219927632, 910.8406028944908, 941.5339406993583, 5197.818076367309, 5584.636998595079, 5853.619514731528, 5913.76344946206, 5924.0, 789.2738680414033, 924.8057907839294, 928.5821380378857, 932.785459344341, 994.472929347447, 3794.2032173243374, 3821.407681809324, 3838.405047217686, 3904.72666913319, 3966.2067586482817, 9594.328397012281, 10841.78316433667, 10859.565617375374, 10875.728106797393, 10876.61931832398, 10714.678559643224, 10730.034296913314, 10796.974287442681, 10820.13438924884, 10821.621243256448, 5978.611390259706, 6812.523123381316, 8170.632321545545, 8172.141925097898, 8185.836283274301, 5842.357340692605, 5938.168656388196, 5980.37206093354, 6010.4891084258325, 6045.637261764308, 9336.906630933603, 9746.308443406253, 10006.749831253986, 10093.293469457067, 10143.746406339606, 9953.651622193478, 10164.237682173718, 10167.593296268362, 10235.795284094425, 10303.330283531546, 6593.736250549924, 6855.931440685529, 7373.963130184315, 7432.3682486987045, 7518.586477743776, 8159.83680326402, 8314.376421768513, 8340.874886876823, 8342.0, 8349.874751878848, 7296.160941491797, 7390.889136663062, 7393.852122957618, 7509.9249007509225, 7529.736459223901, 7263.600501972231, 7506.699732010658, 7528.887066694114, 7544.773656790305, 7750.99237099196, 6654.367835055662, 6831.351021652935, 6853.417459515997, 6930.168379794457, 6930.61881596517, 4996.875078123076, 5089.618278629044, 5095.566876815512, 5144.0997825381155, 5157.535821776059, 4321.935170972375, 4930.7534623267975, 5087.491250874883, 5123.205903085028, 5127.564157046693], "value": 4567.758529429365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.08927316321797, 308.07270116947984, 313.1654141712337, 314.33518109199053, 316.15901701474075, 4411.823527058914, 5212.452692467288, 5238.10952138136, 5287.709175995324, 5303.886183901385, 4274.935875961863, 4397.648188144949, 4863.440704319004, 4948.604111671058, 5150.22746588012, 3491.5810102787636, 3867.149227170018, 3944.4477773111644, 4037.1925614876995, 4045.919081618366, 3051.7711171662213, 3360.286254010448, 3983.5618082010956, 4012.699047571429, 4027.7180597358197, 3680.7055435565226, 3777.6033516480784, 3951.9802400988096, 3968.1666849961543, 3979.0, 3456.222349971249, 3599.892003239907, 3856.5564960029674, 3952.980235098835, 3999.1601763629674, 3276.262840860787, 3449.9827500862584, 3456.0, 3461.0, 3470.861165553375, 4509.7970591323465, 5052.368453943257, 5055.469175736532, 5075.822346217901, 5083.87290317745, 4467.0, 4496.797644106023, 4501.572350626685, 4504.639628829718, 4528.547145285478, 5419.756110975016, 5443.972780136113, 5447.809326673548, 5477.808876449412, 5487.396386397493, 3789.9344857052974, 3793.336166170937, 3793.506844110276, 3814.7329686921926, 3839.3856982882603, 5376.354837419495, 5650.491455768959, 5685.749135190252, 5755.22304488897, 5779.844031193778, 3483.6168021517615, 3757.9812100939866, 3879.80600969956, 3883.262180185756, 3883.359245724424, 3306.9007929762147, 3711.740178187555, 3944.881653550398, 3950.170464202492, 3967.8573570272306, 3413.9829300853335, 4034.7693953343924, 4195.958040419557, 4223.472065991751, 4519.864404067883, 4562.133194692998, 5462.016836969384, 5479.137093388267, 5532.0, 5704.117641178401, 1103.7130346110068, 1227.5085770788357, 1334.7463981843418, 1335.0, 1335.1774827360582, 822.9465084769471, 833.6832003838502, 863.8013256950936, 889.7286327669993, 927.5918595817953, 4960.082384758759, 4963.337282010567, 4974.950250497449, 4986.6010719143105, 5009.9729555441045, 5118.744062796845, 5268.7839039350765, 5469.398366179717, 5526.944730552643, 5583.888322233533, 4213.789310534461, 4365.934510982338, 4604.0, 4875.975620121948, 4955.529224723646, 2918.941621167607, 2931.2818359502057, 2941.6911224321566, 2947.5556977081505, 2957.896473623413, 4602.792874320664, 4740.691855029412, 4846.975765121152, 5365.980463711882, 5731.398203188605, 4256.59562341577, 4870.439899411542, 5174.421801350549, 5185.496206100264, 5343.49236822509, 5701.543876489871, 5872.911906321408, 5925.822225333247, 6024.548158888101, 6031.517478601789, 5474.616776825584, 5689.260396148474, 5760.481556659921, 5825.863956528437, 5838.474537291664, 5582.748776305158, 5583.106702927512, 5597.188407680782, 5611.961787069406, 5638.295213098363, 4924.261360795909, 5892.587518873809, 5908.970455147869, 5940.287165540163, 5956.463918247378, 3585.946210806892, 3681.4293784463453, 3751.699864010818, 3793.962060379361, 3840.2703486337505, 4964.404271487445, 5010.49895010496, 5647.548196144381, 5652.0, 5667.971660141673, 5498.752556135064, 5504.256925315031, 5515.696636685021, 5520.751566179451, 5524.447555244604, 5245.606579506476, 5462.481064298885, 5496.5053145217125, 5527.419620939743, 5531.1426728857095, 4568.908621827612, 4749.596284315872, 4869.956277326671, 5377.919331210113, 5434.592405569677, 4355.673324500612, 5407.513323800877, 5582.692951887685, 5593.356763972195, 5610.438956104357, 4731.195696731495, 5408.972955135357, 5411.107167317348, 5417.295751552273, 5455.5450047478], "value": 3982.050626889831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.7319985405911, 685.9657017149148, 721.8270310745042, 776.3401109057298, 801.7314199743086, 11875.584354547582, 13428.0, 14209.218492982882, 16179.948303360288, 16197.676046479064, 15209.163496007715, 15237.314320855561, 15471.5358539244, 16270.83729162708, 16319.184040797942, 872.9039805621377, 907.1382186922417, 913.8674892140635, 913.8811954445913, 919.103873723118, 707.130229817325, 725.0574253470494, 732.088549755555, 733.7798660401885, 873.0047745570055, 933.551895090357, 940.5673390240497, 945.2768631996528, 947.2516711797706, 957.4016239850093, 939.9295052871062, 942.88213973253, 943.9244860411151, 947.8056998315398, 951.6241084771546, 705.728294606575, 706.4524993130365, 706.6254884911006, 709.120690343975, 715.3526058916689, 15415.152166630944, 15532.844671553254, 15546.76679849803, 15577.688446231012, 15584.532464025984, 11696.883031169664, 14160.079594826304, 14270.714585708332, 14293.428262869473, 14494.855051449456, 11765.411729413496, 11880.227785193934, 12006.399680016051, 12020.218685785396, 12531.248125112523, 3738.607446218135, 3757.643023912724, 3848.8460461581503, 3849.2301539692176, 3850.172212974224, 115267.0, 116382.25426618608, 117854.0, 118961.0, 120027.0, 10302.793944121076, 11015.7190486334, 11021.559137634405, 11088.611898583511, 11455.369954652408, 18477.7228341575, 22572.322830315115, 22597.661035084486, 22605.09579616797, 22625.2081177158, 7455.254474552501, 7459.403247740168, 7542.811429714191, 7549.169591344948, 7729.961350193325, 4347.500037495665, 4359.629431498295, 4383.276759334738, 4436.977815110904, 4459.888502787457, 3328.350971560571, 3487.442009278503, 3548.4677298405445, 3863.5318578939823, 4025.3358195897936, 702.0522294901943, 706.5266271598042, 709.7764204275637, 716.2443621978758, 719.7548241542162, 574.2391331485798, 605.5609682979805, 606.8543549548165, 612.7273363353354, 665.171861033017, 9031.683891063782, 9241.953790231006, 9311.953440232755, 9486.118963311292, 9929.602815887283, 566.6316894018921, 654.9115869357671, 655.1777519213357, 664.3190729502298, 668.882945484548, 4130.690198235085, 4315.956840431619, 4370.453693288339, 4730.5032971538185, 4758.357621721093, 90805.0, 117840.41079794717, 153294.0, 164869.0, 173129.26870731384, 143816.0, 147437.0, 148057.25971370074, 149017.50982490252, 153912.2304388471, 124269.0, 126121.0, 126501.0, 127329.3633531845, 130005.34997324953, 8841.469511829311, 8951.820963580562, 8961.686340978034, 9109.134632209929, 9166.22087122602, 62452.687736562846, 67250.11561239864, 68365.65817170883, 70230.29769702238, 71262.0, 88982.0, 101037.0, 103110.48444757728, 104436.0, 110709.0, 11479.4260286987, 11956.701082473008, 12029.518819247132, 12390.5663301784, 12469.0, 12294.0, 12861.935690321488, 13054.477820887058, 13104.868951310365, 13146.60560183196, 13536.932315338361, 13764.105333153313, 13769.449222031006, 13915.539850178986, 13977.231252281223, 13168.60494185176, 13252.337383130998, 13534.255615940823, 13656.863431365558, 13676.521321753691, 13029.47882084706, 13278.53525126616, 13432.798508022192, 13437.529686460926, 13662.248576328397, 11129.443527823414, 11270.370315014256, 11431.428428578703, 11445.656630301104, 11935.582254621047, 8057.073436554637, 9872.753181170241, 10385.0, 11353.432328383713, 11586.826197606873], "value": 7903.179378725574, "unit": "score"}], "name": "dromaeo_css", "value": 7331.846323912029, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 114.0, 109.0, 111.0, 109.0, 110.0, 110.0, 111.0, 121.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 129.0, 187.0, 136.0, 135.0, 127.0, 107.0, 162.0, 106.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 180.0, 182.0, 181.0, 183.0, 177.0, 181.0, 180.0, 179.0, 182.0], "value": 180.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 171.0, 58.0, 58.0, 57.0, 60.0, 145.0, 57.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 137.0, 71.0, 72.0, 85.0, 117.0, 70.0, 70.0, 118.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 116.0, 84.0, 85.0, 83.0, 87.0, 83.0, 86.0, 83.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 85.0, 84.0, 84.0, 83.0, 83.0, 84.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 70.0, 70.0, 74.0, 68.0, 68.0, 67.0, 69.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 101.0, 105.0, 104.0, 81.0, 84.0, 82.0, 86.0, 83.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 152.0, 149.0, 135.0, 152.0, 132.0, 155.0, 152.0, 176.0, 138.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 162.0, 168.0, 168.0, 166.0, 164.0, 167.0, 169.0, 167.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1468.2, "alertThreshold": 2.0}]} 05:06:29 INFO - Return code: 0 05:06:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:06:29 INFO - # TBPL SUCCESS # 05:06:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:29 INFO - 2016-09-09 05:06:29.426 screenresolution[1894:10834] starting screenresolution argv=screenresolution get 05:06:29 INFO - 2016-09-09 05:06:29.429 screenresolution[1894:10834] Display 0: 1600x1200x32@60 05:06:29 INFO - 2016-09-09 05:06:29.435 screenresolution[1895:10837] starting screenresolution argv=screenresolution list 05:06:29 INFO - Available Modes on Display 0 05:06:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:29 INFO - Intel Iris: 05:06:29 INFO - Chipset Model: Intel Iris 05:06:29 INFO - Type: GPU 05:06:29 INFO - Bus: Built-In 05:06:29 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:29 INFO - Vendor: Intel (0x8086) 05:06:29 INFO - Device ID: 0x0a2e 05:06:29 INFO - Revision ID: 0x0009 05:06:29 INFO - Displays: 05:06:29 INFO - Display: 05:06:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:29 INFO - Display Serial Number: 1600x1200 60 05:06:29 INFO - Main Display: Yes 05:06:29 INFO - Mirror: Off 05:06:29 INFO - Online: Yes 05:06:29 INFO - Rotation: Supported 05:06:29 INFO - Return code: 0 05:06:29 INFO - Running post-action listener: _resource_record_post_action 05:06:29 INFO - [mozharness: 2016-09-09 12:06:29.675891Z] Finished run-tests step (success) 05:06:29 INFO - Running post-run listener: _resource_record_post_run 05:06:29 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 33254400; Write bytes: 712694272; Read time: 316; Write time: 1988 05:06:29 INFO - TinderboxPrint: CPU usage
53.7% 05:06:29 INFO - TinderboxPrint: I/O read bytes / time
33,254,400 / 316 05:06:29 INFO - TinderboxPrint: I/O write bytes / time
712,694,272 / 1,988 05:06:29 INFO - TinderboxPrint: CPU idle
2,239.5 (46.3%) 05:06:29 INFO - TinderboxPrint: CPU system
974.1 (20.1%) 05:06:29 INFO - TinderboxPrint: CPU user
1,627.8 (33.6%) 05:06:29 INFO - TinderboxPrint: Swap in / out
435,347,456 / 0 05:06:29 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 388090368; Write bytes: 386645504; Read time: 28198; Write time: 784 05:06:29 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 32267264; Write bytes: 299809792; Read time: 300; Write time: 1153 05:06:30 INFO - Running post-run listener: _upload_blobber_files 05:06:30 INFO - Blob upload gear active. 05:06:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:30 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 05:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:06:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:31 INFO - (blobuploader) - INFO - Done attempting. 05:06:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:06:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:06:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:32 INFO - (blobuploader) - INFO - Done attempting. 05:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:35 INFO - (blobuploader) - INFO - Done attempting. 05:06:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:35 INFO - Return code: 0 05:06:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca7efa0e7e738267fc3fa5d7ecdcda5c70aae99c03ebdd6e1233cc05401a5493f650c637f9215ecc86734dc549f99d81b5108fcf9334f6bb8d968bb99277052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a16885f74b93c7ea4d2cde2c105efe8efbd0cab6ae127deac26d5ea1e6fd4bdcabc24831b48e8e6e7eaa7ddfb6ef0c18eff0c2b150c207a406157e35bb6ec536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/677020dbc2f19b6fd0f9c0e80e9317fcde76f11cdcf0e225534cc2d4cff69a453e507818417e4c14e31e8b51390702ecbf15f50128892641725ce103f7b370dd"} 05:06:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:35 INFO - Contents: 05:06:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca7efa0e7e738267fc3fa5d7ecdcda5c70aae99c03ebdd6e1233cc05401a5493f650c637f9215ecc86734dc549f99d81b5108fcf9334f6bb8d968bb99277052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a16885f74b93c7ea4d2cde2c105efe8efbd0cab6ae127deac26d5ea1e6fd4bdcabc24831b48e8e6e7eaa7ddfb6ef0c18eff0c2b150c207a406157e35bb6ec536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/677020dbc2f19b6fd0f9c0e80e9317fcde76f11cdcf0e225534cc2d4cff69a453e507818417e4c14e31e8b51390702ecbf15f50128892641725ce103f7b370dd"} 05:06:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:35 INFO - Copying logs to upload dir... 05:06:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1335.384613 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 15 secs) (at 2016-09-09 05:06:35.187265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 05:06:35.190585) ========= 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.rtPbxDkeQR/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.2xtubkXRF7/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca7efa0e7e738267fc3fa5d7ecdcda5c70aae99c03ebdd6e1233cc05401a5493f650c637f9215ecc86734dc549f99d81b5108fcf9334f6bb8d968bb99277052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a16885f74b93c7ea4d2cde2c105efe8efbd0cab6ae127deac26d5ea1e6fd4bdcabc24831b48e8e6e7eaa7ddfb6ef0c18eff0c2b150c207a406157e35bb6ec536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/677020dbc2f19b6fd0f9c0e80e9317fcde76f11cdcf0e225534cc2d4cff69a453e507818417e4c14e31e8b51390702ecbf15f50128892641725ce103f7b370dd"} build_url:https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/BGcAVoTURV2vr_2WXt7UNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca7efa0e7e738267fc3fa5d7ecdcda5c70aae99c03ebdd6e1233cc05401a5493f650c637f9215ecc86734dc549f99d81b5108fcf9334f6bb8d968bb99277052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a16885f74b93c7ea4d2cde2c105efe8efbd0cab6ae127deac26d5ea1e6fd4bdcabc24831b48e8e6e7eaa7ddfb6ef0c18eff0c2b150c207a406157e35bb6ec536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/677020dbc2f19b6fd0f9c0e80e9317fcde76f11cdcf0e225534cc2d4cff69a453e507818417e4c14e31e8b51390702ecbf15f50128892641725ce103f7b370dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 05:06:35.224013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 05:06:35.224312) ========= 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.rtPbxDkeQR/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.2xtubkXRF7/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005339 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 05:06:35.272753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 05:06:35.273044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 05:06:35.273343) ========= ========= Total master_lag: 0.17 =========