builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0239 starttime: 1476960911.15 results: success (0) buildid: 20161020004015 builduid: 32acc0c03fed4cf2a110bc1815cfd38f revision: 95567c6551ea7dfef517e7b3f50fe0be209a3a2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.154473) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.154916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.155218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.182473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.182874) ========= 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.AaCudFw4jG/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.9IP2Vis1yC/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-20 03:55:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2016-10-20 03:55:11 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.298642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.302004) ========= 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.AaCudFw4jG/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.9IP2Vis1yC/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.024457 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.350832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:11.354212) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 95567c6551ea7dfef517e7b3f50fe0be209a3a2a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 95567c6551ea7dfef517e7b3f50fe0be209a3a2a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AaCudFw4jG/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.9IP2Vis1yC/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-20 03:55:11,359 truncating revision to first 12 chars 2016-10-20 03:55:11,359 Setting DEBUG logging. 2016-10-20 03:55:11,359 attempt 1/10 2016-10-20 03:55:11,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/95567c6551ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 03:55:12,010 unpacking tar archive at: mozilla-aurora-95567c6551ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.907325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:12.282729) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:12.286122) ========= script_repo_revision: 95567c6551ea7dfef517e7b3f50fe0be209a3a2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:12.286508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:12.286779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 03:55:12.304682) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-20 03:55:12.305047) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AaCudFw4jG/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.9IP2Vis1yC/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:12 INFO - MultiFileLogger online at 20161020 03:55:12 in /builds/slave/test 03:55:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:55:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:55:12 INFO - {'append_to_log': False, 03:55:12 INFO - 'base_work_dir': '/builds/slave/test', 03:55:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:55:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:55:12 INFO - 'branch': 'Mozilla-Aurora', 03:55:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:12 INFO - 'config_files': ('talos/mac_config.py',), 03:55:12 INFO - 'default_actions': ('clobber', 03:55:12 INFO - 'read-buildbot-config', 03:55:12 INFO - 'download-and-extract', 03:55:12 INFO - 'populate-webroot', 03:55:12 INFO - 'create-virtualenv', 03:55:12 INFO - 'install', 03:55:12 INFO - 'run-tests'), 03:55:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:12 INFO - 'download_minidump_stackwalk': True, 03:55:12 INFO - 'download_symbols': 'ondemand', 03:55:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:55:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:55:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:55:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:55:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:12 INFO - 'installer_path': 'installer.exe', 03:55:12 INFO - 'log_level': 'info', 03:55:12 INFO - 'log_name': 'talos', 03:55:12 INFO - 'log_to_console': True, 03:55:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:55:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:55:12 INFO - 'opt_config_files': (), 03:55:12 INFO - 'pip_index': False, 03:55:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:55:12 INFO - 'cmd': ('bash', 03:55:12 INFO - '-c', 03:55:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:55:12 INFO - 'enabled': True, 03:55:12 INFO - 'halt_on_failure': False, 03:55:12 INFO - 'name': 'check_screen_resolution'},), 03:55:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:55:12 INFO - 'cmd': ('bash', 03:55:12 INFO - '-c', 03:55:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:55:12 INFO - 'enabled': True, 03:55:12 INFO - 'halt_on_failure': False, 03:55:12 INFO - 'name': 'check_screen_resolution'},), 03:55:12 INFO - 'run_cmd_checks_enabled': True, 03:55:12 INFO - 'sps_profile': False, 03:55:12 INFO - 'sps_profile_interval': 0, 03:55:12 INFO - 'suite': 'dromaeojs', 03:55:12 INFO - 'system_bits': '32', 03:55:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:12 INFO - 'title': 't-yosemite-r7-0239', 03:55:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:12 INFO - 'use_talos_json': True, 03:55:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:55:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:12 INFO - 'work_dir': 'build'} 03:55:12 INFO - [mozharness: 2016-10-20 10:55:12.425523Z] Running clobber step. 03:55:12 INFO - Running pre-action listener: _resource_record_pre_action 03:55:12 INFO - Running main action method: clobber 03:55:12 INFO - rmtree: /builds/slave/test/build 03:55:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:55:14 INFO - Running post-action listener: _resource_record_post_action 03:55:14 INFO - [mozharness: 2016-10-20 10:55:14.535590Z] Finished clobber step (success) 03:55:14 INFO - [mozharness: 2016-10-20 10:55:14.535769Z] Running read-buildbot-config step. 03:55:14 INFO - Running pre-action listener: _resource_record_pre_action 03:55:14 INFO - Running main action method: read_buildbot_config 03:55:14 INFO - Using buildbot properties: 03:55:14 INFO - { 03:55:14 INFO - "project": "", 03:55:14 INFO - "product": "firefox", 03:55:14 INFO - "script_repo_revision": "production", 03:55:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:55:14 INFO - "repository": "", 03:55:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:55:14 INFO - "buildid": "20161020004015", 03:55:14 INFO - "stage_platform": "macosx64", 03:55:14 INFO - "basedir": "/builds/slave/test", 03:55:14 INFO - "nightly_build": "True", 03:55:14 INFO - "buildnumber": 96, 03:55:14 INFO - "slavename": "t-yosemite-r7-0239", 03:55:14 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:55:14 INFO - "platform": "yosemite_r7", 03:55:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:55:14 INFO - "branch": "mozilla-aurora", 03:55:14 INFO - "repo_path": "releases/mozilla-aurora", 03:55:14 INFO - "revision": "95567c6551ea7dfef517e7b3f50fe0be209a3a2a", 03:55:14 INFO - "pgo_build": "False", 03:55:14 INFO - "builduid": "32acc0c03fed4cf2a110bc1815cfd38f", 03:55:14 INFO - "slavebuilddir": "test" 03:55:14 INFO - } 03:55:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:55:14 INFO - Running post-action listener: _resource_record_post_action 03:55:14 INFO - [mozharness: 2016-10-20 10:55:14.539270Z] Finished read-buildbot-config step (success) 03:55:14 INFO - [mozharness: 2016-10-20 10:55:14.539398Z] Running download-and-extract step. 03:55:14 INFO - Running pre-action listener: _resource_record_pre_action 03:55:14 INFO - Running main action method: download_and_extract 03:55:14 INFO - mkdir: /builds/slave/test/build/tests 03:55:14 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')]} 03:55:14 INFO - trying https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:55:14 INFO - Downloading https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:55:15 INFO - Downloaded 1199 bytes. 03:55:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:55:15 INFO - Using the following test package requirements: 03:55:15 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:55:15 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:55:15 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:55:15 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'jsshell-mac.zip'], 03:55:15 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:55:15 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:55:15 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:55:15 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:55:15 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:55:15 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:55:15 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:55:15 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:55:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:55:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:55:15 INFO - Fetch https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:55:16 INFO - Expected file size: 16436312 03:55:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:55:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:55:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:55:22 INFO - Fetch https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:55:23 INFO - Expected file size: 16436312 03:55:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:55:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:55:30 INFO - Fetch https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:55:30 INFO - Expected file size: 14414081 03:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:31 INFO - trying https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:55:31 INFO - Downloading https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:55:34 INFO - Downloaded 115563639 bytes. 03:55:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:55:34 INFO - mkdir: /builds/slave/test/properties 03:55:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:55:34 INFO - Writing to file /builds/slave/test/properties/build_url 03:55:34 INFO - Contents: 03:55:34 INFO - build_url:https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:55:35 INFO - Running post-action listener: _resource_record_post_action 03:55:35 INFO - Running post-action listener: set_extra_try_arguments 03:55:35 INFO - [mozharness: 2016-10-20 10:55:35.071459Z] Finished download-and-extract step (success) 03:55:35 INFO - [mozharness: 2016-10-20 10:55:35.071627Z] Running populate-webroot step. 03:55:35 INFO - Running pre-action listener: _resource_record_pre_action 03:55:35 INFO - Running main action method: populate_webroot 03:55:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:55:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:55:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:55:35 INFO - '--tppagecycles', 03:55:35 INFO - '7'], 03:55:35 INFO - 'tests': ['tsvgm']}}, 03:55:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:55:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:55:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:55:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:55:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['damp', 'tps']}, 03:55:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'tests': ['damp', 'tps']}, 03:55:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['dromaeo_dom']}, 03:55:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['basic_compositor_video']}, 03:55:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:55:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['a11yr', 03:55:35 INFO - 'ts_paint', 03:55:35 INFO - 'tpaint', 03:55:35 INFO - 'sessionrestore', 03:55:35 INFO - 'sessionrestore_no_auto_restore', 03:55:35 INFO - 'tabpaint']}, 03:55:35 INFO - 'other-e10s': {'tests': ['a11yr', 03:55:35 INFO - 'ts_paint', 03:55:35 INFO - 'tpaint', 03:55:35 INFO - 'sessionrestore', 03:55:35 INFO - 'sessionrestore_no_auto_restore', 03:55:35 INFO - 'tabpaint']}, 03:55:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:55:35 INFO - 'ts_paint', 03:55:35 INFO - 'tpaint', 03:55:35 INFO - 'sessionrestore', 03:55:35 INFO - 'sessionrestore_no_auto_restore', 03:55:35 INFO - 'tabpaint']}, 03:55:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:55:35 INFO - 'ts_paint', 03:55:35 INFO - 'tpaint', 03:55:35 INFO - 'sessionrestore', 03:55:35 INFO - 'sessionrestore_no_auto_restore', 03:55:35 INFO - 'tabpaint']}, 03:55:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['a11yr', 03:55:35 INFO - 'ts_paint', 03:55:35 INFO - 'tpaint', 03:55:35 INFO - 'sessionrestore', 03:55:35 INFO - 'sessionrestore_no_auto_restore', 03:55:35 INFO - 'tabpaint']}, 03:55:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['a11yr', 03:55:35 INFO - 'ts_paint', 03:55:35 INFO - 'tpaint', 03:55:35 INFO - 'sessionrestore', 03:55:35 INFO - 'sessionrestore_no_auto_restore', 03:55:35 INFO - 'tabpaint']}, 03:55:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['tsvgx', 03:55:35 INFO - 'tsvgr_opacity', 03:55:35 INFO - 'tart', 03:55:35 INFO - 'tscrollx', 03:55:35 INFO - 'cart']}, 03:55:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:55:35 INFO - 'tsvgr_opacity', 03:55:35 INFO - 'tart', 03:55:35 INFO - 'tscrollx', 03:55:35 INFO - 'cart']}, 03:55:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'talos_options': ['--disable-e10s'], 03:55:35 INFO - 'tests': ['tp5o']}, 03:55:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'tests': ['tp5o']}, 03:55:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'talos_options': ['--disable-e10s', 03:55:35 INFO - '--xperf_path', 03:55:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:35 INFO - 'tests': ['tp5n']}, 03:55:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:35 INFO - 'talos_options': ['--xperf_path', 03:55:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:35 INFO - 'tests': ['tp5n']}}, 03:55:35 INFO - 'talos.zip': {'path': '', 03:55:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:55:35 INFO - Running post-action listener: _resource_record_post_action 03:55:35 INFO - [mozharness: 2016-10-20 10:55:35.090644Z] Finished populate-webroot step (success) 03:55:35 INFO - [mozharness: 2016-10-20 10:55:35.090773Z] Running create-virtualenv step. 03:55:35 INFO - Running pre-action listener: _resource_record_pre_action 03:55:35 INFO - Running main action method: create_virtualenv 03:55:35 INFO - Creating virtualenv /builds/slave/test/build/venv 03:55:35 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 03:55:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:55:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:35 INFO - Using real prefix '/tools/python27' 03:55:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:55:36 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:38 INFO - Installing pip.................done. 03:55:38 INFO - Return code: 0 03:55:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:38 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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:38 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 03:55:38 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 03:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:38 INFO - 'HOME': '/Users/cltbld', 03:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:38 INFO - 'LOGNAME': 'cltbld', 03:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:38 INFO - 'MOZ_NO_REMOTE': '1', 03:55:38 INFO - 'NO_EM_RESTART': '1', 03:55:38 INFO - 'PAGER': '/bin/cat', 03:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:38 INFO - 'PWD': '/builds/slave/test', 03:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:38 INFO - 'SHELL': '/bin/bash', 03:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:55:38 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:38 INFO - 'USER': 'cltbld', 03:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:38 INFO - 'XPC_FLAGS': '0x0', 03:55:38 INFO - 'XPC_SERVICE_NAME': '0', 03:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:39 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 03:55:39 INFO - Cleaning up... 03:55:39 INFO - Return code: 0 03:55:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:55:39 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')]} 03:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:39 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')]} 03:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:39 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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:39 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 03:55:39 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 03:55:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:55:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:39 INFO - 'HOME': '/Users/cltbld', 03:55:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:39 INFO - 'LOGNAME': 'cltbld', 03:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:39 INFO - 'MOZ_NO_REMOTE': '1', 03:55:39 INFO - 'NO_EM_RESTART': '1', 03:55:39 INFO - 'PAGER': '/bin/cat', 03:55:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:39 INFO - 'PWD': '/builds/slave/test', 03:55:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:39 INFO - 'SHELL': '/bin/bash', 03:55:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:55:39 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:55:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:39 INFO - 'USER': 'cltbld', 03:55:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:39 INFO - 'XPC_FLAGS': '0x0', 03:55:39 INFO - 'XPC_SERVICE_NAME': '0', 03:55:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:39 INFO - Downloading/unpacking psutil>=3.1.1 03:55:39 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 03:55:39 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 03:55:39 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 03:55:39 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 03:55:39 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 03:55:39 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 03:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:55:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:42 INFO - Installing collected packages: psutil 03:55:42 INFO - Running setup.py install for psutil 03:55:42 INFO - building 'psutil._psutil_osx' extension 03:55:42 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 03:55:43 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 03:55:43 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 03:55:43 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 03:55:43 INFO - building 'psutil._psutil_posix' extension 03:55:43 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 03:55:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:55:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:55:43 INFO - ^ 03:55:43 INFO - 1 warning generated. 03:55:43 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 03:55:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:43 INFO - Successfully installed psutil 03:55:43 INFO - Cleaning up... 03:55:43 INFO - Return code: 0 03:55:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:43 INFO - 'HOME': '/Users/cltbld', 03:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:43 INFO - 'LOGNAME': 'cltbld', 03:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:43 INFO - 'MOZ_NO_REMOTE': '1', 03:55:43 INFO - 'NO_EM_RESTART': '1', 03:55:43 INFO - 'PAGER': '/bin/cat', 03:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:43 INFO - 'PWD': '/builds/slave/test', 03:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:43 INFO - 'SHELL': '/bin/bash', 03:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:55:43 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:43 INFO - 'USER': 'cltbld', 03:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:43 INFO - 'XPC_FLAGS': '0x0', 03:55:43 INFO - 'XPC_SERVICE_NAME': '0', 03:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:55:46 INFO - Installing collected packages: mozsystemmonitor 03:55:46 INFO - Running setup.py install for mozsystemmonitor 03:55:46 INFO - Successfully installed mozsystemmonitor 03:55:46 INFO - Cleaning up... 03:55:46 INFO - Return code: 0 03:55:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:46 INFO - 'HOME': '/Users/cltbld', 03:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:46 INFO - 'LOGNAME': 'cltbld', 03:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:46 INFO - 'MOZ_NO_REMOTE': '1', 03:55:46 INFO - 'NO_EM_RESTART': '1', 03:55:46 INFO - 'PAGER': '/bin/cat', 03:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:46 INFO - 'PWD': '/builds/slave/test', 03:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:46 INFO - 'SHELL': '/bin/bash', 03:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:55:46 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:46 INFO - 'USER': 'cltbld', 03:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:46 INFO - 'XPC_FLAGS': '0x0', 03:55:46 INFO - 'XPC_SERVICE_NAME': '0', 03:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:50 INFO - warning: no files found matching '*.txt' 03:55:50 INFO - no previously-included directories found matching 'build' 03:55:50 INFO - no previously-included directories found matching 'dist' 03:55:50 INFO - no previously-included directories found matching '.git*' 03:55:50 INFO - Installing collected packages: jsonschema, functools32 03:55:50 INFO - Running setup.py install for functools32 03:55:50 INFO - warning: no files found matching '*.txt' 03:55:50 INFO - no previously-included directories found matching 'build' 03:55:50 INFO - no previously-included directories found matching 'dist' 03:55:50 INFO - no previously-included directories found matching '.git*' 03:55:50 INFO - Successfully installed jsonschema functools32 03:55:50 INFO - Cleaning up... 03:55:50 INFO - Return code: 0 03:55:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:50 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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:50 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 03:55:50 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 03:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:50 INFO - 'HOME': '/Users/cltbld', 03:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:50 INFO - 'LOGNAME': 'cltbld', 03:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:50 INFO - 'MOZ_NO_REMOTE': '1', 03:55:50 INFO - 'NO_EM_RESTART': '1', 03:55:50 INFO - 'PAGER': '/bin/cat', 03:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:50 INFO - 'PWD': '/builds/slave/test', 03:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:50 INFO - 'SHELL': '/bin/bash', 03:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:55:50 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:50 INFO - 'USER': 'cltbld', 03:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:50 INFO - 'XPC_FLAGS': '0x0', 03:55:50 INFO - 'XPC_SERVICE_NAME': '0', 03:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:55:50 INFO - Cleaning up... 03:55:50 INFO - Return code: 0 03:55:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:50 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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:50 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 03:55:50 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 03:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:50 INFO - 'HOME': '/Users/cltbld', 03:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:50 INFO - 'LOGNAME': 'cltbld', 03:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:50 INFO - 'MOZ_NO_REMOTE': '1', 03:55:50 INFO - 'NO_EM_RESTART': '1', 03:55:50 INFO - 'PAGER': '/bin/cat', 03:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:50 INFO - 'PWD': '/builds/slave/test', 03:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:50 INFO - 'SHELL': '/bin/bash', 03:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:55:50 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:50 INFO - 'USER': 'cltbld', 03:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:50 INFO - 'XPC_FLAGS': '0x0', 03:55:50 INFO - 'XPC_SERVICE_NAME': '0', 03:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55:53 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 03:55:53 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 03:55:53 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 03:55:53 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 03:55:53 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 03:55:53 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 03:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55:54 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 03:55:54 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 03:55:54 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 03:55:54 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 03:55:54 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 03:55:54 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 03:55:54 INFO - Downloading docopt-0.6.1.tar.gz 03:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:54 INFO - Running setup.py install for blobuploader 03:55:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:54 INFO - Running setup.py install for requests 03:55:55 INFO - Running setup.py install for docopt 03:55:55 INFO - Successfully installed blobuploader requests docopt 03:55:55 INFO - Cleaning up... 03:55:55 INFO - Return code: 0 03:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:55 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')]} 03:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:55 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')]} 03:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:55 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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:55:55 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 03:55:55 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 03:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:55 INFO - 'HOME': '/Users/cltbld', 03:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:55 INFO - 'LOGNAME': 'cltbld', 03:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:55 INFO - 'MOZ_NO_REMOTE': '1', 03:55:55 INFO - 'NO_EM_RESTART': '1', 03:55:55 INFO - 'PAGER': '/bin/cat', 03:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:55 INFO - 'PWD': '/builds/slave/test', 03:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:55 INFO - 'SHELL': '/bin/bash', 03:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:55:55 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:55 INFO - 'USER': 'cltbld', 03:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:55 INFO - 'XPC_FLAGS': '0x0', 03:55:55 INFO - 'XPC_SERVICE_NAME': '0', 03:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-NQM5co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-6F3mbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:55 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-jvrj7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-iTU0VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-eygaGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-AoptXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-dSV68u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-4MdkOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-HCc8vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-fNeiXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-hUPCll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:56 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-RUKijA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:57 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-MSi_e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:57 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-_osQcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:57 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-lytrqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:57 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-MddSd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:57 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-MGjfqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:55:57 INFO - Running setup.py install for manifestparser 03:55:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:55:57 INFO - Running setup.py install for mozcrash 03:55:57 INFO - Running setup.py install for mozdebug 03:55:57 INFO - Running setup.py install for mozdevice 03:55:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Running setup.py install for mozfile 03:55:58 INFO - Running setup.py install for mozhttpd 03:55:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Running setup.py install for mozinfo 03:55:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Running setup.py install for mozInstall 03:55:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:55:58 INFO - Running setup.py install for mozleak 03:55:58 INFO - Running setup.py install for mozlog 03:55:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Running setup.py install for moznetwork 03:55:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Running setup.py install for mozprocess 03:55:59 INFO - Running setup.py install for mozprofile 03:55:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Running setup.py install for mozrunner 03:55:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:55:59 INFO - Running setup.py install for mozscreenshot 03:55:59 INFO - Running setup.py install for moztest 03:55:59 INFO - Running setup.py install for mozversion 03:56:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:56:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:00 INFO - Cleaning up... 03:56:00 INFO - Return code: 0 03:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:00 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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:56:00 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 03:56:00 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 03:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:00 INFO - 'HOME': '/Users/cltbld', 03:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:00 INFO - 'LOGNAME': 'cltbld', 03:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:00 INFO - 'MOZ_NO_REMOTE': '1', 03:56:00 INFO - 'NO_EM_RESTART': '1', 03:56:00 INFO - 'PAGER': '/bin/cat', 03:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:00 INFO - 'PWD': '/builds/slave/test', 03:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:00 INFO - 'SHELL': '/bin/bash', 03:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:56:00 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:00 INFO - 'USER': 'cltbld', 03:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:00 INFO - 'XPC_FLAGS': '0x0', 03:56:00 INFO - 'XPC_SERVICE_NAME': '0', 03:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-vJUDOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:00 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)) 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-hHh2uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:00 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)) 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-EssF_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:00 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)) 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-dOL7LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:00 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)) 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-YZVMun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:00 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)) 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:00 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-HOgztQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-mDDAoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Vau7r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-F9uZ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-fxip2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-5diWFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-bvA75v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-FqK5j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-A9T2sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-PNeoJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:01 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)) 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:01 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-gG03Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:02 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)) 03:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:02 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-5b0Ozk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:02 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)) 03:56:02 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)) 03:56:02 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)) 03:56:02 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)) 03:56:02 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)) 03:56:02 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)) 03:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:04 INFO - Downloading blessings-1.6.tar.gz 03:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:04 INFO - Installing collected packages: blessings 03:56:04 INFO - Running setup.py install for blessings 03:56:04 INFO - Successfully installed blessings 03:56:04 INFO - Cleaning up... 03:56:05 INFO - Return code: 0 03:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:05 INFO - Reading from file tmpfile_stdout 03:56:05 INFO - Current package versions: 03:56:05 INFO - blessings == 1.6 03:56:05 INFO - blobuploader == 1.2.4 03:56:05 INFO - docopt == 0.6.1 03:56:05 INFO - functools32 == 3.2.3-2 03:56:05 INFO - jsonschema == 2.5.1 03:56:05 INFO - manifestparser == 1.1 03:56:05 INFO - mozInstall == 1.12 03:56:05 INFO - mozcrash == 0.17 03:56:05 INFO - mozdebug == 0.1 03:56:05 INFO - mozdevice == 0.48 03:56:05 INFO - mozfile == 1.2 03:56:05 INFO - mozhttpd == 0.7 03:56:05 INFO - mozinfo == 0.9 03:56:05 INFO - mozleak == 0.1 03:56:05 INFO - mozlog == 3.4 03:56:05 INFO - moznetwork == 0.27 03:56:05 INFO - mozprocess == 0.23 03:56:05 INFO - mozprofile == 0.28 03:56:05 INFO - mozrunner == 6.12 03:56:05 INFO - mozscreenshot == 0.1 03:56:05 INFO - mozsystemmonitor == 0.3 03:56:05 INFO - moztest == 0.7 03:56:05 INFO - mozversion == 1.4 03:56:05 INFO - psutil == 3.1.1 03:56:05 INFO - requests == 1.2.3 03:56:05 INFO - wsgiref == 0.1.2 03:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:05 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 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:56:05 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 03:56:05 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 03:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:05 INFO - 'HOME': '/Users/cltbld', 03:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:05 INFO - 'LOGNAME': 'cltbld', 03:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:05 INFO - 'MOZ_NO_REMOTE': '1', 03:56:05 INFO - 'NO_EM_RESTART': '1', 03:56:05 INFO - 'PAGER': '/bin/cat', 03:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:05 INFO - 'PWD': '/builds/slave/test', 03:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:05 INFO - 'SHELL': '/bin/bash', 03:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:56:05 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:05 INFO - 'USER': 'cltbld', 03:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:05 INFO - 'XPC_FLAGS': '0x0', 03:56:05 INFO - 'XPC_SERVICE_NAME': '0', 03:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 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)) 03:56:05 INFO - Cleaning up... 03:56:05 INFO - Return code: 0 03:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe10b55e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, '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.AaCudFw4jG/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.9IP2Vis1yC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:05 INFO - 'HOME': '/Users/cltbld', 03:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:05 INFO - 'LOGNAME': 'cltbld', 03:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:05 INFO - 'MOZ_NO_REMOTE': '1', 03:56:05 INFO - 'NO_EM_RESTART': '1', 03:56:05 INFO - 'PAGER': '/bin/cat', 03:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:05 INFO - 'PWD': '/builds/slave/test', 03:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:05 INFO - 'SHELL': '/bin/bash', 03:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:56:05 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:05 INFO - 'USER': 'cltbld', 03:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:05 INFO - 'XPC_FLAGS': '0x0', 03:56:05 INFO - 'XPC_SERVICE_NAME': '0', 03:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:56:05 INFO - Cleaning up... 03:56:05 INFO - Return code: 0 03:56:05 INFO - Running post-action listener: _resource_record_post_action 03:56:05 INFO - Running post-action listener: _start_resource_monitoring 03:56:05 INFO - Starting resource monitoring. 03:56:05 INFO - [mozharness: 2016-10-20 10:56:05.860454Z] Finished create-virtualenv step (success) 03:56:05 INFO - [mozharness: 2016-10-20 10:56:05.861408Z] Running install step. 03:56:05 INFO - Running pre-action listener: _resource_record_pre_action 03:56:05 INFO - Running main action method: install 03:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:06 INFO - Reading from file tmpfile_stdout 03:56:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:56:06 INFO - Reading from file tmpfile_stdout 03:56:06 INFO - Output received: 03:56:06 INFO - Usage: mozinstall [options] installer 03:56:06 INFO - Options: 03:56:06 INFO - -h, --help show this help message and exit 03:56:06 INFO - -d DEST, --destination=DEST 03:56:06 INFO - Directory to install application into. [default: 03:56:06 INFO - "/builds/slave/test"] 03:56:06 INFO - --app=APP Application being installed. [default: firefox] 03:56:06 INFO - mkdir: /builds/slave/test/build/application 03:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:56:37 INFO - Reading from file tmpfile_stdout 03:56:37 INFO - Output received: 03:56:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:56:37 INFO - Running post-action listener: _resource_record_post_action 03:56:37 INFO - [mozharness: 2016-10-20 10:56:37.864669Z] Finished install step (success) 03:56:37 INFO - [mozharness: 2016-10-20 10:56:37.864838Z] Running run-tests step. 03:56:37 INFO - Running pre-action listener: _resource_record_pre_action 03:56:37 INFO - Running main action method: run_tests 03:56:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:56:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:56:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:56:37 INFO - 2016-10-20 03:56:37.879 screenresolution[1661:7471] starting screenresolution argv=screenresolution get 03:56:37 INFO - 2016-10-20 03:56:37.882 screenresolution[1661:7471] Display 0: 1600x1200x32@60 03:56:37 INFO - 2016-10-20 03:56:37.887 screenresolution[1662:7473] starting screenresolution argv=screenresolution list 03:56:37 INFO - Available Modes on Display 0 03:56:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:56:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:56:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:56:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:56:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:56:38 INFO - Intel Iris: 03:56:38 INFO - Chipset Model: Intel Iris 03:56:38 INFO - Type: GPU 03:56:38 INFO - Bus: Built-In 03:56:38 INFO - VRAM (Dynamic, Max): 1536 MB 03:56:38 INFO - Vendor: Intel (0x8086) 03:56:38 INFO - Device ID: 0x0a2e 03:56:38 INFO - Revision ID: 0x0009 03:56:38 INFO - Displays: 03:56:38 INFO - Display: 03:56:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:56:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:56:38 INFO - Display Serial Number: 1600x1200 60 03:56:38 INFO - Main Display: Yes 03:56:38 INFO - Mirror: Off 03:56:38 INFO - Online: Yes 03:56:38 INFO - Rotation: Supported 03:56:38 INFO - Return code: 0 03:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:56:38 INFO - Python 2.7.3 03:56:38 INFO - Return code: 0 03:56:38 INFO - grabbing minidump binary from tooltool 03:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1bd30>, '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 0x101a81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c13b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:56:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:56:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:56:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:56:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:38 INFO - Return code: 0 03:56:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:56:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:56:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:56:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:56:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 03:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0239 --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 03:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AaCudFw4jG/Render', 03:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:38 INFO - 'HOME': '/Users/cltbld', 03:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:38 INFO - 'LOGNAME': 'cltbld', 03:56:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:38 INFO - 'MOZ_NO_REMOTE': '1', 03:56:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:38 INFO - 'NO_EM_RESTART': '1', 03:56:38 INFO - 'PAGER': '/bin/cat', 03:56:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:38 INFO - 'PWD': '/builds/slave/test', 03:56:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:38 INFO - 'SHELL': '/bin/bash', 03:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9IP2Vis1yC/Listeners', 03:56:38 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:38 INFO - 'USER': 'cltbld', 03:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:38 INFO - 'XPC_FLAGS': '0x0', 03:56:38 INFO - 'XPC_SERVICE_NAME': '0', 03:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 03:56:38 INFO - mozversion application_buildid: 20161020004015 03:56:38 INFO - mozversion application_changeset: 95567c6551ea7dfef517e7b3f50fe0be209a3a2a 03:56:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:56:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:38 INFO - mozversion application_name: Firefox 03:56:38 INFO - mozversion application_remotingname: firefox-dev 03:56:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:56:38 INFO - mozversion application_vendor: Mozilla 03:56:38 INFO - mozversion application_version: 51.0a2 03:56:38 INFO - mozversion platform_buildid: 20161020004015 03:56:38 INFO - mozversion platform_changeset: 95567c6551ea7dfef517e7b3f50fe0be209a3a2a 03:56:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:56:38 INFO - mozversion platform_version: 51.0a2 03:56:38 INFO - using testdate: 1476960998 03:56:38 INFO - actual date: 1476960998 03:56:38 INFO - starting webserver on 'localhost:49277' 03:56:38 INFO - SUITE-START | Running 2 tests 03:56:38 INFO - TEST-START | dromaeo_css 03:56:38 INFO - operating with platform_type : mac_ 03:56:38 INFO - Initialising browser for dromaeo_css test... 03:56:38 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpLgOYSo/profile http://localhost:49277/getInfo.html) 03:56:40 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 03:56:40 INFO - PROCESS | 1672 | colorDepth:24 03:56:40 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 03:56:40 INFO - PROCESS | 1672 | __metrics 03:56:41 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:56:41 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:41 INFO - TEST-INFO | 1672: exit 0 03:56:41 INFO - Browser initialized. 03:56:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:41 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpLgOYSo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:53 INFO - PROCESS | 1675 | RSS: Main: 219566080 03:56:53 INFO - PROCESS | 1675 | 03:57:46 INFO - PROCESS | 1675 | 1476961066969 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] 03:59:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 03:59:58 INFO - PROCESS | 1675 | RSS: Main: 355790848 03:59:58 INFO - PROCESS | 1675 | 04:03:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 04:03:02 INFO - PROCESS | 1675 | RSS: Main: 349945856 04:03:02 INFO - PROCESS | 1675 | 04:06:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 04:06:05 INFO - PROCESS | 1675 | RSS: Main: 326553600 04:06:05 INFO - PROCESS | 1675 | 04:09:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 04:09:07 INFO - PROCESS | 1675 | RSS: Main: 321060864 04:09:07 INFO - PROCESS | 1675 | 04:12:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 04:12:12 INFO - PROCESS | 1675 | RSS: Main: 308293632 04:12:12 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 04:15:15 INFO - PROCESS | 1675 | RSS: Main: 385986560 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | __start_tp_report 04:15:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 04:15:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 04:15:15 INFO - PROCESS | 1675 | |i|pagename|runs| 04:15:15 INFO - PROCESS | 1675 | |0;dojo.html;3296.208909861633;3310.3875782980144;3331.533585298059;3351.7151042161413;3381.746369022324;5599.132134519151;5648.774049038034;5677.829665110043;5704.229928959589;5719.742611582473;5657.23627310313;5724.62789918655;5733.140028995643;5735.741891614877;5748.396418376073;5204.167333226685;5212.947870521284;5214.191800270954;5245.239440281157;5266.052110620087;5169.3279873616375;5170.586353091744;5181.378234611833;5303.602229832778;5331.520163185312;5270.710110943896;5279.155335146377;5287.444818294081;5287.656302340355;5294.629375943686;5175.896482070375;5181.326427564431;5236.083685355047;5260.763265653036;5275.340582427197;5104.43851176374;5122.615803814729;5145.845624631267;5145.948540514584;5243.449437809051;5661.320641523002;5682.801101961411;5752.993226185443;5761.48146666802;5773.711314434261;5848.385919478436;5907.379725128885;5929.080992446177;5950.256217972754;5975.581709280352;6172.1667574877265;6176;6263.718132683995;6297.0554416837385;6302.432781049682;5799.333076696192;5829.8251052468495;5847.181394604759;5854.531637468992;5894.498967587803;6253.405926436982;6292.528060395397;6297.055441683692;6304.590201636879;6307.369263073656;6115.785947491817;6132.023677617105;6140.13616995768;6203.503719702413;6213.099100630383;4477.977610111929;6280.811575652738;6312.210973628296;6315.968420157962;6341.175647165839;4883.511648835088;6075.605085669417;6120.477608373006;6243.0635404688755;6258.906116408258;6139.369480960552;6221.595596286227;6235;6300.117983482316;6300.338464461257;4892.094962431962;4921.188003979375;4922.360093187863;4929.285253638274;4934.7285899275885;4397.912041759147;4474.843380481732;4476.552344765498;4484.349769283501;4503.707259028152;5698.515626171822;5727.942720572824;5768.077107662838;5776.33572139201;5801.216835727208;6302.527310451735;6365.172527571386;6367.395097465734;6376.808695739135;6378.872422551523;4893.779779909913;5820.126980952807;5830.067189249699;5830.067189249699;5856.40151345205;4501.527339629357;5291.04761142998;5310.787568497217;5347.0909945309395;5461.2354270402175;6233.0338797486465;6272.529560282906;6285.560010799383;6336.17629708135;6337.271213810471;6324.683765811783;6337.461315788025;6344.555881088279;6351.936480635134;6374.075759014824;5086.54221120101;6242.687865606611;6307.747690092345;6333;6334.3665633436285;6075.756969721162;6079.088136779342;6082.178905847654;6142.815715528542;6164.938350616437;5318.840434786963;6090.330063692902;6220.346863579259;6314.052892066226;6317.463015643538;6066.817995460143;6118.663473509;6125.632462052291;6142.723577438936;6155.753769849156;5983.042713165873;6058.0610005449225;6116.082587611894;6124.5406594506485;6137;6051;6068.211132552917;6085.482733967662;6088.086786981989;6092;6148.139260503443;6165.876682466415;6190.473809726223;6195.96902015487;6197.845053873689;5892.469677729025;5918.911216331845;5933.792317268875;5936.317323507852;5990.610610310316 04:15:15 INFO - PROCESS | 1675 | |1;ext.html;460.62689221730403;496.22341036278226;501.3382335317378;515.6313236036234;523.131601541441;30159.396812063747;39570.01074973127;40732.59267407333;40737.59262407375;40984.59015409845;42586.29654813812;42965.78517107418;42981;43014;43109;8606.106656535583;9594.904050959505;9775.755606109833;9813.313068085237;9824.410535367864;8676.436031657922;11654.825177622342;11917.761644767099;11936.343501107436;12160.452779624893;11852.940735296312;11879.524819007273;11893.108016898725;11899.167058305922;11926.105542084335;8721.825563488757;8931.017588065308;11878.881211187863;11972.982296504808;11975.760484790255;11485.253458525169;11820.527178912833;11835.822462663067;12093.395330233454;12114.333711645855;39928.401073983914;40439.78680639585;40439.98900027493;40478.190436191115;40496.98757531056;3335.666433356669;3354.0608629583758;3450.6376830432696;3691.7231207659265;3706.6664000240107;29828.806847726064;30970.690293097006;31329.373412531622;31586.842065789755;31889.681103188905;3219.581454410935;3221.2430078931434;3253.886113985999;3276.0990727549874;3340.766146369755;521980;522955;523720.38139809057;524478;524540;32835.50746738801;33297;33515.16212094717;35059.64940350564;58097.70951145217;35088.64911350905;35110.47334289987;35223.11942201466;35230.471542926876;35344.82327588346;14984.850151498564;15083.773743393858;15105.773413398807;15115.848841511664;15117.848821511645;9783.853242201372;11460.828087578526;11793.233439826385;12703;12817.35913204336;7616.695332186761;7804.765857024298;7822.374210063182;7885.881711774328;7963.482373645695;3236.482162853932;3282.14664187313;3287.5726155600096;3312.403767321857;3319.71782398494;932.3380399916;957.760559860035;961.5192403798101;1010.7372083258259;1017.872765904262;26955.460890782073;28949.421011579652;29322;30210.917496089754;30320.938767143485;1043.7129789308;1075.0324707763075;1104.779044191165;1141.5433826469311;1150.3155622404656;15437.536873893801;15444.996075255072;15459.845401545841;15472.5358239253;15859.682806343808;690090;696489;696703;696813;697781;47689.5231047692;57257.42742572521;57741.422585774446;57857;58008.8398232033;1235.6849003504049;1249.993750031244;1367.883729882971;1380.6824430381068;1396.3786115178648;29859.402811944074;30315.468570204725;30934.917277895165;31107.222319442197;31567.052988410385;47262.76368618135;47719;47837.28244076272;47856.282155766996;47894.5210547904;463242;541777;545301;546548;892018;40332.99167520835;40480.98797530085;40968.15643295999;41035.58964410318;41150.38274425826;44903;45484.77257613691;45546;45974.54025459837;46077.30884036809;32198.678013220506;34619.78830740912;37861.05347366338;37985;38170.854874352706;36960.445593315584;37543.62456375401;37578.812105939294;37651.246975060894;37937.62062379341;35967.100822479646;36073.63926360703;36312;36333;36370;26655.933762650053;33063.66936330606;33065;34014.319713606084;34112.14719632029;25236.49527009413;25260.74739252584;25548.48903021892;26055.609165862148;26673.33316667099 04:15:15 INFO - PROCESS | 1675 | |2;jquery.html;334.6670063287029;354.5585745746546;378.5892306847071;388.74537178148313;406.46549787030074;15041.323140458679;15052.548423547298;16401.589960250985;20787.68818467724;20811.791882081176;16303.592410189722;19552.511187220327;19656.508587285323;20252.89873550634;20619.793802061973;5726.656400615955;6025;6027;6028.547858910577;6033.909491357633;4165.58344165584;4377.912441751163;4398.8900277493;5953.166556682068;6013.51891848651;4304.24675681756;6398.712057957403;6709.36261055199;6720.227173875018;6821.18145822502;6537.411632953033;6695.230048544431;6751.088603038576;6767.526273160881;6799.252082270947;5537.473939975695;5850.210221620112;5894.145348924425;5896.027155519334;5899.823005309805;21312.57374852494;25033;25454.618180727302;25774.48451030969;26076.087336943117;1985.7815640279557;2382.225776622587;2450.9387265318333;2582.6642536470326;2934.5158048921903;12522.874771252262;14772.55682329532;15883.444079457164;15939.884208105437;16452.588685282844;1458.5988853065385;1858.5632376391536;1910.3791267838008;1948.4349538633778;2020.464576887126;116788;119432;126693.83265418345;127350;130983;11267.323960562393;11435.885641143483;11453.370064646359;11628;11649.47577359021;14691;14701.705965880836;14708.191049492167;14710.779338309934;14718.558443246506;8421.19998600132;8509.787255318543;8532.786680333042;8535.231829135284;8594.957025214833;8504.957475212585;8505.234528892306;8516.233538981522;8617.741467755977;8620.008698999696;4539.773011349419;4547.522510136388;4575.748333841604;4580.129775342674;4622.9768851156205;1571.9449819256272;1772.2202231018312;1820.479406073533;1931.2371613212702;1931.3819577735271;818.6807145213371;985.2561316206362;1004.8392257238806;1021.0759262867117;1025.7435641089728;21123.894380528305;21386.572268554854;21429.357119286447;21511.67732484014;21521.354359369245;863.6558112693164;920.2453987729997;973.2846357926918;991.5587563534158;1009.9192064634811;10978.12175025996;11321.981021707921;11436.485358158903;11449.427528623535;11489.310641361544;641331;645433;652091;656409;659214;143853;147668;148563.2571837134;149366;150156.24921875322;949.1220620925616;954.7040417470467;965.0301447045674;965.5992763003416;967.7677357434305;13907.860921391062;18900.716489252947;19854.907980061234;20088.79911200869;20480.795192047888;39252.803735981135;58930;59728.40271597402;60095;60483.395166047776;81903;82128.94677633107;83549.58225208835;86596;90277;7782.377409807315;7845;7982.401319900914;7996.080940574104;8278.296344810518;9010.189082982562;11300.604478843201;12076.154669173073;12456.937715311366;12473.438695258554;10373.948130259301;10502.632407865687;10527.105196058115;10773.461326933779;10806.243562950833;8538.658453661785;10197.388156710622;10389.324693894872;10558.155347572329;10728.570857165938;10620.09729173029;10763.515641796295;10782.029617334478;11031.22781405294;11070.335779853234;7032.2264550898335;7579.696812127453;7858.842823143391;7950.920490795018;8243.711470098518;9600.85598716006;10644.361338319726;11106.000459958643;11415.828762568402;11864.11019173548 04:15:15 INFO - PROCESS | 1675 | |3;mootools.html;1384.8684374984373;1493.5295381954684;1716.9656606867864;1845.132787589834;1920.16472834317;8586.484810911343;9136.903571571413;9155;9160;9184.173424391804;7916.525008499494;8188.181181881809;8192.262696357328;8665.69670061548;8856.601452934618;2382.344855164835;2417.153996101368;2418.2019933422016;2419.9395015124674;2425.3936515871032;2377.7741114594087;2398.0767404549288;2423.297243799296;2423.6001059825107;2426.1387207541334;2408.421978725111;2411.6020856558735;2418.576749068906;2424.224248240555;2425.563398588253;2376.156464455111;2382.702162229721;2390.2351247600773;2390.318759153633;2399.6160614301803;2371.193794110011;2397.1849571145895;2399.5200959807935;2401.903923843044;2403.8076953843824;8870.37907346486;9065.501397423139;9081.45511269326;9102;9102.590383432762;5274.973625131888;5450.836474905759;5452.536534394581;5453.727313634303;5462.399136095027;3511.2450823073164;3623;3678.503402040717;3698.500702405168;3705.573859006222;1050.8528805967171;1085.4355735017746;1090.6237348114887;1100.7908497385472;1105.3865104866795;12032.759344813056;12051.517939282418;12074.818877716842;12111.87888121125;12121;4691.437027556715;4725.199455897785;4766.61867050642;4889.975550122226;4894.902101957941;10235.437050962268;10239.283250172566;10249.026342497451;10249.9487502562;10263.897361026444;4675.672702910763;5361.08861493547;5421.888512854855;5445.83662490126;5446.183072539151;4239.194553034913;4409.382686423904;4583.381243532081;4938.407391113089;4959.355283813081;3135.984320078385;3947.921041579152;4073.551909289976;4082.4692789937117;4096.283150448719;1211.2490256041135;1262.040848954801;1268.207370393504;1298.2016060122955;1306.941187646558;828.9088200297963;833.4291010657719;914.1635403605626;916.6791622932054;923.3905622289391;5814.94185058144;5849.707514624251;6048.516118710492;6091.878162436815;6185.876282474415;431.51454613559747;943.7734943613483;1028.1106842581114;1050.3067975136373;1059.597353005853;3430.1939044324563;3861.1119442528375;3989.0130158872403;4068.9013966228954;4151.6886233532605;10563.419011954262;11023.338599683884;11034.558617655364;11084.279521831217;11186.776264474665;11129.554817807197;11132.554697812158;11140.610078647209;11154.665360039211;11156.330620162817;8280.875786863202;8344.290735287446;8352.290055345364;8452.915470845213;8465.576721163918;5790;5833.241678581757;5872.412758724094;5996.850078748066;6023.879522409439;10235.385876847413;10311.329763565343;10369;10393.324433912074;10427.94786026065;10171.84742228882;10220.131288840532;10356.585736570452;10435.634752783617;10661;6691.297413771484;6884.208316043519;7131.215566287808;7325.377342925911;7327.303906128909;8357.95821020891;8637.093105223861;8646.654133834576;8743;8745.431546949429;7619.65711542993;7755.069391673035;7773.961130194313;7818.140004599603;7915.525068495908;7425.925740742523;7488.887666685113;7539.886901696588;7563.621818909142;7667.233276672288;7007.824804379931;7154.356107950101;7164.176119746087;7168.068151140318;7172.533785303938;4972.403311602486;5000.424951130666;5026.44709082008;5096.159133742891;5132.3327967364;4376.321670141006;5012.147934851157;5069.949300507095;5178.8964220716125;5218.504242096995 04:15:15 INFO - PROCESS | 1675 | |4;prototype.html;306.2680194335538;310.86322018311955;313.61425446700565;319.702676510845;323.7086622040162;5309.230161626562;5416.343967821725;5454.318210223722;5500.367457742361;5576.5259952904;4009.7995100245016;5053.332400307899;5255.766299322782;5288.471152884719;5402.405735369116;3507.754457187998;4139.710220284582;4141.647959923403;4156.147989662127;4167.833286668545;3436.639152888948;4155.148194620111;4163.479565054368;4187.1625674865145;4202.201581699483;4042.2117687051036;4093.3246014407587;4104.958950410502;4127.339625659895;4227.682923780713;3439.673231043047;4177.540470548237;4186.811593478301;4207.894802629943;4210.642095421893;2969.8218106913437;3289.227031647561;3607.4408466687705;3631.909202269938;3661.4507823826375;4352.847650332224;4933.519944016816;5049.84850454487;5293.947060529384;5347.59893008022;4753.857384278443;4767.523247675239;4774.424439934814;4790.520947905182;4829.879253018667;4420.84527041552;5575.163725441216;5732.3121225453215;5736.418611624786;5747.540196784247;3415.8121303328307;3661.5240018797654;4024.879253622367;4025.3760667096353;4041.2321658884716;5974.924513587553;6020.548458865603;6025.608335458225;6051.667158306292;6092.817215483498;3959.3269144244973;3960.20795840833;3961.2473630010204;3968.8214030368704;3981.7411868228473;4035.3139966205817;4043.0094626816617;4043.4137050127565;4043.8584649537124;4044.15072834708;4178.310578754472;4363.869083927487;4586.472555656075;4606;4671.789769460383;5673.914891276634;5702.942970570324;5713.371529131792;5755.107958266475;5765.308163020464;1223.3149436315691;1298.9285589292679;1340.3901224942629;1368.4252613902186;1381.7581923163407;803;861.9267362274277;919.3013309884536;920.9171174594319;932.7901222225081;5326.840194794162;5335.279737235423;5344.412114667383;5359.464053594687;5421.593380496479;5604.861277684428;5612.915806262909;5872.590578261272;5925.496332811673;5957.650914832197;5181.093308670967;5291.365036195682;5317.8936421271355;5370.70461124634;5374.381946076173;2600.8439493630062;2643.867806609662;2702.7702395410042;2724.523208438515;2775.4726601945567;4533.569310915458;5060;5804.506616937523;5964.047796340839;6042.939570604238;5125.513076257749;5143.459936706592;5834.970825145932;6106.114613381035;6168.722407491584;5143.485651434827;6169.691515424211;6204;6240.563160578716;6273.560850740496;5374.4625537445945;5651.773929042793;5683.943160568341;5943.167956486009;5949.018411961978;5860.7729062955805;5867.882642347215;5938.435848594377;5972.283326000907;6102.237220347457;5353.839384818461;5753.827385178452;5831.77532718134;5995.970020149872;6155.292141403616;3629.147150419702;3961.6632586230494;3964.821583028713;3988.880333589997;3992.3811809169624;5749.051406517878;5916.349201587908;5959.880802384015;5985.431384018511;6023.45788879003;5422.48486393792;5742.684152371659;5767.913481297868;5873.530117590668;5873.647581145145;5702.372738998624;5710.857228569319;5755.424457554211;5762.625429347079;5776.7400466979925;4845.830395936126;5125.743712814419;5129.333186685707;5436.71078997201;5611.831645050655;5515.841673248663;5636.408177141505;5806.796762113306;5823.563232757645;5841.69943981649;5238.790448382022;5277.788888444573;5656.151577263279;5702.40124786908;5719.311044376437 04:15:15 INFO - PROCESS | 1675 | |5;yui.html;668.7091115364816;742.9405647548197;788.5505262000655;822.7449490657895;839.7522730794415;13139.605811825637;15023.849761502383;16367.345306187739;16508.422205222818;16658.1670916454;14959.551213463614;15076.849231507682;15077.698446031072;15086.245687715598;15089.547313580582;700.5866538742141;866.514751739025;890.5814267294394;891.6477991193475;895.9696349198441;721.982005372425;732.7105793211679;757.8863170524438;881.4402854187605;891.5141248019845;870.268974061788;907.2605826251616;916.083916083916;919.0946917286501;925.6390007896925;909.4770506958525;911.9452832830018;912.297530901209;912.3522299167565;913.9908600913973;543.5054100768322;563.8533981164927;567.3815541060264;570.6347937320119;571.7198572699348;12417.93791031048;14653.194074325907;15214.391424343014;15517.612059698486;15547.766783498257;14351.354189061518;14794.260286985607;14828.70342593153;14847.331870065873;15117.54647360581;11094.833577496343;11644.301341919512;11675;11944.343061131634;11997.400129993553;3862.864799731996;3881.6700580450697;3889.4165875118674;4007.8797636070963;4032.8790136295665;122464;126081.73918260791;127378;128289.35855320757;128831;11244.55021799119;11268.985791278825;11375;11385.772284554263;11540.826887596693;17209.827901720822;17456.389026384015;22243.777562224495;22453.989570469366;22585.209517666804;8061.4760040597175;8148.918510814935;8249.670013199404;8262.008558972962;8342;4250.723702959298;4437.778111094497;4445.555444455593;4458.420405347349;4467.687261891637;3567.7502574819514;3686.170611612419;3706.4625629283605;3708.332500149999;3714.201446688921;574.6609500394703;652.3052948609716;668.0547025958311;680.5474359550942;680.7515256931184;594.3165359836137;618.9566730328834;640.4044238857907;667.6127845849396;677.4512644757664;8564.400491965502;9407.576659050359;10008.649697260707;10286.537105830255;10429.165666746794;558.0930987145888;573.3148887079899;620.3052581109187;650.7494614573424;672.468749687751;4019.577944315863;4113.382992551082;4469.597736203692;4649.703729522509;4769.689970151929;132073;133194;133198;158274.2086289561;168730;98584.50707746415;107444;121009;125959.11061334088;136663.31668341794;115231;116025.41987290178;116627.8337216634;117462;121470.1779473291;8669.959604847207;9453.574589143367;10177.542010609392;10220.131288840234;10278.537465814206;61859.762804744554;62417;63383.6830815843;64278.53632441295;66724;92576;97715;98212;101237;101523.9847601544;11498.367589782642;12550.874491255336;12669.683257918627;12686.492540298654;13766.793498097337;13710.314484275947;14557.199354035207;15077.623059423602;16014.519564413085;16175.352985880432;12161.87838121643;14511.492097776527;14608.78086828677;14906.925465372604;15085.094894305937;13933.442662293395;14062.929685351508;14126.717465650834;14209.644758881112;14210.715785684435;10942.17933654963;13038.348082596021;13271.402786874807;13529.323533823466;13647.590572282847;10888.945555272174;11122.98824164088;11130.499127539118;11876.940615297213;12036.458359374024;10989.285696429706;11559.826602600799;11737.530498779954;11779.941100294443;11864.584739534075 04:15:15 INFO - PROCESS | 1675 | __end_tp_report 04:15:15 INFO - PROCESS | 1675 | __start_cc_report 04:15:15 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1353 04:15:15 INFO - PROCESS | 1675 | __end_cc_report 04:15:15 INFO - PROCESS | 1675 | __startTimestamp1476962115471__endTimestamp 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | ------- Summary: start ------- 04:15:15 INFO - PROCESS | 1675 | Number of tests: 6 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5718.84 Median:5918.91 stddev:660.74 (11.2%) stddev-sans-first:634.84 04:15:15 INFO - PROCESS | 1675 | Values: 3296.2 3310.4 3331.5 3351.7 3381.7 5599.1 5648.8 5677.8 5704.2 5719.7 5657.2 5724.6 5733.1 5735.7 5748.4 5204.2 5212.9 5214.2 5245.2 5266.1 5169.3 5170.6 5181.4 5303.6 5331.5 5270.7 5279.2 5287.4 5287.7 5294.6 5175.9 5181.3 5236.1 5260.8 5275.3 5104.4 5122.6 5145.8 5145.9 5243.4 5661.3 5682.8 5753.0 5761.5 5773.7 5848.4 5907.4 5929.1 5950.3 5975.6 6172.2 6176.0 6263.7 6297.1 6302.4 5799.3 5829.8 5847.2 5854.5 5894.5 6253.4 6292.5 6297.1 6304.6 6307.4 6115.8 6132.0 6140.1 6203.5 6213.1 4478.0 6280.8 6312.2 6316.0 6341.2 4883.5 6075.6 6120.5 6243.1 6258.9 6139.4 6221.6 6235.0 6300.1 6300.3 4892.1 4921.2 4922.4 4929.3 4934.7 4397.9 4474.8 4476.6 4484.3 4503.7 5698.5 5727.9 5768.1 5776.3 5801.2 6302.5 6365.2 6367.4 6376.8 6378.9 4893.8 5820.1 5830.1 5830.1 5856.4 4501.5 5291.0 5310.8 5347.1 5461.2 6233.0 6272.5 6285.6 6336.2 6337.3 6324.7 6337.5 6344.6 6351.9 6374.1 5086.5 6242.7 6307.7 6333.0 6334.4 6075.8 6079.1 6082.2 6142.8 6164.9 5318.8 6090.3 6220.3 6314.1 6317.5 6066.8 6118.7 6125.6 6142.7 6155.8 5983.0 6058.1 6116.1 6124.5 6137.0 6051.0 6068.2 6085.5 6088.1 6092.0 6148.1 6165.9 6190.5 6196.0 6197.8 5892.5 5918.9 5933.8 5936.3 5990.6 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:71678.46 Median:35226.80 stddev:165426.35 (469.6%) stddev-sans-first:165803.99 04:15:15 INFO - PROCESS | 1675 | Values: 460.6 496.2 501.3 515.6 523.1 30159.4 39570.0 40732.6 40737.6 40984.6 42586.3 42965.8 42981.0 43014.0 43109.0 8606.1 9594.9 9775.8 9813.3 9824.4 8676.4 11654.8 11917.8 11936.3 12160.5 11852.9 11879.5 11893.1 11899.2 11926.1 8721.8 8931.0 11878.9 11973.0 11975.8 11485.3 11820.5 11835.8 12093.4 12114.3 39928.4 40439.8 40440.0 40478.2 40497.0 3335.7 3354.1 3450.6 3691.7 3706.7 29828.8 30970.7 31329.4 31586.8 31889.7 3219.6 3221.2 3253.9 3276.1 3340.8 521980.0 522955.0 523720.4 524478.0 524540.0 32835.5 33297.0 33515.2 35059.6 58097.7 35088.6 35110.5 35223.1 35230.5 35344.8 14984.9 15083.8 15105.8 15115.8 15117.8 9783.9 11460.8 11793.2 12703.0 12817.4 7616.7 7804.8 7822.4 7885.9 7963.5 3236.5 3282.1 3287.6 3312.4 3319.7 932.3 957.8 961.5 1010.7 1017.9 26955.5 28949.4 29322.0 30210.9 30320.9 1043.7 1075.0 1104.8 1141.5 1150.3 15437.5 15445.0 15459.8 15472.5 15859.7 690090.0 696489.0 696703.0 696813.0 697781.0 47689.5 57257.4 57741.4 57857.0 58008.8 1235.7 1250.0 1367.9 1380.7 1396.4 29859.4 30315.5 30934.9 31107.2 31567.1 47262.8 47719.0 47837.3 47856.3 47894.5 463242.0 541777.0 545301.0 546548.0 892018.0 40333.0 40481.0 40968.2 41035.6 41150.4 44903.0 45484.8 45546.0 45974.5 46077.3 32198.7 34619.8 37861.1 37985.0 38170.9 36960.4 37543.6 37578.8 37651.2 37937.6 35967.1 36073.6 36312.0 36333.0 36370.0 26655.9 33063.7 33065.0 34014.3 34112.1 25236.5 25260.7 25548.5 26055.6 26673.3 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:37452.11 Median:25243.81 stddev:108936.86 (431.5%) stddev-sans-first:109206.80 04:15:15 INFO - PROCESS | 1675 | Values: 334.7 354.6 378.6 388.7 406.5 15041.3 15052.5 16401.6 20787.7 20811.8 16303.6 19552.5 19656.5 20252.9 20619.8 5726.7 6025.0 6027.0 6028.5 6033.9 4165.6 4377.9 4398.9 5953.2 6013.5 4304.2 6398.7 6709.4 6720.2 6821.2 6537.4 6695.2 6751.1 6767.5 6799.3 5537.5 5850.2 5894.1 5896.0 5899.8 21312.6 25033.0 25454.6 25774.5 26076.1 1985.8 2382.2 2450.9 2582.7 2934.5 12522.9 14772.6 15883.4 15939.9 16452.6 1458.6 1858.6 1910.4 1948.4 2020.5 116788.0 119432.0 126693.8 127350.0 130983.0 11267.3 11435.9 11453.4 11628.0 11649.5 14691.0 14701.7 14708.2 14710.8 14718.6 8421.2 8509.8 8532.8 8535.2 8595.0 8505.0 8505.2 8516.2 8617.7 8620.0 4539.8 4547.5 4575.7 4580.1 4623.0 1571.9 1772.2 1820.5 1931.2 1931.4 818.7 985.3 1004.8 1021.1 1025.7 21123.9 21386.6 21429.4 21511.7 21521.4 863.7 920.2 973.3 991.6 1009.9 10978.1 11322.0 11436.5 11449.4 11489.3 641331.0 645433.0 652091.0 656409.0 659214.0 143853.0 147668.0 148563.3 149366.0 150156.2 949.1 954.7 965.0 965.6 967.8 13907.9 18900.7 19854.9 20088.8 20480.8 39252.8 58930.0 59728.4 60095.0 60483.4 81903.0 82128.9 83549.6 86596.0 90277.0 7782.4 7845.0 7982.4 7996.1 8278.3 9010.2 11300.6 12076.2 12456.9 12473.4 10373.9 10502.6 10527.1 10773.5 10806.2 8538.7 10197.4 10389.3 10558.2 10728.6 10620.1 10763.5 10782.0 11031.2 11070.3 7032.2 7579.7 7858.8 7950.9 8243.7 9600.9 10644.4 11106.0 11415.8 11864.1 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5817.07 Median:4392.85 stddev:3306.43 (75.3%) stddev-sans-first:3298.93 04:15:15 INFO - PROCESS | 1675 | Values: 1384.9 1493.5 1717.0 1845.1 1920.2 8586.5 9136.9 9155.0 9160.0 9184.2 7916.5 8188.2 8192.3 8665.7 8856.6 2382.3 2417.2 2418.2 2419.9 2425.4 2377.8 2398.1 2423.3 2423.6 2426.1 2408.4 2411.6 2418.6 2424.2 2425.6 2376.2 2382.7 2390.2 2390.3 2399.6 2371.2 2397.2 2399.5 2401.9 2403.8 8870.4 9065.5 9081.5 9102.0 9102.6 5275.0 5450.8 5452.5 5453.7 5462.4 3511.2 3623.0 3678.5 3698.5 3705.6 1050.9 1085.4 1090.6 1100.8 1105.4 12032.8 12051.5 12074.8 12111.9 12121.0 4691.4 4725.2 4766.6 4890.0 4894.9 10235.4 10239.3 10249.0 10249.9 10263.9 4675.7 5361.1 5421.9 5445.8 5446.2 4239.2 4409.4 4583.4 4938.4 4959.4 3136.0 3947.9 4073.6 4082.5 4096.3 1211.2 1262.0 1268.2 1298.2 1306.9 828.9 833.4 914.2 916.7 923.4 5814.9 5849.7 6048.5 6091.9 6185.9 431.5 943.8 1028.1 1050.3 1059.6 3430.2 3861.1 3989.0 4068.9 4151.7 10563.4 11023.3 11034.6 11084.3 11186.8 11129.6 11132.6 11140.6 11154.7 11156.3 8280.9 8344.3 8352.3 8452.9 8465.6 5790.0 5833.2 5872.4 5996.9 6023.9 10235.4 10311.3 10369.0 10393.3 10427.9 10171.8 10220.1 10356.6 10435.6 10661.0 6691.3 6884.2 7131.2 7325.4 7327.3 8358.0 8637.1 8646.7 8743.0 8745.4 7619.7 7755.1 7774.0 7818.1 7915.5 7425.9 7488.9 7539.9 7563.6 7667.2 7007.8 7154.4 7164.2 7168.1 7172.5 4972.4 5000.4 5026.4 5096.2 5132.3 4376.3 5012.1 5069.9 5178.9 5218.5 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:4653.04 Median:5301.59 stddev:1456.06 (27.5%) stddev-sans-first:1423.12 04:15:15 INFO - PROCESS | 1675 | Values: 306.3 310.9 313.6 319.7 323.7 5309.2 5416.3 5454.3 5500.4 5576.5 4009.8 5053.3 5255.8 5288.5 5402.4 3507.8 4139.7 4141.6 4156.1 4167.8 3436.6 4155.1 4163.5 4187.2 4202.2 4042.2 4093.3 4105.0 4127.3 4227.7 3439.7 4177.5 4186.8 4207.9 4210.6 2969.8 3289.2 3607.4 3631.9 3661.5 4352.8 4933.5 5049.8 5293.9 5347.6 4753.9 4767.5 4774.4 4790.5 4829.9 4420.8 5575.2 5732.3 5736.4 5747.5 3415.8 3661.5 4024.9 4025.4 4041.2 5974.9 6020.5 6025.6 6051.7 6092.8 3959.3 3960.2 3961.2 3968.8 3981.7 4035.3 4043.0 4043.4 4043.9 4044.2 4178.3 4363.9 4586.5 4606.0 4671.8 5673.9 5702.9 5713.4 5755.1 5765.3 1223.3 1298.9 1340.4 1368.4 1381.8 803.0 861.9 919.3 920.9 932.8 5326.8 5335.3 5344.4 5359.5 5421.6 5604.9 5612.9 5872.6 5925.5 5957.7 5181.1 5291.4 5317.9 5370.7 5374.4 2600.8 2643.9 2702.8 2724.5 2775.5 4533.6 5060.0 5804.5 5964.0 6042.9 5125.5 5143.5 5835.0 6106.1 6168.7 5143.5 6169.7 6204.0 6240.6 6273.6 5374.5 5651.8 5683.9 5943.2 5949.0 5860.8 5867.9 5938.4 5972.3 6102.2 5353.8 5753.8 5831.8 5996.0 6155.3 3629.1 3961.7 3964.8 3988.9 3992.4 5749.1 5916.3 5959.9 5985.4 6023.5 5422.5 5742.7 5767.9 5873.5 5873.6 5702.4 5710.9 5755.4 5762.6 5776.7 4845.8 5125.7 5129.3 5436.7 5611.8 5515.8 5636.4 5806.8 5823.6 5841.7 5238.8 5277.8 5656.2 5702.4 5719.3 04:15:15 INFO - PROCESS | 1675 | 04:15:15 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:25424.97 Median:92694.08 stddev:40526.89 (43.7%) stddev-sans-first:40597.95 04:15:15 INFO - PROCESS | 1675 | Values: 668.7 742.9 788.6 822.7 839.8 13139.6 15023.8 16367.3 16508.4 16658.2 14959.6 15076.8 15077.7 15086.2 15089.5 700.6 866.5 890.6 891.6 896.0 722.0 732.7 757.9 881.4 891.5 870.3 907.3 916.1 919.1 925.6 909.5 911.9 912.3 912.4 914.0 543.5 563.9 567.4 570.6 571.7 12417.9 14653.2 15214.4 15517.6 15547.8 14351.4 14794.3 14828.7 14847.3 15117.5 11094.8 11644.3 11675.0 11944.3 11997.4 3862.9 3881.7 3889.4 4007.9 4032.9 122464.0 126081.7 127378.0 128289.4 128831.0 11244.6 11269.0 11375.0 11385.8 11540.8 17209.8 17456.4 22243.8 22454.0 22585.2 8061.5 8148.9 8249.7 8262.0 8342.0 4250.7 4437.8 4445.6 4458.4 4467.7 3567.8 3686.2 3706.5 3708.3 3714.2 574.7 652.3 668.1 680.5 680.8 594.3 619.0 640.4 667.6 677.5 8564.4 9407.6 10008.6 10286.5 10429.2 558.1 573.3 620.3 650.7 672.5 4019.6 4113.4 4469.6 4649.7 4769.7 132073.0 133194.0 133198.0 158274.2 168730.0 98584.5 107444.0 121009.0 125959.1 136663.3 115231.0 116025.4 116627.8 117462.0 121470.2 8670.0 9453.6 10177.5 10220.1 10278.5 61859.8 62417.0 63383.7 64278.5 66724.0 92576.0 97715.0 98212.0 101237.0 101524.0 11498.4 12550.9 12669.7 12686.5 13766.8 13710.3 14557.2 15077.6 16014.5 16175.4 12161.9 14511.5 14608.8 14906.9 15085.1 13933.4 14062.9 14126.7 14209.6 14210.7 10942.2 13038.3 13271.4 13529.3 13647.6 10888.9 11123.0 11130.5 11876.9 12036.5 10989.3 11559.8 11737.5 11779.9 11864.6 04:15:15 INFO - PROCESS | 1675 | -------- Summary: end -------- 04:15:15 INFO - PROCESS | 1675 | 04:15:16 INFO - TEST-INFO | 1675: exit 0 04:15:16 INFO - TEST-OK | dromaeo_css | took 1117645ms 04:15:16 INFO - TEST-START | kraken 04:15:16 INFO - operating with platform_type : mac_ 04:15:16 INFO - Initialising browser for kraken test... 04:15:16 INFO - TEST-INFO | started process 1795 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpQsPzNP/profile http://localhost:49277/getInfo.html) 04:15:18 INFO - PROCESS | 1795 | __metrics Screen width/height:1600/1200 04:15:18 INFO - PROCESS | 1795 | colorDepth:24 04:15:18 INFO - PROCESS | 1795 | Browser inner width/height: 1024/689 04:15:18 INFO - PROCESS | 1795 | __metrics 04:15:18 INFO - PROCESS | 1795 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:15:18 INFO - PROCESS | 1795 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:19 INFO - TEST-INFO | 1795: exit 0 04:15:19 INFO - Browser initialized. 04:15:19 INFO - Running cycle 1/1 for kraken test... 04:15:19 INFO - TEST-INFO | started process 1798 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpQsPzNP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:31 INFO - PROCESS | 1798 | RSS: Main: 219815936 04:15:31 INFO - PROCESS | 1798 | 04:15:34 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:35 INFO - PROCESS | 1798 | RSS: Main: 270188544 04:15:35 INFO - PROCESS | 1798 | 04:15:38 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 04:15:38 INFO - PROCESS | 1798 | RSS: Main: 280391680 04:15:38 INFO - PROCESS | 1798 | 04:15:41 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 04:15:42 INFO - PROCESS | 1798 | RSS: Main: 378183680 04:15:42 INFO - PROCESS | 1798 | 04:15:44 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 04:15:45 INFO - PROCESS | 1798 | RSS: Main: 279482368 04:15:45 INFO - PROCESS | 1798 | 04:15:47 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:47 INFO - PROCESS | 1798 | RSS: Main: 280031232 04:15:47 INFO - PROCESS | 1798 | 04:15:50 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:51 INFO - PROCESS | 1798 | RSS: Main: 319655936 04:15:51 INFO - PROCESS | 1798 | 04:15:54 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:54 INFO - PROCESS | 1798 | RSS: Main: 319463424 04:15:54 INFO - PROCESS | 1798 | 04:15:57 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 04:15:58 INFO - PROCESS | 1798 | RSS: Main: 318210048 04:15:58 INFO - PROCESS | 1798 | 04:15:59 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:00 INFO - PROCESS | 1798 | RSS: Main: 290164736 04:16:00 INFO - PROCESS | 1798 | 04:16:02 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:02 INFO - PROCESS | 1798 | RSS: Main: 295845888 04:16:02 INFO - PROCESS | 1798 | 04:16:04 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:05 INFO - PROCESS | 1798 | RSS: Main: 298278912 04:16:05 INFO - PROCESS | 1798 | 04:16:08 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:09 INFO - PROCESS | 1798 | RSS: Main: 309485568 04:16:09 INFO - PROCESS | 1798 | 04:16:12 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:12 INFO - PROCESS | 1798 | RSS: Main: 308871168 04:16:12 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 04:16:14 INFO - PROCESS | 1798 | RSS: Main: 353140736 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | __start_tp_report 04:16:14 INFO - PROCESS | 1798 | _x_x_mozilla_page_load 04:16:14 INFO - PROCESS | 1798 | _x_x_mozilla_page_load_details 04:16:14 INFO - PROCESS | 1798 | |i|pagename|runs| 04:16:14 INFO - PROCESS | 1798 | |0;ai-astar;115;114;120;163;161;112;112;114;113;112 04:16:14 INFO - PROCESS | 1798 | |1;audio-beat-detection;145;132;142;171;139;108;110;108;145;136 04:16:14 INFO - PROCESS | 1798 | |2;audio-dft;184;188;182;183;186;181;182;182;181;179 04:16:14 INFO - PROCESS | 1798 | |3;audio-fft;80;59;57;90;83;86;75;57;81;58 04:16:14 INFO - PROCESS | 1798 | |4;audio-oscillator;85;71;94;70;68;70;91;68;70;106 04:16:14 INFO - PROCESS | 1798 | |5;imaging-gaussian-blur;87;84;87;85;88;84;87;84;86;84 04:16:14 INFO - PROCESS | 1798 | |6;imaging-darkroom;111;150;88;148;151;93;92;92;93;93 04:16:14 INFO - PROCESS | 1798 | |7;imaging-desaturate;87;85;83;86;83;84;85;85;86;85 04:16:14 INFO - PROCESS | 1798 | |8;json-parse-financial;57;55;54;53;56;59;58;58;59;58 04:16:14 INFO - PROCESS | 1798 | |9;json-stringify-tinderbox;64;68;73;70;74;69;73;69;70;71 04:16:14 INFO - PROCESS | 1798 | |10;stanford-crypto-aes;92;90;100;75;81;78;81;84;82;82 04:16:14 INFO - PROCESS | 1798 | |11;stanford-crypto-ccm;133;141;148;146;137;143;151;127;169;137 04:16:14 INFO - PROCESS | 1798 | |12;stanford-crypto-pbkdf2;163;165;161;226;158;199;223;167;163;162 04:16:14 INFO - PROCESS | 1798 | |13;stanford-crypto-sha256-iterative;68;67;68;64;64;67;67;66;65;66 04:16:14 INFO - PROCESS | 1798 | __end_tp_report 04:16:14 INFO - PROCESS | 1798 | __start_cc_report 04:16:14 INFO - PROCESS | 1798 | _x_x_mozilla_cycle_collect,1942 04:16:14 INFO - PROCESS | 1798 | __end_cc_report 04:16:14 INFO - PROCESS | 1798 | __startTimestamp1476962174675__endTimestamp 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | ------- Summary: start ------- 04:16:14 INFO - PROCESS | 1798 | Number of tests: 14 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#0] ai-astar Cycles:10 Average:123.60 Median:114.50 stddev:20.38 (17.8%) stddev-sans-first:21.38 04:16:14 INFO - PROCESS | 1798 | Values: 115.0 114.0 120.0 163.0 161.0 112.0 112.0 114.0 113.0 112.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:140.50 stddev:20.10 (14.3%) stddev-sans-first:20.89 04:16:14 INFO - PROCESS | 1798 | Values: 145.0 132.0 142.0 171.0 139.0 108.0 110.0 108.0 145.0 136.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#2] audio-dft Cycles:10 Average:182.80 Median:182.50 stddev:2.62 (1.4%) stddev-sans-first:2.74 04:16:14 INFO - PROCESS | 1798 | Values: 184.0 188.0 182.0 183.0 186.0 181.0 182.0 182.0 181.0 179.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#3] audio-fft Cycles:10 Average:72.60 Median:80.50 stddev:13.36 (16.6%) stddev-sans-first:13.90 04:16:14 INFO - PROCESS | 1798 | Values: 80.0 59.0 57.0 90.0 83.0 86.0 75.0 57.0 81.0 58.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:70.50 stddev:13.67 (19.4%) stddev-sans-first:14.34 04:16:14 INFO - PROCESS | 1798 | Values: 85.0 71.0 94.0 70.0 68.0 70.0 91.0 68.0 70.0 106.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.59 04:16:14 INFO - PROCESS | 1798 | Values: 87.0 84.0 87.0 85.0 88.0 84.0 87.0 84.0 86.0 84.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#6] imaging-darkroom Cycles:10 Average:111.10 Median:92.00 stddev:27.31 (29.7%) stddev-sans-first:28.97 04:16:14 INFO - PROCESS | 1798 | Values: 111.0 150.0 88.0 148.0 151.0 93.0 92.0 92.0 93.0 93.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:1.12 04:16:14 INFO - PROCESS | 1798 | Values: 87.0 85.0 83.0 86.0 83.0 84.0 85.0 85.0 86.0 85.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:58.00 stddev:2.11 (3.6%) stddev-sans-first:2.24 04:16:14 INFO - PROCESS | 1798 | Values: 57.0 55.0 54.0 53.0 56.0 59.0 58.0 58.0 59.0 58.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:2.92 (4.1%) stddev-sans-first:2.11 04:16:14 INFO - PROCESS | 1798 | Values: 64.0 68.0 73.0 70.0 74.0 69.0 73.0 69.0 70.0 71.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:82.00 stddev:7.43 (9.1%) stddev-sans-first:7.37 04:16:14 INFO - PROCESS | 1798 | Values: 92.0 90.0 100.0 75.0 81.0 78.0 81.0 84.0 82.0 82.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:144.50 stddev:11.57 (8.0%) stddev-sans-first:11.67 04:16:14 INFO - PROCESS | 1798 | Values: 133.0 141.0 148.0 146.0 137.0 143.0 151.0 127.0 169.0 137.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:166.00 stddev:26.77 (16.1%) stddev-sans-first:27.79 04:16:14 INFO - PROCESS | 1798 | Values: 163.0 165.0 161.0 226.0 158.0 199.0 223.0 167.0 163.0 162.0 04:16:14 INFO - PROCESS | 1798 | 04:16:14 INFO - PROCESS | 1798 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.41 04:16:14 INFO - PROCESS | 1798 | Values: 68.0 67.0 68.0 64.0 64.0 67.0 67.0 66.0 65.0 66.0 04:16:14 INFO - PROCESS | 1798 | -------- Summary: end -------- 04:16:14 INFO - PROCESS | 1798 | 04:16:15 INFO - TEST-INFO | 1798: exit 0 04:16:15 INFO - TEST-OK | kraken | took 59385ms 04:16:15 INFO - SUITE-END | took 1177s 04:16:15 INFO - Completed test suite (00:19:37) 04:16:15 INFO - javascript benchmark 04:16:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.208909861633, 3310.3875782980144, 3331.533585298059, 3351.7151042161413, 3381.746369022324, 5599.132134519151, 5648.774049038034, 5677.829665110043, 5704.229928959589, 5719.742611582473, 5657.23627310313, 5724.62789918655, 5733.140028995643, 5735.741891614877, 5748.396418376073, 5204.167333226685, 5212.947870521284, 5214.191800270954, 5245.239440281157, 5266.052110620087, 5169.3279873616375, 5170.586353091744, 5181.378234611833, 5303.602229832778, 5331.520163185312, 5270.710110943896, 5279.155335146377, 5287.444818294081, 5287.656302340355, 5294.629375943686, 5175.896482070375, 5181.326427564431, 5236.083685355047, 5260.763265653036, 5275.340582427197, 5104.43851176374, 5122.615803814729, 5145.845624631267, 5145.948540514584, 5243.449437809051, 5661.320641523002, 5682.801101961411, 5752.993226185443, 5761.48146666802, 5773.711314434261, 5848.385919478436, 5907.379725128885, 5929.080992446177, 5950.256217972754, 5975.581709280352, 6172.1667574877265, 6176.0, 6263.718132683995, 6297.0554416837385, 6302.432781049682, 5799.333076696192, 5829.8251052468495, 5847.181394604759, 5854.531637468992, 5894.498967587803, 6253.405926436982, 6292.528060395397, 6297.055441683692, 6304.590201636879, 6307.369263073656, 6115.785947491817, 6132.023677617105, 6140.13616995768, 6203.503719702413, 6213.099100630383, 4477.977610111929, 6280.811575652738, 6312.210973628296, 6315.968420157962, 6341.175647165839, 4883.511648835088, 6075.605085669417, 6120.477608373006, 6243.0635404688755, 6258.906116408258, 6139.369480960552, 6221.595596286227, 6235.0, 6300.117983482316, 6300.338464461257, 4892.094962431962, 4921.188003979375, 4922.360093187863, 4929.285253638274, 4934.7285899275885, 4397.912041759147, 4474.843380481732, 4476.552344765498, 4484.349769283501, 4503.707259028152, 5698.515626171822, 5727.942720572824, 5768.077107662838, 5776.33572139201, 5801.216835727208, 6302.527310451735, 6365.172527571386, 6367.395097465734, 6376.808695739135, 6378.872422551523, 4893.779779909913, 5820.126980952807, 5830.067189249699, 5830.067189249699, 5856.40151345205, 4501.527339629357, 5291.04761142998, 5310.787568497217, 5347.0909945309395, 5461.2354270402175, 6233.0338797486465, 6272.529560282906, 6285.560010799383, 6336.17629708135, 6337.271213810471, 6324.683765811783, 6337.461315788025, 6344.555881088279, 6351.936480635134, 6374.075759014824, 5086.54221120101, 6242.687865606611, 6307.747690092345, 6333.0, 6334.3665633436285, 6075.756969721162, 6079.088136779342, 6082.178905847654, 6142.815715528542, 6164.938350616437, 5318.840434786963, 6090.330063692902, 6220.346863579259, 6314.052892066226, 6317.463015643538, 6066.817995460143, 6118.663473509, 6125.632462052291, 6142.723577438936, 6155.753769849156, 5983.042713165873, 6058.0610005449225, 6116.082587611894, 6124.5406594506485, 6137.0, 6051.0, 6068.211132552917, 6085.482733967662, 6088.086786981989, 6092.0, 6148.139260503443, 6165.876682466415, 6190.473809726223, 6195.96902015487, 6197.845053873689, 5892.469677729025, 5918.911216331845, 5933.792317268875, 5936.317323507852, 5990.610610310316], "value": 5678.168266654308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.62689221730403, 496.22341036278226, 501.3382335317378, 515.6313236036234, 523.131601541441, 30159.396812063747, 39570.01074973127, 40732.59267407333, 40737.59262407375, 40984.59015409845, 42586.29654813812, 42965.78517107418, 42981.0, 43014.0, 43109.0, 8606.106656535583, 9594.904050959505, 9775.755606109833, 9813.313068085237, 9824.410535367864, 8676.436031657922, 11654.825177622342, 11917.761644767099, 11936.343501107436, 12160.452779624893, 11852.940735296312, 11879.524819007273, 11893.108016898725, 11899.167058305922, 11926.105542084335, 8721.825563488757, 8931.017588065308, 11878.881211187863, 11972.982296504808, 11975.760484790255, 11485.253458525169, 11820.527178912833, 11835.822462663067, 12093.395330233454, 12114.333711645855, 39928.401073983914, 40439.78680639585, 40439.98900027493, 40478.190436191115, 40496.98757531056, 3335.666433356669, 3354.0608629583758, 3450.6376830432696, 3691.7231207659265, 3706.6664000240107, 29828.806847726064, 30970.690293097006, 31329.373412531622, 31586.842065789755, 31889.681103188905, 3219.581454410935, 3221.2430078931434, 3253.886113985999, 3276.0990727549874, 3340.766146369755, 521980.0, 522955.0, 523720.38139809057, 524478.0, 524540.0, 32835.50746738801, 33297.0, 33515.16212094717, 35059.64940350564, 58097.70951145217, 35088.64911350905, 35110.47334289987, 35223.11942201466, 35230.471542926876, 35344.82327588346, 14984.850151498564, 15083.773743393858, 15105.773413398807, 15115.848841511664, 15117.848821511645, 9783.853242201372, 11460.828087578526, 11793.233439826385, 12703.0, 12817.35913204336, 7616.695332186761, 7804.765857024298, 7822.374210063182, 7885.881711774328, 7963.482373645695, 3236.482162853932, 3282.14664187313, 3287.5726155600096, 3312.403767321857, 3319.71782398494, 932.3380399916, 957.760559860035, 961.5192403798101, 1010.7372083258259, 1017.872765904262, 26955.460890782073, 28949.421011579652, 29322.0, 30210.917496089754, 30320.938767143485, 1043.7129789308, 1075.0324707763075, 1104.779044191165, 1141.5433826469311, 1150.3155622404656, 15437.536873893801, 15444.996075255072, 15459.845401545841, 15472.5358239253, 15859.682806343808, 690090.0, 696489.0, 696703.0, 696813.0, 697781.0, 47689.5231047692, 57257.42742572521, 57741.422585774446, 57857.0, 58008.8398232033, 1235.6849003504049, 1249.993750031244, 1367.883729882971, 1380.6824430381068, 1396.3786115178648, 29859.402811944074, 30315.468570204725, 30934.917277895165, 31107.222319442197, 31567.052988410385, 47262.76368618135, 47719.0, 47837.28244076272, 47856.282155766996, 47894.5210547904, 463242.0, 541777.0, 545301.0, 546548.0, 892018.0, 40332.99167520835, 40480.98797530085, 40968.15643295999, 41035.58964410318, 41150.38274425826, 44903.0, 45484.77257613691, 45546.0, 45974.54025459837, 46077.30884036809, 32198.678013220506, 34619.78830740912, 37861.05347366338, 37985.0, 38170.854874352706, 36960.445593315584, 37543.62456375401, 37578.812105939294, 37651.246975060894, 37937.62062379341, 35967.100822479646, 36073.63926360703, 36312.0, 36333.0, 36370.0, 26655.933762650053, 33063.66936330606, 33065.0, 34014.319713606084, 34112.14719632029, 25236.49527009413, 25260.74739252584, 25548.48903021892, 26055.609165862148, 26673.33316667099], "value": 18976.167145337076, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.6670063287029, 354.5585745746546, 378.5892306847071, 388.74537178148313, 406.46549787030074, 15041.323140458679, 15052.548423547298, 16401.589960250985, 20787.68818467724, 20811.791882081176, 16303.592410189722, 19552.511187220327, 19656.508587285323, 20252.89873550634, 20619.793802061973, 5726.656400615955, 6025.0, 6027.0, 6028.547858910577, 6033.909491357633, 4165.58344165584, 4377.912441751163, 4398.8900277493, 5953.166556682068, 6013.51891848651, 4304.24675681756, 6398.712057957403, 6709.36261055199, 6720.227173875018, 6821.18145822502, 6537.411632953033, 6695.230048544431, 6751.088603038576, 6767.526273160881, 6799.252082270947, 5537.473939975695, 5850.210221620112, 5894.145348924425, 5896.027155519334, 5899.823005309805, 21312.57374852494, 25033.0, 25454.618180727302, 25774.48451030969, 26076.087336943117, 1985.7815640279557, 2382.225776622587, 2450.9387265318333, 2582.6642536470326, 2934.5158048921903, 12522.874771252262, 14772.55682329532, 15883.444079457164, 15939.884208105437, 16452.588685282844, 1458.5988853065385, 1858.5632376391536, 1910.3791267838008, 1948.4349538633778, 2020.464576887126, 116788.0, 119432.0, 126693.83265418345, 127350.0, 130983.0, 11267.323960562393, 11435.885641143483, 11453.370064646359, 11628.0, 11649.47577359021, 14691.0, 14701.705965880836, 14708.191049492167, 14710.779338309934, 14718.558443246506, 8421.19998600132, 8509.787255318543, 8532.786680333042, 8535.231829135284, 8594.957025214833, 8504.957475212585, 8505.234528892306, 8516.233538981522, 8617.741467755977, 8620.008698999696, 4539.773011349419, 4547.522510136388, 4575.748333841604, 4580.129775342674, 4622.9768851156205, 1571.9449819256272, 1772.2202231018312, 1820.479406073533, 1931.2371613212702, 1931.3819577735271, 818.6807145213371, 985.2561316206362, 1004.8392257238806, 1021.0759262867117, 1025.7435641089728, 21123.894380528305, 21386.572268554854, 21429.357119286447, 21511.67732484014, 21521.354359369245, 863.6558112693164, 920.2453987729997, 973.2846357926918, 991.5587563534158, 1009.9192064634811, 10978.12175025996, 11321.981021707921, 11436.485358158903, 11449.427528623535, 11489.310641361544, 641331.0, 645433.0, 652091.0, 656409.0, 659214.0, 143853.0, 147668.0, 148563.2571837134, 149366.0, 150156.24921875322, 949.1220620925616, 954.7040417470467, 965.0301447045674, 965.5992763003416, 967.7677357434305, 13907.860921391062, 18900.716489252947, 19854.907980061234, 20088.79911200869, 20480.795192047888, 39252.803735981135, 58930.0, 59728.40271597402, 60095.0, 60483.395166047776, 81903.0, 82128.94677633107, 83549.58225208835, 86596.0, 90277.0, 7782.377409807315, 7845.0, 7982.401319900914, 7996.080940574104, 8278.296344810518, 9010.189082982562, 11300.604478843201, 12076.154669173073, 12456.937715311366, 12473.438695258554, 10373.948130259301, 10502.632407865687, 10527.105196058115, 10773.461326933779, 10806.243562950833, 8538.658453661785, 10197.388156710622, 10389.324693894872, 10558.155347572329, 10728.570857165938, 10620.09729173029, 10763.515641796295, 10782.029617334478, 11031.22781405294, 11070.335779853234, 7032.2264550898335, 7579.696812127453, 7858.842823143391, 7950.920490795018, 8243.711470098518, 9600.85598716006, 10644.361338319726, 11106.000459958643, 11415.828762568402, 11864.11019173548], "value": 9689.050872677128, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.8684374984373, 1493.5295381954684, 1716.9656606867864, 1845.132787589834, 1920.16472834317, 8586.484810911343, 9136.903571571413, 9155.0, 9160.0, 9184.173424391804, 7916.525008499494, 8188.181181881809, 8192.262696357328, 8665.69670061548, 8856.601452934618, 2382.344855164835, 2417.153996101368, 2418.2019933422016, 2419.9395015124674, 2425.3936515871032, 2377.7741114594087, 2398.0767404549288, 2423.297243799296, 2423.6001059825107, 2426.1387207541334, 2408.421978725111, 2411.6020856558735, 2418.576749068906, 2424.224248240555, 2425.563398588253, 2376.156464455111, 2382.702162229721, 2390.2351247600773, 2390.318759153633, 2399.6160614301803, 2371.193794110011, 2397.1849571145895, 2399.5200959807935, 2401.903923843044, 2403.8076953843824, 8870.37907346486, 9065.501397423139, 9081.45511269326, 9102.0, 9102.590383432762, 5274.973625131888, 5450.836474905759, 5452.536534394581, 5453.727313634303, 5462.399136095027, 3511.2450823073164, 3623.0, 3678.503402040717, 3698.500702405168, 3705.573859006222, 1050.8528805967171, 1085.4355735017746, 1090.6237348114887, 1100.7908497385472, 1105.3865104866795, 12032.759344813056, 12051.517939282418, 12074.818877716842, 12111.87888121125, 12121.0, 4691.437027556715, 4725.199455897785, 4766.61867050642, 4889.975550122226, 4894.902101957941, 10235.437050962268, 10239.283250172566, 10249.026342497451, 10249.9487502562, 10263.897361026444, 4675.672702910763, 5361.08861493547, 5421.888512854855, 5445.83662490126, 5446.183072539151, 4239.194553034913, 4409.382686423904, 4583.381243532081, 4938.407391113089, 4959.355283813081, 3135.984320078385, 3947.921041579152, 4073.551909289976, 4082.4692789937117, 4096.283150448719, 1211.2490256041135, 1262.040848954801, 1268.207370393504, 1298.2016060122955, 1306.941187646558, 828.9088200297963, 833.4291010657719, 914.1635403605626, 916.6791622932054, 923.3905622289391, 5814.94185058144, 5849.707514624251, 6048.516118710492, 6091.878162436815, 6185.876282474415, 431.51454613559747, 943.7734943613483, 1028.1106842581114, 1050.3067975136373, 1059.597353005853, 3430.1939044324563, 3861.1119442528375, 3989.0130158872403, 4068.9013966228954, 4151.6886233532605, 10563.419011954262, 11023.338599683884, 11034.558617655364, 11084.279521831217, 11186.776264474665, 11129.554817807197, 11132.554697812158, 11140.610078647209, 11154.665360039211, 11156.330620162817, 8280.875786863202, 8344.290735287446, 8352.290055345364, 8452.915470845213, 8465.576721163918, 5790.0, 5833.241678581757, 5872.412758724094, 5996.850078748066, 6023.879522409439, 10235.385876847413, 10311.329763565343, 10369.0, 10393.324433912074, 10427.94786026065, 10171.84742228882, 10220.131288840532, 10356.585736570452, 10435.634752783617, 10661.0, 6691.297413771484, 6884.208316043519, 7131.215566287808, 7325.377342925911, 7327.303906128909, 8357.95821020891, 8637.093105223861, 8646.654133834576, 8743.0, 8745.431546949429, 7619.65711542993, 7755.069391673035, 7773.961130194313, 7818.140004599603, 7915.525068495908, 7425.925740742523, 7488.887666685113, 7539.886901696588, 7563.621818909142, 7667.233276672288, 7007.824804379931, 7154.356107950101, 7164.176119746087, 7168.068151140318, 7172.533785303938, 4972.403311602486, 5000.424951130666, 5026.44709082008, 5096.159133742891, 5132.3327967364, 4376.321670141006, 5012.147934851157, 5069.949300507095, 5178.8964220716125, 5218.504242096995], "value": 4652.505506767244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.2680194335538, 310.86322018311955, 313.61425446700565, 319.702676510845, 323.7086622040162, 5309.230161626562, 5416.343967821725, 5454.318210223722, 5500.367457742361, 5576.5259952904, 4009.7995100245016, 5053.332400307899, 5255.766299322782, 5288.471152884719, 5402.405735369116, 3507.754457187998, 4139.710220284582, 4141.647959923403, 4156.147989662127, 4167.833286668545, 3436.639152888948, 4155.148194620111, 4163.479565054368, 4187.1625674865145, 4202.201581699483, 4042.2117687051036, 4093.3246014407587, 4104.958950410502, 4127.339625659895, 4227.682923780713, 3439.673231043047, 4177.540470548237, 4186.811593478301, 4207.894802629943, 4210.642095421893, 2969.8218106913437, 3289.227031647561, 3607.4408466687705, 3631.909202269938, 3661.4507823826375, 4352.847650332224, 4933.519944016816, 5049.84850454487, 5293.947060529384, 5347.59893008022, 4753.857384278443, 4767.523247675239, 4774.424439934814, 4790.520947905182, 4829.879253018667, 4420.84527041552, 5575.163725441216, 5732.3121225453215, 5736.418611624786, 5747.540196784247, 3415.8121303328307, 3661.5240018797654, 4024.879253622367, 4025.3760667096353, 4041.2321658884716, 5974.924513587553, 6020.548458865603, 6025.608335458225, 6051.667158306292, 6092.817215483498, 3959.3269144244973, 3960.20795840833, 3961.2473630010204, 3968.8214030368704, 3981.7411868228473, 4035.3139966205817, 4043.0094626816617, 4043.4137050127565, 4043.8584649537124, 4044.15072834708, 4178.310578754472, 4363.869083927487, 4586.472555656075, 4606.0, 4671.789769460383, 5673.914891276634, 5702.942970570324, 5713.371529131792, 5755.107958266475, 5765.308163020464, 1223.3149436315691, 1298.9285589292679, 1340.3901224942629, 1368.4252613902186, 1381.7581923163407, 803.0, 861.9267362274277, 919.3013309884536, 920.9171174594319, 932.7901222225081, 5326.840194794162, 5335.279737235423, 5344.412114667383, 5359.464053594687, 5421.593380496479, 5604.861277684428, 5612.915806262909, 5872.590578261272, 5925.496332811673, 5957.650914832197, 5181.093308670967, 5291.365036195682, 5317.8936421271355, 5370.70461124634, 5374.381946076173, 2600.8439493630062, 2643.867806609662, 2702.7702395410042, 2724.523208438515, 2775.4726601945567, 4533.569310915458, 5060.0, 5804.506616937523, 5964.047796340839, 6042.939570604238, 5125.513076257749, 5143.459936706592, 5834.970825145932, 6106.114613381035, 6168.722407491584, 5143.485651434827, 6169.691515424211, 6204.0, 6240.563160578716, 6273.560850740496, 5374.4625537445945, 5651.773929042793, 5683.943160568341, 5943.167956486009, 5949.018411961978, 5860.7729062955805, 5867.882642347215, 5938.435848594377, 5972.283326000907, 6102.237220347457, 5353.839384818461, 5753.827385178452, 5831.77532718134, 5995.970020149872, 6155.292141403616, 3629.147150419702, 3961.6632586230494, 3964.821583028713, 3988.880333589997, 3992.3811809169624, 5749.051406517878, 5916.349201587908, 5959.880802384015, 5985.431384018511, 6023.45788879003, 5422.48486393792, 5742.684152371659, 5767.913481297868, 5873.530117590668, 5873.647581145145, 5702.372738998624, 5710.857228569319, 5755.424457554211, 5762.625429347079, 5776.7400466979925, 4845.830395936126, 5125.743712814419, 5129.333186685707, 5436.71078997201, 5611.831645050655, 5515.841673248663, 5636.408177141505, 5806.796762113306, 5823.563232757645, 5841.69943981649, 5238.790448382022, 5277.788888444573, 5656.151577263279, 5702.40124786908, 5719.311044376437], "value": 4184.450456618822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.7091115364816, 742.9405647548197, 788.5505262000655, 822.7449490657895, 839.7522730794415, 13139.605811825637, 15023.849761502383, 16367.345306187739, 16508.422205222818, 16658.1670916454, 14959.551213463614, 15076.849231507682, 15077.698446031072, 15086.245687715598, 15089.547313580582, 700.5866538742141, 866.514751739025, 890.5814267294394, 891.6477991193475, 895.9696349198441, 721.982005372425, 732.7105793211679, 757.8863170524438, 881.4402854187605, 891.5141248019845, 870.268974061788, 907.2605826251616, 916.083916083916, 919.0946917286501, 925.6390007896925, 909.4770506958525, 911.9452832830018, 912.297530901209, 912.3522299167565, 913.9908600913973, 543.5054100768322, 563.8533981164927, 567.3815541060264, 570.6347937320119, 571.7198572699348, 12417.93791031048, 14653.194074325907, 15214.391424343014, 15517.612059698486, 15547.766783498257, 14351.354189061518, 14794.260286985607, 14828.70342593153, 14847.331870065873, 15117.54647360581, 11094.833577496343, 11644.301341919512, 11675.0, 11944.343061131634, 11997.400129993553, 3862.864799731996, 3881.6700580450697, 3889.4165875118674, 4007.8797636070963, 4032.8790136295665, 122464.0, 126081.73918260791, 127378.0, 128289.35855320757, 128831.0, 11244.55021799119, 11268.985791278825, 11375.0, 11385.772284554263, 11540.826887596693, 17209.827901720822, 17456.389026384015, 22243.777562224495, 22453.989570469366, 22585.209517666804, 8061.4760040597175, 8148.918510814935, 8249.670013199404, 8262.008558972962, 8342.0, 4250.723702959298, 4437.778111094497, 4445.555444455593, 4458.420405347349, 4467.687261891637, 3567.7502574819514, 3686.170611612419, 3706.4625629283605, 3708.332500149999, 3714.201446688921, 574.6609500394703, 652.3052948609716, 668.0547025958311, 680.5474359550942, 680.7515256931184, 594.3165359836137, 618.9566730328834, 640.4044238857907, 667.6127845849396, 677.4512644757664, 8564.400491965502, 9407.576659050359, 10008.649697260707, 10286.537105830255, 10429.165666746794, 558.0930987145888, 573.3148887079899, 620.3052581109187, 650.7494614573424, 672.468749687751, 4019.577944315863, 4113.382992551082, 4469.597736203692, 4649.703729522509, 4769.689970151929, 132073.0, 133194.0, 133198.0, 158274.2086289561, 168730.0, 98584.50707746415, 107444.0, 121009.0, 125959.11061334088, 136663.31668341794, 115231.0, 116025.41987290178, 116627.8337216634, 117462.0, 121470.1779473291, 8669.959604847207, 9453.574589143367, 10177.542010609392, 10220.131288840234, 10278.537465814206, 61859.762804744554, 62417.0, 63383.6830815843, 64278.53632441295, 66724.0, 92576.0, 97715.0, 98212.0, 101237.0, 101523.9847601544, 11498.367589782642, 12550.874491255336, 12669.683257918627, 12686.492540298654, 13766.793498097337, 13710.314484275947, 14557.199354035207, 15077.623059423602, 16014.519564413085, 16175.352985880432, 12161.87838121643, 14511.492097776527, 14608.78086828677, 14906.925465372604, 15085.094894305937, 13933.442662293395, 14062.929685351508, 14126.717465650834, 14209.644758881112, 14210.715785684435, 10942.17933654963, 13038.348082596021, 13271.402786874807, 13529.323533823466, 13647.590572282847, 10888.945555272174, 11122.98824164088, 11130.499127539118, 11876.940615297213, 12036.458359374024, 10989.285696429706, 11559.826602600799, 11737.530498779954, 11779.941100294443, 11864.584739534075], "value": 7890.975349878435, "unit": "score"}], "name": "dromaeo_css", "value": 7371.108567420349, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 120.0, 163.0, 161.0, 112.0, 112.0, 114.0, 113.0, 112.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 142.0, 171.0, 139.0, 108.0, 110.0, 108.0, 145.0, 136.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 182.0, 183.0, 186.0, 181.0, 182.0, 182.0, 181.0, 179.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 57.0, 90.0, 83.0, 86.0, 75.0, 57.0, 81.0, 58.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 94.0, 70.0, 68.0, 70.0, 91.0, 68.0, 70.0, 106.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 88.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 150.0, 88.0, 148.0, 151.0, 93.0, 92.0, 92.0, 93.0, 93.0], "value": 111.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 83.0, 86.0, 83.0, 84.0, 85.0, 85.0, 86.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 56.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 73.0, 70.0, 74.0, 69.0, 73.0, 69.0, 70.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 100.0, 75.0, 81.0, 78.0, 81.0, 84.0, 82.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 141.0, 148.0, 146.0, 137.0, 143.0, 151.0, 127.0, 169.0, 137.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 161.0, 226.0, 158.0, 199.0, 223.0, 167.0, 163.0, 162.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 64.0, 64.0, 67.0, 67.0, 66.0, 65.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1472.9000000000003, "alertThreshold": 2.0}]} 04:16:15 INFO - Return code: 0 04:16:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:16:15 INFO - # TBPL SUCCESS # 04:16:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:16:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:16:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:16:15 INFO - 2016-10-20 04:16:15.998 screenresolution[1807:9945] starting screenresolution argv=screenresolution get 04:16:16 INFO - 2016-10-20 04:16:16.000 screenresolution[1807:9945] Display 0: 1600x1200x32@60 04:16:16 INFO - 2016-10-20 04:16:16.006 screenresolution[1808:9948] starting screenresolution argv=screenresolution list 04:16:16 INFO - Available Modes on Display 0 04:16:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:16:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:16:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:16:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:16:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:16:16 INFO - Intel Iris: 04:16:16 INFO - Chipset Model: Intel Iris 04:16:16 INFO - Type: GPU 04:16:16 INFO - Bus: Built-In 04:16:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:16:16 INFO - Vendor: Intel (0x8086) 04:16:16 INFO - Device ID: 0x0a2e 04:16:16 INFO - Revision ID: 0x0009 04:16:16 INFO - Displays: 04:16:16 INFO - Display: 04:16:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:16:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:16:16 INFO - Display Serial Number: 1600x1200 60 04:16:16 INFO - Main Display: Yes 04:16:16 INFO - Mirror: Off 04:16:16 INFO - Online: Yes 04:16:16 INFO - Rotation: Supported 04:16:16 INFO - Return code: 0 04:16:16 INFO - Running post-action listener: _resource_record_post_action 04:16:16 INFO - [mozharness: 2016-10-20 11:16:16.241670Z] Finished run-tests step (success) 04:16:16 INFO - Running post-run listener: _resource_record_post_run 04:16:16 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37512192; Write bytes: 664882176; Read time: 238; Write time: 1958 04:16:16 INFO - TinderboxPrint: CPU usage
53.4% 04:16:16 INFO - TinderboxPrint: I/O read bytes / time
37,512,192 / 238 04:16:16 INFO - TinderboxPrint: I/O write bytes / time
664,882,176 / 1,958 04:16:16 INFO - TinderboxPrint: CPU idle
2,253.6 (46.6%) 04:16:16 INFO - TinderboxPrint: CPU system
968.2 (20.0%) 04:16:16 INFO - TinderboxPrint: CPU user
1,615.7 (33.4%) 04:16:16 INFO - TinderboxPrint: Swap in / out
400,777,216 / 0 04:16:16 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 349725184; Write bytes: 345650688; Read time: 26473; Write time: 732 04:16:16 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36557824; Write bytes: 298092032; Read time: 225; Write time: 1167 04:16:16 INFO - Running post-run listener: _upload_blobber_files 04:16:16 INFO - Blob upload gear active. 04:16:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:16:16 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 04:16:16 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:16:16 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:16:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:18 INFO - (blobuploader) - INFO - Done attempting. 04:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:19 INFO - (blobuploader) - INFO - Done attempting. 04:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:21 INFO - (blobuploader) - INFO - Done attempting. 04:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:21 INFO - Return code: 0 04:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a93c3953222dbc179e79192b3611a8488ea3aaa4b15dbd90351ce6c7c54b93a46d1edce85bd1dafe39184f8ef6f7adee79205a6eff71ed85f88b8ed324a0bf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f30fdabfed3f0b65fd5d3e0433634f7eb1894ceeb25126e4d4429a297bffe92c6d0b588f3ef07d04907bbfec9a89130b9c42d32e6c39a5864cc785d8b3c036b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2df23a70de05af85203a818c92a0965ab0654074ec66ad6179e596e72b929cc71c40f1510cb7e4f6a612431bc8baac5d9211795f52c157d0c4dbf9fa2ac8b6e"} 04:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:16:21 INFO - Contents: 04:16:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a93c3953222dbc179e79192b3611a8488ea3aaa4b15dbd90351ce6c7c54b93a46d1edce85bd1dafe39184f8ef6f7adee79205a6eff71ed85f88b8ed324a0bf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f30fdabfed3f0b65fd5d3e0433634f7eb1894ceeb25126e4d4429a297bffe92c6d0b588f3ef07d04907bbfec9a89130b9c42d32e6c39a5864cc785d8b3c036b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2df23a70de05af85203a818c92a0965ab0654074ec66ad6179e596e72b929cc71c40f1510cb7e4f6a612431bc8baac5d9211795f52c157d0c4dbf9fa2ac8b6e"} 04:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:16:21 INFO - Copying logs to upload dir... 04:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.105238 ========= master_lag: 1.45 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-20 04:16:22.863298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 04:16:22.870415) ========= 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.AaCudFw4jG/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.9IP2Vis1yC/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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/Mozilla-Aurora/sha512/1a93c3953222dbc179e79192b3611a8488ea3aaa4b15dbd90351ce6c7c54b93a46d1edce85bd1dafe39184f8ef6f7adee79205a6eff71ed85f88b8ed324a0bf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f30fdabfed3f0b65fd5d3e0433634f7eb1894ceeb25126e4d4429a297bffe92c6d0b588f3ef07d04907bbfec9a89130b9c42d32e6c39a5864cc785d8b3c036b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2df23a70de05af85203a818c92a0965ab0654074ec66ad6179e596e72b929cc71c40f1510cb7e4f6a612431bc8baac5d9211795f52c157d0c4dbf9fa2ac8b6e"} build_url:https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010916 build_url: 'https://queue.taskcluster.net/v1/task/XCGsII1dQDiHlf6XIKu3rQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a93c3953222dbc179e79192b3611a8488ea3aaa4b15dbd90351ce6c7c54b93a46d1edce85bd1dafe39184f8ef6f7adee79205a6eff71ed85f88b8ed324a0bf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f30fdabfed3f0b65fd5d3e0433634f7eb1894ceeb25126e4d4429a297bffe92c6d0b588f3ef07d04907bbfec9a89130b9c42d32e6c39a5864cc785d8b3c036b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2df23a70de05af85203a818c92a0965ab0654074ec66ad6179e596e72b929cc71c40f1510cb7e4f6a612431bc8baac5d9211795f52c157d0c4dbf9fa2ac8b6e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 04:16:22.914809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:16:22.915145) ========= 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.AaCudFw4jG/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.9IP2Vis1yC/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.005161 ========= master_lag: 0.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:16:23.175753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 04:16:23.176094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 04:16:23.176562) ========= ========= Total master_lag: 1.81 =========