builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0095 starttime: 1476387261.04 results: success (0) buildid: 20161013102025 builduid: 1bbe533c04454b6d883d9602a678adb1 revision: 28cea4babaf878d6ea5bfd19be4ac0aeef38d154 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.040882) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.041375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.041725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.065945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.066406) ========= 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.yhHCI0NyxD/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.CKTiwz52OH/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-13 12:34:21-- 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% 9.69M=0.001s 2016-10-13 12:34:21 (9.69 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086702 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.175459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.175764) ========= 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.yhHCI0NyxD/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.CKTiwz52OH/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.030139 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:21.225544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 12:34:21.226000) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 28cea4babaf878d6ea5bfd19be4ac0aeef38d154 --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 28cea4babaf878d6ea5bfd19be4ac0aeef38d154 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yhHCI0NyxD/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.CKTiwz52OH/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-13 12:34:21,299 truncating revision to first 12 chars 2016-10-13 12:34:21,299 Setting DEBUG logging. 2016-10-13 12:34:21,299 attempt 1/10 2016-10-13 12:34:21,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/28cea4babaf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 12:34:22,411 unpacking tar archive at: mozilla-aurora-28cea4babaf8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.389986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 12:34:22.637786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:22.638214) ========= script_repo_revision: 28cea4babaf878d6ea5bfd19be4ac0aeef38d154 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:22.638644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:22.638924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 12:34:22.656935) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-13 12:34:22.657289) ========= /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.yhHCI0NyxD/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.CKTiwz52OH/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:34:22 INFO - MultiFileLogger online at 20161013 12:34:22 in /builds/slave/test 12:34:22 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 12:34:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:22 INFO - {'append_to_log': False, 12:34:22 INFO - 'base_work_dir': '/builds/slave/test', 12:34:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:34:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:22 INFO - 'branch': 'Mozilla-Aurora', 12:34:22 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:22 INFO - 'config_files': ('talos/mac_config.py',), 12:34:22 INFO - 'default_actions': ('clobber', 12:34:22 INFO - 'read-buildbot-config', 12:34:22 INFO - 'download-and-extract', 12:34:22 INFO - 'populate-webroot', 12:34:22 INFO - 'create-virtualenv', 12:34:22 INFO - 'install', 12:34:22 INFO - 'run-tests'), 12:34:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:22 INFO - 'download_minidump_stackwalk': True, 12:34:22 INFO - 'download_symbols': 'ondemand', 12:34:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:22 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:22 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:22 INFO - 'installer_path': 'installer.exe', 12:34:22 INFO - 'log_level': 'info', 12:34:22 INFO - 'log_name': 'talos', 12:34:22 INFO - 'log_to_console': True, 12:34:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:34:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:34:22 INFO - 'opt_config_files': (), 12:34:22 INFO - 'pip_index': False, 12:34:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:34:22 INFO - 'cmd': ('bash', 12:34:22 INFO - '-c', 12:34:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:34:22 INFO - 'enabled': True, 12:34:22 INFO - 'halt_on_failure': False, 12:34:22 INFO - 'name': 'check_screen_resolution'},), 12:34:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:34:22 INFO - 'cmd': ('bash', 12:34:22 INFO - '-c', 12:34:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:34:22 INFO - 'enabled': True, 12:34:22 INFO - 'halt_on_failure': False, 12:34:22 INFO - 'name': 'check_screen_resolution'},), 12:34:22 INFO - 'run_cmd_checks_enabled': True, 12:34:22 INFO - 'sps_profile': False, 12:34:22 INFO - 'sps_profile_interval': 0, 12:34:22 INFO - 'suite': 'dromaeojs', 12:34:22 INFO - 'system_bits': '32', 12:34:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:22 INFO - 'title': 't-yosemite-r7-0095', 12:34:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:22 INFO - 'use_talos_json': True, 12:34:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:22 INFO - 'work_dir': 'build'} 12:34:22 INFO - [mozharness: 2016-10-13 19:34:22.854762Z] Running clobber step. 12:34:22 INFO - Running pre-action listener: _resource_record_pre_action 12:34:22 INFO - Running main action method: clobber 12:34:22 INFO - rmtree: /builds/slave/test/build 12:34:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:25 INFO - Running post-action listener: _resource_record_post_action 12:34:25 INFO - [mozharness: 2016-10-13 19:34:25.064822Z] Finished clobber step (success) 12:34:25 INFO - [mozharness: 2016-10-13 19:34:25.065077Z] Running read-buildbot-config step. 12:34:25 INFO - Running pre-action listener: _resource_record_pre_action 12:34:25 INFO - Running main action method: read_buildbot_config 12:34:25 INFO - Using buildbot properties: 12:34:25 INFO - { 12:34:25 INFO - "project": "", 12:34:25 INFO - "product": "firefox", 12:34:25 INFO - "script_repo_revision": "production", 12:34:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:34:25 INFO - "repository": "", 12:34:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:34:25 INFO - "buildid": "20161013102025", 12:34:25 INFO - "pgo_build": "False", 12:34:25 INFO - "basedir": "/builds/slave/test", 12:34:25 INFO - "buildnumber": 51, 12:34:25 INFO - "slavename": "t-yosemite-r7-0095", 12:34:25 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:34:25 INFO - "platform": "yosemite_r7", 12:34:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:34:25 INFO - "branch": "mozilla-aurora", 12:34:25 INFO - "repo_path": "releases/mozilla-aurora", 12:34:25 INFO - "revision": "28cea4babaf878d6ea5bfd19be4ac0aeef38d154", 12:34:25 INFO - "stage_platform": "macosx64", 12:34:25 INFO - "builduid": "1bbe533c04454b6d883d9602a678adb1", 12:34:25 INFO - "slavebuilddir": "test" 12:34:25 INFO - } 12:34:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:34:25 INFO - Running post-action listener: _resource_record_post_action 12:34:25 INFO - [mozharness: 2016-10-13 19:34:25.070465Z] Finished read-buildbot-config step (success) 12:34:25 INFO - [mozharness: 2016-10-13 19:34:25.070691Z] Running download-and-extract step. 12:34:25 INFO - Running pre-action listener: _resource_record_pre_action 12:34:25 INFO - Running main action method: download_and_extract 12:34:25 INFO - mkdir: /builds/slave/test/build/tests 12:34:25 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')]} 12:34:25 INFO - trying https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:34:25 INFO - Downloading https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/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 12:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/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 12:34:26 INFO - Downloaded 1199 bytes. 12:34:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:34:26 INFO - Using the following test package requirements: 12:34:26 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:34:26 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:34:26 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:34:26 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'jsshell-mac.zip'], 12:34:26 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:34:26 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:34:26 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:34:26 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:34:26 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:34:26 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:34:26 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:34:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:34:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:34:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:34:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:34:26 INFO - Expected file size: 16435236 12:34:33 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 12:34:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:34:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:34:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:34:34 INFO - Expected file size: 16435236 12:34:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:34:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:34:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:34:42 INFO - Expected file size: 14414059 12:34: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')]} 12:34:43 INFO - trying https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:34:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/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 12:34:46 INFO - Downloaded 115367433 bytes. 12:34:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:34:46 INFO - mkdir: /builds/slave/test/properties 12:34:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:46 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:46 INFO - Contents: 12:34:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:34:46 INFO - Running post-action listener: _resource_record_post_action 12:34:46 INFO - Running post-action listener: set_extra_try_arguments 12:34:46 INFO - [mozharness: 2016-10-13 19:34:46.827813Z] Finished download-and-extract step (success) 12:34:46 INFO - [mozharness: 2016-10-13 19:34:46.827931Z] Running populate-webroot step. 12:34:46 INFO - Running pre-action listener: _resource_record_pre_action 12:34:46 INFO - Running main action method: populate_webroot 12:34:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:46 INFO - '--tppagecycles', 12:34:46 INFO - '7'], 12:34:46 INFO - 'tests': ['tsvgm']}}, 12:34:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:34:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:34:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['damp', 'tps']}, 12:34:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'tests': ['damp', 'tps']}, 12:34:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['dromaeo_dom']}, 12:34:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['basic_compositor_video']}, 12:34:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:34:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['a11yr', 12:34:46 INFO - 'ts_paint', 12:34:46 INFO - 'tpaint', 12:34:46 INFO - 'sessionrestore', 12:34:46 INFO - 'sessionrestore_no_auto_restore', 12:34:46 INFO - 'tabpaint']}, 12:34:46 INFO - 'other-e10s': {'tests': ['a11yr', 12:34:46 INFO - 'ts_paint', 12:34:46 INFO - 'tpaint', 12:34:46 INFO - 'sessionrestore', 12:34:46 INFO - 'sessionrestore_no_auto_restore', 12:34:46 INFO - 'tabpaint']}, 12:34:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:34:46 INFO - 'ts_paint', 12:34:46 INFO - 'tpaint', 12:34:46 INFO - 'sessionrestore', 12:34:46 INFO - 'sessionrestore_no_auto_restore', 12:34:46 INFO - 'tabpaint']}, 12:34:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:34:46 INFO - 'ts_paint', 12:34:46 INFO - 'tpaint', 12:34:46 INFO - 'sessionrestore', 12:34:46 INFO - 'sessionrestore_no_auto_restore', 12:34:46 INFO - 'tabpaint']}, 12:34:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['a11yr', 12:34:46 INFO - 'ts_paint', 12:34:46 INFO - 'tpaint', 12:34:46 INFO - 'sessionrestore', 12:34:46 INFO - 'sessionrestore_no_auto_restore', 12:34:46 INFO - 'tabpaint']}, 12:34:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['a11yr', 12:34:46 INFO - 'ts_paint', 12:34:46 INFO - 'tpaint', 12:34:46 INFO - 'sessionrestore', 12:34:46 INFO - 'sessionrestore_no_auto_restore', 12:34:46 INFO - 'tabpaint']}, 12:34:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['tsvgx', 12:34:46 INFO - 'tsvgr_opacity', 12:34:46 INFO - 'tart', 12:34:46 INFO - 'tscrollx', 12:34:46 INFO - 'cart']}, 12:34:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:34:46 INFO - 'tsvgr_opacity', 12:34:46 INFO - 'tart', 12:34:46 INFO - 'tscrollx', 12:34:46 INFO - 'cart']}, 12:34:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'talos_options': ['--disable-e10s'], 12:34:46 INFO - 'tests': ['tp5o']}, 12:34:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'tests': ['tp5o']}, 12:34:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'talos_options': ['--disable-e10s', 12:34:46 INFO - '--xperf_path', 12:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:46 INFO - 'tests': ['tp5n']}, 12:34:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:46 INFO - 'talos_options': ['--xperf_path', 12:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:46 INFO - 'tests': ['tp5n']}}, 12:34:46 INFO - 'talos.zip': {'path': '', 12:34:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:46 INFO - Running post-action listener: _resource_record_post_action 12:34:46 INFO - [mozharness: 2016-10-13 19:34:46.846537Z] Finished populate-webroot step (success) 12:34:46 INFO - [mozharness: 2016-10-13 19:34:46.846645Z] Running create-virtualenv step. 12:34:46 INFO - Running pre-action listener: _resource_record_pre_action 12:34:46 INFO - Running main action method: create_virtualenv 12:34:46 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:46 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 12:34:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:46 INFO - Using real prefix '/tools/python27' 12:34:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:34:50 INFO - Installing pip.................done. 12:34:50 INFO - Return code: 0 12:34:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:34: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', 'pip>=1.5'] in /builds/slave/test/build 12:34: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 pip>=1.5 12:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:50 INFO - 'HOME': '/Users/cltbld', 12:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:50 INFO - 'LOGNAME': 'cltbld', 12:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:50 INFO - 'MOZ_NO_REMOTE': '1', 12:34:50 INFO - 'NO_EM_RESTART': '1', 12:34:50 INFO - 'PAGER': '/bin/cat', 12:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:50 INFO - 'PWD': '/builds/slave/test', 12:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:50 INFO - 'SHELL': '/bin/bash', 12:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:34:50 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:50 INFO - 'USER': 'cltbld', 12:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:50 INFO - 'XPC_FLAGS': '0x0', 12:34:50 INFO - 'XPC_SERVICE_NAME': '0', 12:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:50 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 12:34:50 INFO - Cleaning up... 12:34:50 INFO - Return code: 0 12:34:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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', '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 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:34: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:34: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 psutil>=3.1.1 12:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:50 INFO - 'HOME': '/Users/cltbld', 12:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:50 INFO - 'LOGNAME': 'cltbld', 12:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:50 INFO - 'MOZ_NO_REMOTE': '1', 12:34:50 INFO - 'NO_EM_RESTART': '1', 12:34:50 INFO - 'PAGER': '/bin/cat', 12:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:50 INFO - 'PWD': '/builds/slave/test', 12:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:50 INFO - 'SHELL': '/bin/bash', 12:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:34:50 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:50 INFO - 'USER': 'cltbld', 12:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:50 INFO - 'XPC_FLAGS': '0x0', 12:34:50 INFO - 'XPC_SERVICE_NAME': '0', 12:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:51 INFO - Downloading/unpacking psutil>=3.1.1 12:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:54 INFO - Installing collected packages: psutil 12:34:54 INFO - Running setup.py install for psutil 12:34:54 INFO - building 'psutil._psutil_osx' extension 12:34:54 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 12:34:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:34:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:34:55 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 12:34:55 INFO - building 'psutil._psutil_posix' extension 12:34:55 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 12:34:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:34:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:34:55 INFO - ^ 12:34:55 INFO - 1 warning generated. 12:34:55 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 12:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:55 INFO - Successfully installed psutil 12:34:55 INFO - Cleaning up... 12:34:55 INFO - Return code: 0 12:34:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:55 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 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:34:55 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 12:34:55 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 12:34:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:34:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:55 INFO - 'HOME': '/Users/cltbld', 12:34:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:55 INFO - 'LOGNAME': 'cltbld', 12:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:55 INFO - 'MOZ_NO_REMOTE': '1', 12:34:55 INFO - 'NO_EM_RESTART': '1', 12:34:55 INFO - 'PAGER': '/bin/cat', 12:34:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:55 INFO - 'PWD': '/builds/slave/test', 12:34:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:55 INFO - 'SHELL': '/bin/bash', 12:34:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:34:55 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:34:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:55 INFO - 'USER': 'cltbld', 12:34:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:55 INFO - 'XPC_FLAGS': '0x0', 12:34:55 INFO - 'XPC_SERVICE_NAME': '0', 12:34:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:34:58 INFO - Installing collected packages: mozsystemmonitor 12:34:58 INFO - Running setup.py install for mozsystemmonitor 12:34:58 INFO - Successfully installed mozsystemmonitor 12:34:58 INFO - Cleaning up... 12:34:58 INFO - Return code: 0 12:34:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:34:58 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')]} 12:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:58 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')]} 12:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:58 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 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:34:58 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 12:34:58 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 12:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:58 INFO - 'HOME': '/Users/cltbld', 12:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:58 INFO - 'LOGNAME': 'cltbld', 12:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:58 INFO - 'MOZ_NO_REMOTE': '1', 12:34:58 INFO - 'NO_EM_RESTART': '1', 12:34:58 INFO - 'PAGER': '/bin/cat', 12:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:58 INFO - 'PWD': '/builds/slave/test', 12:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:58 INFO - 'SHELL': '/bin/bash', 12:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:34:58 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:58 INFO - 'USER': 'cltbld', 12:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:58 INFO - 'XPC_FLAGS': '0x0', 12:34:58 INFO - 'XPC_SERVICE_NAME': '0', 12:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:59 INFO - Downloading/unpacking jsonschema==2.5.1 12:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:35:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 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 12:35:01 INFO - Downloading functools32-3.2.3-2.tar.gz 12:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:35:02 INFO - warning: no files found matching '*.txt' 12:35:02 INFO - no previously-included directories found matching 'build' 12:35:02 INFO - no previously-included directories found matching 'dist' 12:35:02 INFO - no previously-included directories found matching '.git*' 12:35:02 INFO - Installing collected packages: jsonschema, functools32 12:35:02 INFO - Running setup.py install for functools32 12:35:02 INFO - warning: no files found matching '*.txt' 12:35:02 INFO - no previously-included directories found matching 'build' 12:35:02 INFO - no previously-included directories found matching 'dist' 12:35:02 INFO - no previously-included directories found matching '.git*' 12:35:02 INFO - Successfully installed jsonschema functools32 12:35:02 INFO - Cleaning up... 12:35:02 INFO - Return code: 0 12:35:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:02 INFO - 'HOME': '/Users/cltbld', 12:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:02 INFO - 'LOGNAME': 'cltbld', 12:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:02 INFO - 'MOZ_NO_REMOTE': '1', 12:35:02 INFO - 'NO_EM_RESTART': '1', 12:35:02 INFO - 'PAGER': '/bin/cat', 12:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:02 INFO - 'PWD': '/builds/slave/test', 12:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:02 INFO - 'SHELL': '/bin/bash', 12:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:35:02 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:02 INFO - 'USER': 'cltbld', 12:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:02 INFO - 'XPC_FLAGS': '0x0', 12:35:02 INFO - 'XPC_SERVICE_NAME': '0', 12:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:35:02 INFO - Cleaning up... 12:35:02 INFO - Return code: 0 12:35:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:02 INFO - 'HOME': '/Users/cltbld', 12:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:02 INFO - 'LOGNAME': 'cltbld', 12:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:02 INFO - 'MOZ_NO_REMOTE': '1', 12:35:02 INFO - 'NO_EM_RESTART': '1', 12:35:02 INFO - 'PAGER': '/bin/cat', 12:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:02 INFO - 'PWD': '/builds/slave/test', 12:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:02 INFO - 'SHELL': '/bin/bash', 12:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:35:02 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:02 INFO - 'USER': 'cltbld', 12:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:02 INFO - 'XPC_FLAGS': '0x0', 12:35:02 INFO - 'XPC_SERVICE_NAME': '0', 12:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:02 INFO - Downloading/unpacking blobuploader==1.2.4 12:35: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 12:35: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 12:35: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 12:35: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 12:35: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 12:35: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 12:35:05 INFO - Downloading blobuploader-1.2.4.tar.gz 12:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:35:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:35:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:06 INFO - Downloading docopt-0.6.1.tar.gz 12:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:35:06 INFO - Installing collected packages: blobuploader, requests, docopt 12:35:06 INFO - Running setup.py install for blobuploader 12:35:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:35:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:35:06 INFO - Running setup.py install for requests 12:35:07 INFO - Running setup.py install for docopt 12:35:07 INFO - Successfully installed blobuploader requests docopt 12:35:07 INFO - Cleaning up... 12:35:07 INFO - Return code: 0 12:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:07 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')]} 12:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:07 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')]} 12:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:07 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 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:35:07 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 12:35:07 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 12:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:07 INFO - 'HOME': '/Users/cltbld', 12:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:07 INFO - 'LOGNAME': 'cltbld', 12:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:07 INFO - 'MOZ_NO_REMOTE': '1', 12:35:07 INFO - 'NO_EM_RESTART': '1', 12:35:07 INFO - 'PAGER': '/bin/cat', 12:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:07 INFO - 'PWD': '/builds/slave/test', 12:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:07 INFO - 'SHELL': '/bin/bash', 12:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:35:07 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:07 INFO - 'USER': 'cltbld', 12:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:07 INFO - 'XPC_FLAGS': '0x0', 12:35:07 INFO - 'XPC_SERVICE_NAME': '0', 12:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-t1Nbel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-4PlZE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-8Kwv9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-A_46LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Rz6Tbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-LNiJwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-7h19He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-7tQqY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Yodisu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-cbVz3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:08 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-nnHYBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QveuCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-nGRTOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-qlHj78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-z7DUAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-XoeUaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-vvxQPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:35:09 INFO - Running setup.py install for manifestparser 12:35:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:35:09 INFO - Running setup.py install for mozcrash 12:35:09 INFO - Running setup.py install for mozdebug 12:35:10 INFO - Running setup.py install for mozdevice 12:35:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Running setup.py install for mozfile 12:35:10 INFO - Running setup.py install for mozhttpd 12:35:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Running setup.py install for mozinfo 12:35:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Running setup.py install for mozInstall 12:35:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:35:10 INFO - Running setup.py install for mozleak 12:35:10 INFO - Running setup.py install for mozlog 12:35:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:35:11 INFO - Running setup.py install for moznetwork 12:35:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:35:11 INFO - Running setup.py install for mozprocess 12:35:11 INFO - Running setup.py install for mozprofile 12:35:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:35:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:35:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:35:11 INFO - Running setup.py install for mozrunner 12:35:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:35:11 INFO - Running setup.py install for mozscreenshot 12:35:11 INFO - Running setup.py install for moztest 12:35:12 INFO - Running setup.py install for mozversion 12:35:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:35:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:35:12 INFO - Cleaning up... 12:35:12 INFO - Return code: 0 12:35:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:12 INFO - 'HOME': '/Users/cltbld', 12:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:12 INFO - 'LOGNAME': 'cltbld', 12:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:12 INFO - 'MOZ_NO_REMOTE': '1', 12:35:12 INFO - 'NO_EM_RESTART': '1', 12:35:12 INFO - 'PAGER': '/bin/cat', 12:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:12 INFO - 'PWD': '/builds/slave/test', 12:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:12 INFO - 'SHELL': '/bin/bash', 12:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:35:12 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:12 INFO - 'USER': 'cltbld', 12:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:12 INFO - 'XPC_FLAGS': '0x0', 12:35:12 INFO - 'XPC_SERVICE_NAME': '0', 12:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:12 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Tc8w6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:12 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)) 12:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:12 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-UVbQrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:12 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)) 12:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:12 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-1VeKXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:12 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)) 12:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:12 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Hn3IXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:12 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)) 12:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:12 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-s7VPQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-SJY8L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-aPJV_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-vt4eld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-qJKalJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-1d1ArR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:13 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)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-S6dHvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:13 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)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-OXMQYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:13 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)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-aefNYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:13 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)) 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:13 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ekF47C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:14 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ixMDIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:14 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-M5HHyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:14 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-91VC3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:35:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:16 INFO - Downloading blessings-1.6.tar.gz 12:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:16 INFO - Installing collected packages: blessings 12:35:16 INFO - Running setup.py install for blessings 12:35:17 INFO - Successfully installed blessings 12:35:17 INFO - Cleaning up... 12:35:17 INFO - Return code: 0 12:35:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:17 INFO - Reading from file tmpfile_stdout 12:35:17 INFO - Current package versions: 12:35:17 INFO - blessings == 1.6 12:35:17 INFO - blobuploader == 1.2.4 12:35:17 INFO - docopt == 0.6.1 12:35:17 INFO - functools32 == 3.2.3-2 12:35:17 INFO - jsonschema == 2.5.1 12:35:17 INFO - manifestparser == 1.1 12:35:17 INFO - mozInstall == 1.12 12:35:17 INFO - mozcrash == 0.17 12:35:17 INFO - mozdebug == 0.1 12:35:17 INFO - mozdevice == 0.48 12:35:17 INFO - mozfile == 1.2 12:35:17 INFO - mozhttpd == 0.7 12:35:17 INFO - mozinfo == 0.9 12:35:17 INFO - mozleak == 0.1 12:35:17 INFO - mozlog == 3.4 12:35:17 INFO - moznetwork == 0.27 12:35:17 INFO - mozprocess == 0.23 12:35:17 INFO - mozprofile == 0.28 12:35:17 INFO - mozrunner == 6.12 12:35:17 INFO - mozscreenshot == 0.1 12:35:17 INFO - mozsystemmonitor == 0.3 12:35:17 INFO - moztest == 0.7 12:35:17 INFO - mozversion == 1.4 12:35:17 INFO - psutil == 3.1.1 12:35:17 INFO - requests == 1.2.3 12:35:17 INFO - wsgiref == 0.1.2 12:35:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:18 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 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:35:18 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 12:35:18 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 12:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:18 INFO - 'HOME': '/Users/cltbld', 12:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:18 INFO - 'LOGNAME': 'cltbld', 12:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:18 INFO - 'MOZ_NO_REMOTE': '1', 12:35:18 INFO - 'NO_EM_RESTART': '1', 12:35:18 INFO - 'PAGER': '/bin/cat', 12:35:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:18 INFO - 'PWD': '/builds/slave/test', 12:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:18 INFO - 'SHELL': '/bin/bash', 12:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:35:18 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:18 INFO - 'USER': 'cltbld', 12:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:18 INFO - 'XPC_FLAGS': '0x0', 12:35:18 INFO - 'XPC_SERVICE_NAME': '0', 12:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:35:18 INFO - Cleaning up... 12:35:18 INFO - Return code: 0 12:35:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a86a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7e0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa67bd6f580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, '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.yhHCI0NyxD/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.CKTiwz52OH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 12:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:18 INFO - 'HOME': '/Users/cltbld', 12:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:18 INFO - 'LOGNAME': 'cltbld', 12:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:18 INFO - 'MOZ_NO_REMOTE': '1', 12:35:18 INFO - 'NO_EM_RESTART': '1', 12:35:18 INFO - 'PAGER': '/bin/cat', 12:35:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:18 INFO - 'PWD': '/builds/slave/test', 12:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:18 INFO - 'SHELL': '/bin/bash', 12:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:35:18 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:18 INFO - 'USER': 'cltbld', 12:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:18 INFO - 'XPC_FLAGS': '0x0', 12:35:18 INFO - 'XPC_SERVICE_NAME': '0', 12:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:35:18 INFO - Cleaning up... 12:35:18 INFO - Return code: 0 12:35:18 INFO - Running post-action listener: _resource_record_post_action 12:35:18 INFO - Running post-action listener: _start_resource_monitoring 12:35:18 INFO - Starting resource monitoring. 12:35:18 INFO - [mozharness: 2016-10-13 19:35:18.861685Z] Finished create-virtualenv step (success) 12:35:18 INFO - [mozharness: 2016-10-13 19:35:18.862664Z] Running install step. 12:35:18 INFO - Running pre-action listener: _resource_record_pre_action 12:35:18 INFO - Running main action method: install 12:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:19 INFO - Reading from file tmpfile_stdout 12:35:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:19 INFO - Reading from file tmpfile_stdout 12:35:19 INFO - Output received: 12:35:19 INFO - Usage: mozinstall [options] installer 12:35:19 INFO - Options: 12:35:19 INFO - -h, --help show this help message and exit 12:35:19 INFO - -d DEST, --destination=DEST 12:35:19 INFO - Directory to install application into. [default: 12:35:19 INFO - "/builds/slave/test"] 12:35:19 INFO - --app=APP Application being installed. [default: firefox] 12:35:19 INFO - mkdir: /builds/slave/test/build/application 12:35:19 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'] 12:35:19 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 12:35:51 INFO - Reading from file tmpfile_stdout 12:35:51 INFO - Output received: 12:35:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:35:51 INFO - Running post-action listener: _resource_record_post_action 12:35:51 INFO - [mozharness: 2016-10-13 19:35:51.567112Z] Finished install step (success) 12:35:51 INFO - [mozharness: 2016-10-13 19:35:51.567252Z] Running run-tests step. 12:35:51 INFO - Running pre-action listener: _resource_record_pre_action 12:35:51 INFO - Running main action method: run_tests 12:35:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:35:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:35:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:35:51 INFO - 2016-10-13 12:35:51.580 screenresolution[1640:7776] starting screenresolution argv=screenresolution get 12:35:51 INFO - 2016-10-13 12:35:51.582 screenresolution[1640:7776] Display 0: 1600x1200x32@60 12:35:51 INFO - 2016-10-13 12:35:51.587 screenresolution[1641:7779] starting screenresolution argv=screenresolution list 12:35:51 INFO - Available Modes on Display 0 12:35:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:35:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:35:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:35:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:35:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:35:51 INFO - Intel Iris: 12:35:51 INFO - Chipset Model: Intel Iris 12:35:51 INFO - Type: GPU 12:35:51 INFO - Bus: Built-In 12:35:51 INFO - VRAM (Dynamic, Max): 1536 MB 12:35:51 INFO - Vendor: Intel (0x8086) 12:35:51 INFO - Device ID: 0x0a2e 12:35:51 INFO - Revision ID: 0x0009 12:35:51 INFO - Displays: 12:35:51 INFO - Display: 12:35:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:35:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:35:51 INFO - Display Serial Number: 1600x1200 60 12:35:51 INFO - Main Display: Yes 12:35:51 INFO - Mirror: Off 12:35:51 INFO - Online: Yes 12:35:51 INFO - Rotation: Supported 12:35:51 INFO - Return code: 0 12:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:51 INFO - Python 2.7.3 12:35:51 INFO - Return code: 0 12:35:51 INFO - grabbing minidump binary from tooltool 12:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:51 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 0x10a67ed30>, '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 0x10a4e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a676b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:51 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 12:35:51 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 12:35:51 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 12:35:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:51 INFO - Return code: 0 12:35:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:35:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:35:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:51 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/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 12:35:51 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/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0095 --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 12:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yhHCI0NyxD/Render', 12:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:51 INFO - 'HOME': '/Users/cltbld', 12:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:51 INFO - 'LOGNAME': 'cltbld', 12:35:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:51 INFO - 'MOZ_NO_REMOTE': '1', 12:35:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:51 INFO - 'NO_EM_RESTART': '1', 12:35:51 INFO - 'PAGER': '/bin/cat', 12:35:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:51 INFO - 'PWD': '/builds/slave/test', 12:35:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:51 INFO - 'SHELL': '/bin/bash', 12:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKTiwz52OH/Listeners', 12:35:51 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 12:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:51 INFO - 'USER': 'cltbld', 12:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:51 INFO - 'XPC_FLAGS': '0x0', 12:35:51 INFO - 'XPC_SERVICE_NAME': '0', 12:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:51 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/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 12:35:52 INFO - mozversion application_buildid: 20161013102025 12:35:52 INFO - mozversion application_changeset: 28cea4babaf878d6ea5bfd19be4ac0aeef38d154 12:35:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:35:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:52 INFO - mozversion application_name: Firefox 12:35:52 INFO - mozversion application_remotingname: firefox-dev 12:35:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:35:52 INFO - mozversion application_vendor: Mozilla 12:35:52 INFO - mozversion application_version: 51.0a2 12:35:52 INFO - mozversion platform_buildid: 20161013102025 12:35:52 INFO - mozversion platform_changeset: 28cea4babaf878d6ea5bfd19be4ac0aeef38d154 12:35:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:35:52 INFO - mozversion platform_version: 51.0a2 12:35:52 INFO - using testdate: 1476387352 12:35:52 INFO - actual date: 1476387352 12:35:52 INFO - starting webserver on 'localhost:49275' 12:35:52 INFO - SUITE-START | Running 2 tests 12:35:52 INFO - TEST-START | dromaeo_css 12:35:52 INFO - operating with platform_type : mac_ 12:35:52 INFO - Initialising browser for dromaeo_css test... 12:35:52 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpXdLYBq/profile http://localhost:49275/getInfo.html) 12:35:54 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 12:35:54 INFO - PROCESS | 1651 | colorDepth:24 12:35:54 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 12:35:54 INFO - PROCESS | 1651 | __metrics 12:35:54 INFO - PROCESS | 1651 | 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" 12:35:54 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:55 INFO - TEST-INFO | 1651: exit 0 12:35:55 INFO - Browser initialized. 12:35:55 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:55 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpXdLYBq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:07 INFO - PROCESS | 1653 | RSS: Main: 219136000 12:36:07 INFO - PROCESS | 1653 | 12:36:58 INFO - PROCESS | 1653 | 1476387418469 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] 12:39:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 12:39:12 INFO - PROCESS | 1653 | RSS: Main: 363134976 12:39:12 INFO - PROCESS | 1653 | 12:42:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 12:42:15 INFO - PROCESS | 1653 | RSS: Main: 350306304 12:42:15 INFO - PROCESS | 1653 | 12:45:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 12:45:18 INFO - PROCESS | 1653 | RSS: Main: 327483392 12:45:18 INFO - PROCESS | 1653 | 12:48:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 12:48:21 INFO - PROCESS | 1653 | RSS: Main: 317517824 12:48:21 INFO - PROCESS | 1653 | 12:51:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 12:51:25 INFO - PROCESS | 1653 | RSS: Main: 311427072 12:51:25 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 12:54:28 INFO - PROCESS | 1653 | RSS: Main: 417349632 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | __start_tp_report 12:54:28 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 12:54:28 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 12:54:28 INFO - PROCESS | 1653 | |i|pagename|runs| 12:54:28 INFO - PROCESS | 1653 | |0;dojo.html;3335.8832440864576;3351.363240984213;3386.0011296667467;3419.1281223288056;3423.0244380351587;5798.623089499185;5910.645361278326;5952.583319167655;5954.583179177459;5961.105834124884;5867.178594996704;5941.257342832146;5960.254968128984;5963.552733544991;5982.521398288138;4590.737547174537;5185.766640501177;5209.114450543398;5270.947290527084;5318.521333080022;5252.579793616502;5257.605679574028;5366.275552800381;5374.3013408256875;5382.838514844561;5201;5284.128118860383;5296.311479507659;5316.946830531684;5330.92003619946;5316.494932981361;5334.626576139672;5380.085385484477;5391.406945236021;5398.13629819227;5223;5314.1497360422145;5351.946480535184;5352.330958630171;5378.300820893259;5680.886382272372;5738.540916726652;5744.253247077895;5775;5780.335261444946;6161.045038019114;6249.78125765596;6250;6263.091851681481;6269.843253918643;6209.913265178576;6270.122182894398;6283;6293.622382657055;6304.747810087591;5766.308043034821;5832.12518122285;5865.560082993792;5934.198883150806;5968.4031596840405;6339.334369891188;6363.395477429637;6371.39471750183;6377.74489020434;6387.520935929824;5202.557782588447;6211.3478084801345;6247.625142491465;6261.7182226799905;6269.96865015672;6180.7527698891545;6192.442680158807;6221.688915554204;6251.937480625135;6258.186435763321;6203.31763506014;6222.595531290452;6236.688165591702;6245.437910587978;6258.812235632939;5972.850678733066;6156.938430615726;6218.098375735493;6262.1859158310035;6265.592736472206;4910.8281210157475;4950.084234416644;4976.402831660224;4992.600591952635;5032.496750325012;4404.977975110168;4440.844570440084;4446.488653804854;4450.844220452269;4520.706154099973;5787.942120578825;5788.0449725795615;5788.450097240755;5796.188533605298;5803.970980145156;6155.876882462326;6247.562670613104;6249.312575616678;6263.4362907338555;6266.905996410058;4794.568488836021;5906;5909.054551271776;5917.023691090922;5932.228810254639;5437.048516509595;5450.781968721286;5469.097598896137;5492.313460817398;5500.917486237709;6426.132472116298;6442.162518872517;6446.387593178641;6451.161349024596;6470.158879345655;5246.76389562463;6260.123582698335;6262.937370626236;6269.968650156902;6281.654509002049;6204.565680402509;6249.78125765596;6449.9355006451215;6450.612963222222;6466.967665161644;6166.013437849922;6198;6218.284897236876;6261.530385221035;6268.27914789805;5608.635438696471;6171.074338849208;6224.346443623354;6233.937660623517;6248.937510624835;6090.634561926298;6121.204243448323;6176.382361763967;6191.659458729813;6227.06594010902;6125.23545181825;6129.601575897731;6135.877282454415;6178.165947597017;6180.289266734383;6095.217231112331;6096.62825864177;6117.174181485442;6140.324564298013;6142.447179753844;6175.135481032748;6181.289151747606;6184.536159788124;6216.813495595139;6224.62652240867;5932.940670593239;6011.21854158974;6079.969600151971;6086.7260973255425;6092.817215483543 12:54:28 INFO - PROCESS | 1653 | |1;ext.html;472.73290590816185;521.4681025354137;528.9312389389379;532.7203218310386;560.7411361493448;26079.95680172793;38940.83177504676;40678.389824152626;40785.59214407855;43678.78160609193;38141.80929095358;38339;38720.419193712114;38728;38879.80560097196;8331.166883311666;8632.007319158283;9828.508574571279;9866.408015519057;9881.555330010167;8714.912850871506;8909.866352004725;8923.553822308859;8938.687145949893;11813.350265735382;11003.449827508633;11404.486798094105;11820.822687659693;12225.449854756513;12261.570845020426;12145.635630931087;12196.085293603015;12198.207116537485;12222.938885305517;12263.754724905497;11916.940415297955;11950.820737688942;11972.521099156023;11995.700107497296;12013.639590812203;39890.40164397536;40120.79939600312;40171;40185.59814401848;40244.195116097806;3247.7401807855313;3332.41682705528;3785;4008.9198216035807;4022.517297924268;30508.694913050807;30668;31344;31549.053528394186;32458.675413246037;3223.161977885743;3259.6251431085493;3271.9509207361907;3276.1645780326103;3352.860027590631;536326;537887;538429;539270;539696.3015184938;33313;33416;33762.83118584391;63078.68460657667;63428.36571634317;34254.14364640854;34327.65672343295;34328;35585.82207088948;35805;15066.924665376602;15248.771268430983;15265.542033739006;15273.923630381776;15322.923385383001;12735.617931462071;12803.231806091664;12823.29471879037;12847.935760321325;12910.096293259381;7297.452691048193;7374.815629609303;7666.769996900102;7725.420593455513;7800.024996875391;3227.8063316200632;3270.73834093272;3272.3946069977133;3295.638448782229;3303.5209894565633;939.3002213351098;965.56066989521;965.75856035991;969.3699095587924;990.6384169778123;29018.27454313659;29943.700562994527;30042.54936175959;30278;30681.926132585253;1028.4446398944635;1033.4987531047436;1050.5850189175233;1051.8001579699833;1077.7682798198425;15708.13605251722;15756.369745210062;16121.355145794038;16547.089910054823;16698.998060116188;706167;710989;712113;712332;712536;49321.753391232814;50081.499185007684;58479.12281315784;59313.40686593079;59346;1316.7564000659718;1351.2568087551808;1356.3150608942422;1358.7350466659104;1362.4413990263945;24697;29895.665128556673;30991.845040774653;31450;31630.525542116426;50095.499045009085;50951.47145585639;51086;51134.488655112975;51253.48746512487;634421;635569;636231;636551;637371;25850.870745646906;26835.792389342918;26849.597256040783;26878.92484300606;26885.86557067202;45802.85492862705;46495;46540.7672961633;46643.30035049409;46846.29730553976;38641.03397415087;38793.612063879;39065.609343906195;39175.41236881506;39778;38619.420708689955;38664.5443613366;39575.2084958305;40030.59969400385;40139.79580612586;31907.521387178745;37206;37818.81090594529;37985;38349.42475862808;32731.672683272864;34480.48279275863;34791.47812782861;34914.127146821535;35448.46827297541;25412.872935635205;25580;25676.486470270116;26154.346141346618;26186.607200892384 12:54:28 INFO - PROCESS | 1653 | |2;jquery.html;353.34983630120576;370.4369358574968;380.5357463894049;384.4137690022715;403.1936127744511;14933.25333733313;14999.1750453725;16499.17504124795;20472.590548189066;20653.896730516328;19508.31720889769;20144;20473.897630511863;20688.793112068874;20929;4939.456659767423;5686.630369026;5833.649981001132;5838.153467747175;5838.883222335551;4168.083021735213;4410.2723050696595;5733.856653583673;5777.046787280094;5825.417458254183;4257.552956939523;6262.248530176385;6597.307282735315;6613.768518101868;6635.867282654344;5412.431694672042;6523.18460192476;6582.078509008743;6615.503837212228;6615.669216539202;5648.943510564924;5694.174344719992;5699.287589051369;5699.74351154199;5708.628939118944;25180;25437.10970116037;25843.74156258432;25996;26346.20961371162;2293.9655905161435;2444.3889027743066;2684.8523331216775;3137.576427182324;3166.1609673436556;15404.614884627861;15517.844821551753;15563.221838908123;15818.841811581968;15958.521244362688;1722.905240211788;1757.455188891435;1872.3914727713411;1931.7875033746277;1944.9416517504499;123453.76546234512;124805.37597312046;126541;128439.35780321038;131675;10326.432046237529;10490.73773155662;10971.615993440191;10989.175811814146;11102.722431939266;13818.309084545732;13825.239611821446;13829.170249784844;13846.723065538632;13879.375428105759;8496.235338819535;8765;8816.647334106563;8859.734207973772;8894.86657700135;8847;8847.46915185091;8858.829586751288;9076.137766912132;9092.499912504876;5456.727163641882;6737.124173857367;6760.492963027793;6763.526553141233;6771.153605799275;1680.4958512446217;1792.524980880068;1811.148760082759;1848.159087615132;1849.306510058728;703.5075447186989;891.5497673674882;974.2352253481125;992.4095163377923;1028.6502589119734;16739;18828.717569236473;20651.58696826055;21735.56528869414;21826.345209643736;917.8485549884327;943.1134733350628;951.6621599332137;994.4381424495137;1060.8620879285643;9933.453660048623;11461.828072578917;11749.177557571058;11775.411229438494;11779.293242405483;441556;604284;605378;625060;626475;97779;137505;137939;140671;144626;870.0864092702637;882.9779255518663;914.1270087066836;914.3416739947228;914.6570036236411;17742.467725968243;17924.910375448562;18416.35542755997;18419.631607367508;18722.15750291213;56381.8723625517;56423.71788141033;57232;58370.4162958365;59697.70151149217;62380;78468;81693;83241.75137373066;88402;7536.886946695914;7726.266004729542;7869.213078692085;7893.36853051743;8031.59842007909;11895.940520297343;12114.575989840314;12221.633350999484;12235.021198304292;12333;10680.57277708883;10731.302465339728;10873.619423320146;11116.166287528305;11126.777464450828;10287.331323463952;10549.470326802724;10564.894351056391;10917.890821091687;10955.726106847393;10665.89334106649;10961.739399968787;11017.334058705173;11124.165687573302;11333;7101.680424380812;7523.586202758901;7556.055493063367;7617;7822.295993360625;8694.826103477768;10250.641227557;10511.26421150512;10682.8397574038;11008.449577520933 12:54:28 INFO - PROCESS | 1653 | |3;mootools.html;1312.7397698209716;1471.9337629806657;1525.3822202008184;1829.4145873320542;1869.429823903709;8088.231617996281;8507.361947853913;9182.494962777044;9185.724428267155;9192.54037298134;8032.477888937215;8281.461704989171;8296.211859873318;8297.1702829717;8297.170282971714;2308.284431826135;2389.199618127929;2390.115657206827;2391.1869964212165;2401.1235898896953;2358.433975845793;2374.2165085521824;2397.5924092904247;2398.628212627037;2403.9519209615796;2369.786719195272;2384.1178763857397;2389.6057150570223;2397.3886658901956;2406.5427568761966;2358.905643774247;2368.810495160392;2373.8931748071204;2375.0499800080106;2375.7386687464364;2369.5024044950583;2374.085976898889;2374.7387787343378;2375.168690958168;2375.750546192642;8965.731028069169;8969.865452018224;9071.410358326688;9072.8639070414;9073.09269073094;5179.974100129475;5344.305240318772;5347.7058761768085;5353.57171426285;5355.812546560852;3016.2610160510817;3446.7414943879307;3500.912477188065;3633.1643721943838;3637.563492380905;1095.5782023920767;1100.6808025672544;1104.1111904916538;1124.7806677697852;1125.0212315285671;11893.94053029738;12038.638840834701;12064.457099430547;12085.274883507018;12097.637070887888;4522.412086428743;4589.196890544142;4752.596029337545;4758.928616070762;4759.524047595212;9864.704058878246;9880.95059524712;9882.654107106217;9889.653862114936;9909.950450247703;5327.627066105335;5342.171963345688;5356.678599284055;5364.544013758796;5367.221752845816;4255.276602977439;4368;4396.648268138541;4822.71063736177;4826.806927722922;3974.423708562242;3991.720579559461;4049.5140583130215;4074.6536544394057;4105.609967053125;1292.4571679894466;1303.2571434282559;1305.9412326445142;1315;1318.6241921052647;793.4406243598249;874.7900503879023;895.3285036222833;900.6802585082332;924.2051835421532;5534.695591742493;5983.37174596661;6088.786892458743;6114.969425152845;6187.84530386735;718.482692461427;898.60910503931;933.3186773655269;941.7316064921464;968.0658164870933;3811.5426148862316;3911.3546264865977;3947.3684210526176;3949.249642567903;3958.3270843956598;10575.471226438647;11100.333979961228;11108.389038602954;11170;11217.60738374153;11090;11095.334279943068;11096.278741881752;11110.500027498781;11121.944390277997;8057.717979870677;8305.792355191048;8423;8428.957855210685;8483.999999999876;5776.19133321327;5816.040353341651;5896.292444906639;5898.882022359443;5919.585629005928;10351.120154786928;10451.477426128511;10468.371897685858;10475.371477711056;10495.317804342692;10077.596896124072;10342.844857327296;10416.062554370143;10436.112930401001;10581.788364232518;7067.222605513492;7222.241664625349;7244.492885498175;7534.510256833289;7773.261540153676;8272.007359116944;8510;8523.147685231428;8624.094470080801;8632.741017769225;7425.814354640961;7471.327580517779;7527.548347098973;7574.166841647304;7696.076470823313;7299.233580473974;7337;7365.300296471826;7469.962650186714;7519.060117485315;6911.827204319932;7037.507374483737;7053.717851286096;7057.788266352018;7059.71761129549;4146.419501269765;5001;5028.723420211923;5062.367204099488;5073.467285935071;4943.9505604944925;4946.183879659816;4975.328330675313;4993.151164302005;5144.074066668036 12:54:28 INFO - PROCESS | 1653 | |4;prototype.html;297.93892252088324;300.63472880450234;307.44966509947193;309.9876004959802;314.50151509856875;5406.324209473816;5473.974629387128;5580;5657.292838395206;5670.461306175906;5104.566111880486;5196.454372290902;5376.542993845528;5444.646098003637;5590.748416321265;3614.9457758133517;4007.479027726406;4142.772147531885;4146.917061658765;4148.502179738421;3463.4977928200396;4183.330667093266;4196.05588742532;4216.524216524207;4255.744655320691;3321.534985102088;3999.800009999503;4114.136031433402;4140.337545992642;4158.896027599304;3909.179072394786;3919.176972835708;4125.773082480462;4150.8132134053885;4202;3493.8602455901732;3547.0422985793693;3560.786352818839;3562.6437356264164;3578.4453409721536;4317.963688714717;5420.430854760272;5429.511343979021;5448;5465.699386533739;4199.91600167998;4476.776161191928;4717.764111794397;4766.428028636586;4772.639797657685;5827.825165245049;5832.912506312408;5854.648721076749;5900.380460051719;5916.603775470941;3643.908902277438;3808.733388662795;3825.800164905163;3927.3912543555793;3988.4615576897036;4868.805247790048;5232.58139348855;6043.305019922721;6086.786962456337;6156;3947.684185265172;3994.6404823566018;3995.5205375354562;4018.33697439925;4021.778802165909;3991.5850910199492;4056.269871423172;4056.51321841375;4061.817218225187;4071;4094.6314831665295;4163.125743593819;4351.8694439166875;4558.908821823545;4723.031778485402;4391.8462853799965;4805.543473370024;4806.812900130432;5041.1430056889685;5819.780659022175;1198.2391181599573;1296.6434230586665;1301.7136230029378;1358.1918758338772;1372.2298235276382;853.8505761491714;933.7161403070778;978.1392374710209;980.1472718734603;991.137710192123;4155.854545090968;4960.13994751968;5068.935523540098;5345.49414103474;5421.376541697677;5167.475594699573;5851.829634073202;5938.138969849348;5942.732577034044;5956.404359564096;5049.293098966147;5122.667026643257;5458.372287186945;5513.889722205534;5546.916796247979;2624.370151163707;2952.7342539171577;3118.656947735747;3145.874165033373;3149.2126968257935;5014.724190169576;5284.682919024871;5476.12382018883;5649.774009039593;6354;4770.570648641569;5092.745362731848;5389.652586853286;5721.083437048552;6113.633182009094;4925.802967881388;6126.324205476678;6138.232720909887;6174.129030001161;6176.973283091343;5705.804749340383;5919.6152250103605;5956;5956.017257152521;5965.254343207099;5287.4930644766055;5799.420057994167;5890.322612899571;5908.231929849092;5946.494547963472;5587.273654424899;5962.284525856751;5999.791363439899;6189.938100618936;6204.224471941007;3453.292075124644;3889.4943657324366;3925.5485619154165;3931.4692516509904;3945.6251656092627;5182.429932707475;5438.912217556425;5474.315710536183;5480.862978425412;5950.98833198366;5427.918581221206;5711.571632127524;5759.934412133769;5791.82624521265;5831.1836342912875;4296.591823776736;5262.842174721555;5741.224934633771;5745.798897038583;5747.540196784331;5444.794858082483;5558.666480011212;5641.407652196624;5642.5987729571;5653.2085508028085;5324.8583335832045;5668.886622267614;5768.50967667753;5814.215080964016;5827.388124246893;5481.835544933659;5628.889166562539;5666.914996274977;5676.489115979582;5681.801136960186 12:54:28 INFO - PROCESS | 1653 | |5;yui.html;667.9298673639267;689.9586024838507;695.2387136085985;728.4136270302406;821.7329367955416;14362.210078445694;15879.285432155537;15999.760003599926;16044.117573533451;16069.357225710972;13601.727965440685;13609.38757755901;14739.557813265592;14773.48292809752;14782.556523304318;678.3589507915023;701.1516065560678;837.9120192379804;859.9398042137053;868.288003836854;814.352589691197;844.5059640110543;844.6114787197896;849.3926842307749;866.8656358264479;897.0536084430922;900.2213085680871;901.5717534171282;901.7249738829687;904.6697955246353;700.2577268095835;892.6563273139823;894.5124906925741;895.9462432254053;896.4755617963499;537.1432565058764;632.8101569529123;650.2229835346762;656.3961155736733;656.8292244016542;14760.335784889705;14777.335019924129;14788.18664973426;14808;14816;13072.08495405322;13356.332183390792;13375;13384.330783460788;13860.930695346458;11055.447227638586;11192;11971.580994665232;12179.208351457128;12215.93892030543;3992.061865461614;4349.3041113421705;4432.889177770549;4433.357163211349;4625.283081122431;103133.4843325786;105968;106515.46742266239;106921.93078069275;109129;10940.945295273472;11029.22795404314;11045.944770276097;11228.270162439416;11437.085033197323;21771.67342489864;21818.345449636538;21823;21829.235976740736;21857.234996775038;6878.931210687829;7934.365250779923;8006.759797206093;8110.716124935717;8119.685889521458;4305.74165550068;4456.331550267421;4479.17135329965;4535.773211339486;4631.212693842055;3340.732741380684;3472.808995505221;3477.1133360992785;3481.5473988381855;3493.1965647900615;634.1819053421127;639.3255115852727;646.8641585267146;651.8663673946829;661.3254480430031;564.3087218157806;650.1515522243424;663.0650782396798;673.8382788130912;684.7432212920155;9255.213306868991;9270.629174833066;9283;9372.109649583279;9729.805403891882;570.0736303506801;606.3088079589272;633.8859902226128;636.5862189576719;675.5170053411736;4392.978035109868;4673.415823022122;4682.063587282489;4684.484706682262;4689.708722400333;166938.16530917268;169457;172208;173032.4045139324;176927.57681058077;100218;136011;137848;141444.5855541452;143202;124626.37686811508;124890;125003;126167;129560.35219823841;8568.14318568163;8889.511076890833;8907;8911.108889111038;9184.173424391836;66634.33365666281;68046;68215.3178468209;68368.6581567089;70020.64989675018;99921.50039249758;101354;102750.48624756829;109965.45017274862;110239;11458.4270786462;11511.36687482163;11673.35796531165;11881.168318217988;12177.208481448677;12367.319797411228;12657.746845063231;12839.358032098544;12922.966162706773;13145.34273286351;10150.390976541432;11180.944095279472;11628.534858605899;12004.279743215435;12255.080868934687;13164.934175329063;13623.795643065163;13727.588172354845;13995.51015714445;14815.777763333774;10849.620263290746;12903.290319032543;13693.246871422167;13798.93100534491;14219;10014.949925250326;10830.566777328819;11050.668479945614;11141.442927853413;11738.471768770596;11075.05862001739;11474.254173478697;11621.24461909973;11732.765344693229;11735.823962640396 12:54:28 INFO - PROCESS | 1653 | __end_tp_report 12:54:28 INFO - PROCESS | 1653 | __start_cc_report 12:54:28 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1324 12:54:28 INFO - PROCESS | 1653 | __end_cc_report 12:54:28 INFO - PROCESS | 1653 | __startTimestamp1476388468861__endTimestamp 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | ------- Summary: start ------- 12:54:28 INFO - PROCESS | 1653 | Number of tests: 6 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5796.98 Median:6086.73 stddev:647.56 (10.6%) stddev-sans-first:620.10 12:54:28 INFO - PROCESS | 1653 | Values: 3335.9 3351.4 3386.0 3419.1 3423.0 5798.6 5910.6 5952.6 5954.6 5961.1 5867.2 5941.3 5960.3 5963.6 5982.5 4590.7 5185.8 5209.1 5270.9 5318.5 5252.6 5257.6 5366.3 5374.3 5382.8 5201.0 5284.1 5296.3 5316.9 5330.9 5316.5 5334.6 5380.1 5391.4 5398.1 5223.0 5314.1 5351.9 5352.3 5378.3 5680.9 5738.5 5744.3 5775.0 5780.3 6161.0 6249.8 6250.0 6263.1 6269.8 6209.9 6270.1 6283.0 6293.6 6304.7 5766.3 5832.1 5865.6 5934.2 5968.4 6339.3 6363.4 6371.4 6377.7 6387.5 5202.6 6211.3 6247.6 6261.7 6270.0 6180.8 6192.4 6221.7 6251.9 6258.2 6203.3 6222.6 6236.7 6245.4 6258.8 5972.9 6156.9 6218.1 6262.2 6265.6 4910.8 4950.1 4976.4 4992.6 5032.5 4405.0 4440.8 4446.5 4450.8 4520.7 5787.9 5788.0 5788.5 5796.2 5804.0 6155.9 6247.6 6249.3 6263.4 6266.9 4794.6 5906.0 5909.1 5917.0 5932.2 5437.0 5450.8 5469.1 5492.3 5500.9 6426.1 6442.2 6446.4 6451.2 6470.2 5246.8 6260.1 6262.9 6270.0 6281.7 6204.6 6249.8 6449.9 6450.6 6467.0 6166.0 6198.0 6218.3 6261.5 6268.3 5608.6 6171.1 6224.3 6233.9 6248.9 6090.6 6121.2 6176.4 6191.7 6227.1 6125.2 6129.6 6135.9 6178.2 6180.3 6095.2 6096.6 6117.2 6140.3 6142.4 6175.1 6181.3 6184.5 6216.8 6224.6 5932.9 6011.2 6080.0 6086.7 6092.8 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:73570.89 Median:35517.15 stddev:169766.72 (478.0%) stddev-sans-first:170154.25 12:54:28 INFO - PROCESS | 1653 | Values: 472.7 521.5 528.9 532.7 560.7 26080.0 38940.8 40678.4 40785.6 43678.8 38141.8 38339.0 38720.4 38728.0 38879.8 8331.2 8632.0 9828.5 9866.4 9881.6 8714.9 8909.9 8923.6 8938.7 11813.4 11003.4 11404.5 11820.8 12225.4 12261.6 12145.6 12196.1 12198.2 12222.9 12263.8 11916.9 11950.8 11972.5 11995.7 12013.6 39890.4 40120.8 40171.0 40185.6 40244.2 3247.7 3332.4 3785.0 4008.9 4022.5 30508.7 30668.0 31344.0 31549.1 32458.7 3223.2 3259.6 3272.0 3276.2 3352.9 536326.0 537887.0 538429.0 539270.0 539696.3 33313.0 33416.0 33762.8 63078.7 63428.4 34254.1 34327.7 34328.0 35585.8 35805.0 15066.9 15248.8 15265.5 15273.9 15322.9 12735.6 12803.2 12823.3 12847.9 12910.1 7297.5 7374.8 7666.8 7725.4 7800.0 3227.8 3270.7 3272.4 3295.6 3303.5 939.3 965.6 965.8 969.4 990.6 29018.3 29943.7 30042.5 30278.0 30681.9 1028.4 1033.5 1050.6 1051.8 1077.8 15708.1 15756.4 16121.4 16547.1 16699.0 706167.0 710989.0 712113.0 712332.0 712536.0 49321.8 50081.5 58479.1 59313.4 59346.0 1316.8 1351.3 1356.3 1358.7 1362.4 24697.0 29895.7 30991.8 31450.0 31630.5 50095.5 50951.5 51086.0 51134.5 51253.5 634421.0 635569.0 636231.0 636551.0 637371.0 25850.9 26835.8 26849.6 26878.9 26885.9 45802.9 46495.0 46540.8 46643.3 46846.3 38641.0 38793.6 39065.6 39175.4 39778.0 38619.4 38664.5 39575.2 40030.6 40139.8 31907.5 37206.0 37818.8 37985.0 38349.4 32731.7 34480.5 34791.5 34914.1 35448.5 25412.9 25580.0 25676.5 26154.3 26186.6 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35058.94 Median:14515.53 stddev:98169.81 (676.3%) stddev-sans-first:98410.62 12:54:28 INFO - PROCESS | 1653 | Values: 353.3 370.4 380.5 384.4 403.2 14933.3 14999.2 16499.2 20472.6 20653.9 19508.3 20144.0 20473.9 20688.8 20929.0 4939.5 5686.6 5833.6 5838.2 5838.9 4168.1 4410.3 5733.9 5777.0 5825.4 4257.6 6262.2 6597.3 6613.8 6635.9 5412.4 6523.2 6582.1 6615.5 6615.7 5648.9 5694.2 5699.3 5699.7 5708.6 25180.0 25437.1 25843.7 25996.0 26346.2 2294.0 2444.4 2684.9 3137.6 3166.2 15404.6 15517.8 15563.2 15818.8 15958.5 1722.9 1757.5 1872.4 1931.8 1944.9 123453.8 124805.4 126541.0 128439.4 131675.0 10326.4 10490.7 10971.6 10989.2 11102.7 13818.3 13825.2 13829.2 13846.7 13879.4 8496.2 8765.0 8816.6 8859.7 8894.9 8847.0 8847.5 8858.8 9076.1 9092.5 5456.7 6737.1 6760.5 6763.5 6771.2 1680.5 1792.5 1811.1 1848.2 1849.3 703.5 891.5 974.2 992.4 1028.7 16739.0 18828.7 20651.6 21735.6 21826.3 917.8 943.1 951.7 994.4 1060.9 9933.5 11461.8 11749.2 11775.4 11779.3 441556.0 604284.0 605378.0 625060.0 626475.0 97779.0 137505.0 137939.0 140671.0 144626.0 870.1 883.0 914.1 914.3 914.7 17742.5 17924.9 18416.4 18419.6 18722.2 56381.9 56423.7 57232.0 58370.4 59697.7 62380.0 78468.0 81693.0 83241.8 88402.0 7536.9 7726.3 7869.2 7893.4 8031.6 11895.9 12114.6 12221.6 12235.0 12333.0 10680.6 10731.3 10873.6 11116.2 11126.8 10287.3 10549.5 10564.9 10917.9 10955.7 10665.9 10961.7 11017.3 11124.2 11333.0 7101.7 7523.6 7556.1 7617.0 7822.3 8694.8 10250.6 10511.3 10682.8 11008.4 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5773.16 Median:4885.38 stddev:3287.82 (67.3%) stddev-sans-first:3279.95 12:54:28 INFO - PROCESS | 1653 | Values: 1312.7 1471.9 1525.4 1829.4 1869.4 8088.2 8507.4 9182.5 9185.7 9192.5 8032.5 8281.5 8296.2 8297.2 8297.2 2308.3 2389.2 2390.1 2391.2 2401.1 2358.4 2374.2 2397.6 2398.6 2404.0 2369.8 2384.1 2389.6 2397.4 2406.5 2358.9 2368.8 2373.9 2375.0 2375.7 2369.5 2374.1 2374.7 2375.2 2375.8 8965.7 8969.9 9071.4 9072.9 9073.1 5180.0 5344.3 5347.7 5353.6 5355.8 3016.3 3446.7 3500.9 3633.2 3637.6 1095.6 1100.7 1104.1 1124.8 1125.0 11893.9 12038.6 12064.5 12085.3 12097.6 4522.4 4589.2 4752.6 4758.9 4759.5 9864.7 9881.0 9882.7 9889.7 9910.0 5327.6 5342.2 5356.7 5364.5 5367.2 4255.3 4368.0 4396.6 4822.7 4826.8 3974.4 3991.7 4049.5 4074.7 4105.6 1292.5 1303.3 1305.9 1315.0 1318.6 793.4 874.8 895.3 900.7 924.2 5534.7 5983.4 6088.8 6115.0 6187.8 718.5 898.6 933.3 941.7 968.1 3811.5 3911.4 3947.4 3949.2 3958.3 10575.5 11100.3 11108.4 11170.0 11217.6 11090.0 11095.3 11096.3 11110.5 11121.9 8057.7 8305.8 8423.0 8429.0 8484.0 5776.2 5816.0 5896.3 5898.9 5919.6 10351.1 10451.5 10468.4 10475.4 10495.3 10077.6 10342.8 10416.1 10436.1 10581.8 7067.2 7222.2 7244.5 7534.5 7773.3 8272.0 8510.0 8523.1 8624.1 8632.7 7425.8 7471.3 7527.5 7574.2 7696.1 7299.2 7337.0 7365.3 7470.0 7519.1 6911.8 7037.5 7053.7 7057.8 7059.7 4146.4 5001.0 5028.7 5062.4 5073.5 4944.0 4946.2 4975.3 4993.2 5144.1 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4627.80 Median:5247.71 stddev:1429.91 (27.2%) stddev-sans-first:1396.50 12:54:28 INFO - PROCESS | 1653 | Values: 297.9 300.6 307.4 310.0 314.5 5406.3 5474.0 5580.0 5657.3 5670.5 5104.6 5196.5 5376.5 5444.6 5590.7 3614.9 4007.5 4142.8 4146.9 4148.5 3463.5 4183.3 4196.1 4216.5 4255.7 3321.5 3999.8 4114.1 4140.3 4158.9 3909.2 3919.2 4125.8 4150.8 4202.0 3493.9 3547.0 3560.8 3562.6 3578.4 4318.0 5420.4 5429.5 5448.0 5465.7 4199.9 4476.8 4717.8 4766.4 4772.6 5827.8 5832.9 5854.6 5900.4 5916.6 3643.9 3808.7 3825.8 3927.4 3988.5 4868.8 5232.6 6043.3 6086.8 6156.0 3947.7 3994.6 3995.5 4018.3 4021.8 3991.6 4056.3 4056.5 4061.8 4071.0 4094.6 4163.1 4351.9 4558.9 4723.0 4391.8 4805.5 4806.8 5041.1 5819.8 1198.2 1296.6 1301.7 1358.2 1372.2 853.9 933.7 978.1 980.1 991.1 4155.9 4960.1 5068.9 5345.5 5421.4 5167.5 5851.8 5938.1 5942.7 5956.4 5049.3 5122.7 5458.4 5513.9 5546.9 2624.4 2952.7 3118.7 3145.9 3149.2 5014.7 5284.7 5476.1 5649.8 6354.0 4770.6 5092.7 5389.7 5721.1 6113.6 4925.8 6126.3 6138.2 6174.1 6177.0 5705.8 5919.6 5956.0 5956.0 5965.3 5287.5 5799.4 5890.3 5908.2 5946.5 5587.3 5962.3 5999.8 6189.9 6204.2 3453.3 3889.5 3925.5 3931.5 3945.6 5182.4 5438.9 5474.3 5480.9 5951.0 5427.9 5711.6 5759.9 5791.8 5831.2 4296.6 5262.8 5741.2 5745.8 5747.5 5444.8 5558.7 5641.4 5642.6 5653.2 5324.9 5668.9 5768.5 5814.2 5827.4 5481.8 5628.9 5666.9 5676.5 5681.8 12:54:28 INFO - PROCESS | 1653 | 12:54:28 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:26302.01 Median:21820.67 stddev:43589.95 (199.8%) stddev-sans-first:43669.74 12:54:28 INFO - PROCESS | 1653 | Values: 667.9 690.0 695.2 728.4 821.7 14362.2 15879.3 15999.8 16044.1 16069.4 13601.7 13609.4 14739.6 14773.5 14782.6 678.4 701.2 837.9 859.9 868.3 814.4 844.5 844.6 849.4 866.9 897.1 900.2 901.6 901.7 904.7 700.3 892.7 894.5 895.9 896.5 537.1 632.8 650.2 656.4 656.8 14760.3 14777.3 14788.2 14808.0 14816.0 13072.1 13356.3 13375.0 13384.3 13860.9 11055.4 11192.0 11971.6 12179.2 12215.9 3992.1 4349.3 4432.9 4433.4 4625.3 103133.5 105968.0 106515.5 106921.9 109129.0 10940.9 11029.2 11045.9 11228.3 11437.1 21771.7 21818.3 21823.0 21829.2 21857.2 6878.9 7934.4 8006.8 8110.7 8119.7 4305.7 4456.3 4479.2 4535.8 4631.2 3340.7 3472.8 3477.1 3481.5 3493.2 634.2 639.3 646.9 651.9 661.3 564.3 650.2 663.1 673.8 684.7 9255.2 9270.6 9283.0 9372.1 9729.8 570.1 606.3 633.9 636.6 675.5 4393.0 4673.4 4682.1 4684.5 4689.7 166938.2 169457.0 172208.0 173032.4 176927.6 100218.0 136011.0 137848.0 141444.6 143202.0 124626.4 124890.0 125003.0 126167.0 129560.4 8568.1 8889.5 8907.0 8911.1 9184.2 66634.3 68046.0 68215.3 68368.7 70020.6 99921.5 101354.0 102750.5 109965.5 110239.0 11458.4 11511.4 11673.4 11881.2 12177.2 12367.3 12657.7 12839.4 12923.0 13145.3 10150.4 11180.9 11628.5 12004.3 12255.1 13164.9 13623.8 13727.6 13995.5 14815.8 10849.6 12903.3 13693.2 13798.9 14219.0 10014.9 10830.6 11050.7 11141.4 11738.5 11075.1 11474.3 11621.2 11732.8 11735.8 12:54:28 INFO - PROCESS | 1653 | -------- Summary: end -------- 12:54:28 INFO - PROCESS | 1653 | 12:54:29 INFO - TEST-INFO | 1653: exit 0 12:54:29 INFO - TEST-OK | dromaeo_css | took 1117305ms 12:54:29 INFO - TEST-START | kraken 12:54:29 INFO - operating with platform_type : mac_ 12:54:29 INFO - Initialising browser for kraken test... 12:54:29 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmptW7A9_/profile http://localhost:49275/getInfo.html) 12:54:31 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 12:54:31 INFO - PROCESS | 1663 | colorDepth:24 12:54:31 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 12:54:31 INFO - PROCESS | 1663 | __metrics 12:54:31 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:54:31 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:54:32 INFO - TEST-INFO | 1663: exit 0 12:54:32 INFO - Browser initialized. 12:54:32 INFO - Running cycle 1/1 for kraken test... 12:54:32 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmptW7A9_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:44 INFO - PROCESS | 1664 | RSS: Main: 219369472 12:54:44 INFO - PROCESS | 1664 | 12:54:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:48 INFO - PROCESS | 1664 | RSS: Main: 269328384 12:54:48 INFO - PROCESS | 1664 | 12:54:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 12:54:51 INFO - PROCESS | 1664 | RSS: Main: 280526848 12:54:51 INFO - PROCESS | 1664 | 12:54:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 12:54:55 INFO - PROCESS | 1664 | RSS: Main: 378662912 12:54:55 INFO - PROCESS | 1664 | 12:54:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 12:54:58 INFO - PROCESS | 1664 | RSS: Main: 279986176 12:54:58 INFO - PROCESS | 1664 | 12:55:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:55:00 INFO - PROCESS | 1664 | RSS: Main: 280539136 12:55:00 INFO - PROCESS | 1664 | 12:55:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 12:55:04 INFO - PROCESS | 1664 | RSS: Main: 317968384 12:55:04 INFO - PROCESS | 1664 | 12:55:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 12:55:07 INFO - PROCESS | 1664 | RSS: Main: 319209472 12:55:07 INFO - PROCESS | 1664 | 12:55:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 12:55:11 INFO - PROCESS | 1664 | RSS: Main: 316084224 12:55:11 INFO - PROCESS | 1664 | 12:55:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:55:13 INFO - PROCESS | 1664 | RSS: Main: 289103872 12:55:13 INFO - PROCESS | 1664 | 12:55:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:55:16 INFO - PROCESS | 1664 | RSS: Main: 295014400 12:55:16 INFO - PROCESS | 1664 | 12:55:18 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:55:18 INFO - PROCESS | 1664 | RSS: Main: 297504768 12:55:18 INFO - PROCESS | 1664 | 12:55:21 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:55:22 INFO - PROCESS | 1664 | RSS: Main: 309547008 12:55:22 INFO - PROCESS | 1664 | 12:55:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:55:26 INFO - PROCESS | 1664 | RSS: Main: 309059584 12:55:26 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 12:55:27 INFO - PROCESS | 1664 | RSS: Main: 353665024 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | __start_tp_report 12:55:27 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 12:55:27 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 12:55:27 INFO - PROCESS | 1664 | |i|pagename|runs| 12:55:27 INFO - PROCESS | 1664 | |0;ai-astar;114;114;113;112;113;113;113;113;113;113 12:55:27 INFO - PROCESS | 1664 | |1;audio-beat-detection;143;110;109;144;109;107;108;107;138;109 12:55:27 INFO - PROCESS | 1664 | |2;audio-dft;186;184;181;184;185;184;186;245;238;183 12:55:27 INFO - PROCESS | 1664 | |3;audio-fft;78;60;59;90;63;76;86;82;74;74 12:55:27 INFO - PROCESS | 1664 | |4;audio-oscillator;85;71;93;68;68;74;126;97;93;89 12:55:27 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;88;86;89;87;88;85;90;86;89;85 12:55:27 INFO - PROCESS | 1664 | |6;imaging-darkroom;95;94;94;96;93;95;94;95;94;93 12:55:27 INFO - PROCESS | 1664 | |7;imaging-desaturate;129;141;91;84;87;85;85;89;84;86 12:55:27 INFO - PROCESS | 1664 | |8;json-parse-financial;57;50;52;75;87;88;84;58;57;57 12:55:27 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;65;74;67;76;73;69;70;71;70;71 12:55:27 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;82;101;103;78;82;82;84;80;82;83 12:55:27 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;140;134;152;156;147;139;142;151;205;136 12:55:27 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;165;163;166;159;163;164;165;163;165;166 12:55:27 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;66;64;67;67;66;65;66;65;65;65 12:55:27 INFO - PROCESS | 1664 | __end_tp_report 12:55:27 INFO - PROCESS | 1664 | __start_cc_report 12:55:27 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2016 12:55:27 INFO - PROCESS | 1664 | __end_cc_report 12:55:27 INFO - PROCESS | 1664 | __startTimestamp1476388527962__endTimestamp 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | ------- Summary: start ------- 12:55:27 INFO - PROCESS | 1664 | Number of tests: 14 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 12:55:27 INFO - PROCESS | 1664 | Values: 114.0 114.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:109.50 stddev:16.15 (14.8%) stddev-sans-first:14.47 12:55:27 INFO - PROCESS | 1664 | Values: 143.0 110.0 109.0 144.0 109.0 107.0 108.0 107.0 138.0 109.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:195.60 Median:185.50 stddev:24.29 (13.1%) stddev-sans-first:25.51 12:55:27 INFO - PROCESS | 1664 | Values: 186.0 184.0 181.0 184.0 185.0 184.0 186.0 245.0 238.0 183.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:74.20 Median:77.00 stddev:10.67 (13.9%) stddev-sans-first:11.23 12:55:27 INFO - PROCESS | 1664 | Values: 78.0 60.0 59.0 90.0 63.0 76.0 86.0 82.0 74.0 74.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:87.00 stddev:17.78 (20.4%) stddev-sans-first:18.85 12:55:27 INFO - PROCESS | 1664 | Values: 85.0 71.0 93.0 68.0 68.0 74.0 126.0 97.0 93.0 89.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.00 stddev:1.77 (2.0%) stddev-sans-first:1.86 12:55:27 INFO - PROCESS | 1664 | Values: 88.0 86.0 89.0 87.0 88.0 85.0 90.0 86.0 89.0 85.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 12:55:27 INFO - PROCESS | 1664 | Values: 95.0 94.0 94.0 96.0 93.0 95.0 94.0 95.0 94.0 93.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:85.50 stddev:20.81 (24.3%) stddev-sans-first:18.36 12:55:27 INFO - PROCESS | 1664 | Values: 129.0 141.0 91.0 84.0 87.0 85.0 85.0 89.0 84.0 86.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.50 stddev:15.23 (22.9%) stddev-sans-first:15.76 12:55:27 INFO - PROCESS | 1664 | Values: 57.0 50.0 52.0 75.0 87.0 88.0 84.0 58.0 57.0 57.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:3.24 (4.6%) stddev-sans-first:2.73 12:55:27 INFO - PROCESS | 1664 | Values: 65.0 74.0 67.0 76.0 73.0 69.0 70.0 71.0 70.0 71.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:82.00 stddev:8.76 (10.7%) stddev-sans-first:9.18 12:55:27 INFO - PROCESS | 1664 | Values: 82.0 101.0 103.0 78.0 82.0 82.0 84.0 80.0 82.0 83.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:149.00 stddev:20.58 (13.8%) stddev-sans-first:21.49 12:55:27 INFO - PROCESS | 1664 | Values: 140.0 134.0 152.0 156.0 147.0 139.0 142.0 151.0 205.0 136.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:165.00 stddev:2.08 (1.3%) stddev-sans-first:2.17 12:55:27 INFO - PROCESS | 1664 | Values: 165.0 163.0 166.0 159.0 163.0 164.0 165.0 163.0 165.0 166.0 12:55:27 INFO - PROCESS | 1664 | 12:55:27 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 12:55:27 INFO - PROCESS | 1664 | Values: 66.0 64.0 67.0 67.0 66.0 65.0 66.0 65.0 65.0 65.0 12:55:27 INFO - PROCESS | 1664 | -------- Summary: end -------- 12:55:27 INFO - PROCESS | 1664 | 12:55:28 INFO - TEST-INFO | 1664: exit 0 12:55:28 INFO - TEST-OK | kraken | took 59327ms 12:55:28 INFO - SUITE-END | took 1176s 12:55:29 INFO - Completed test suite (00:19:36) 12:55:29 INFO - javascript benchmark 12:55:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.8832440864576, 3351.363240984213, 3386.0011296667467, 3419.1281223288056, 3423.0244380351587, 5798.623089499185, 5910.645361278326, 5952.583319167655, 5954.583179177459, 5961.105834124884, 5867.178594996704, 5941.257342832146, 5960.254968128984, 5963.552733544991, 5982.521398288138, 4590.737547174537, 5185.766640501177, 5209.114450543398, 5270.947290527084, 5318.521333080022, 5252.579793616502, 5257.605679574028, 5366.275552800381, 5374.3013408256875, 5382.838514844561, 5201.0, 5284.128118860383, 5296.311479507659, 5316.946830531684, 5330.92003619946, 5316.494932981361, 5334.626576139672, 5380.085385484477, 5391.406945236021, 5398.13629819227, 5223.0, 5314.1497360422145, 5351.946480535184, 5352.330958630171, 5378.300820893259, 5680.886382272372, 5738.540916726652, 5744.253247077895, 5775.0, 5780.335261444946, 6161.045038019114, 6249.78125765596, 6250.0, 6263.091851681481, 6269.843253918643, 6209.913265178576, 6270.122182894398, 6283.0, 6293.622382657055, 6304.747810087591, 5766.308043034821, 5832.12518122285, 5865.560082993792, 5934.198883150806, 5968.4031596840405, 6339.334369891188, 6363.395477429637, 6371.39471750183, 6377.74489020434, 6387.520935929824, 5202.557782588447, 6211.3478084801345, 6247.625142491465, 6261.7182226799905, 6269.96865015672, 6180.7527698891545, 6192.442680158807, 6221.688915554204, 6251.937480625135, 6258.186435763321, 6203.31763506014, 6222.595531290452, 6236.688165591702, 6245.437910587978, 6258.812235632939, 5972.850678733066, 6156.938430615726, 6218.098375735493, 6262.1859158310035, 6265.592736472206, 4910.8281210157475, 4950.084234416644, 4976.402831660224, 4992.600591952635, 5032.496750325012, 4404.977975110168, 4440.844570440084, 4446.488653804854, 4450.844220452269, 4520.706154099973, 5787.942120578825, 5788.0449725795615, 5788.450097240755, 5796.188533605298, 5803.970980145156, 6155.876882462326, 6247.562670613104, 6249.312575616678, 6263.4362907338555, 6266.905996410058, 4794.568488836021, 5906.0, 5909.054551271776, 5917.023691090922, 5932.228810254639, 5437.048516509595, 5450.781968721286, 5469.097598896137, 5492.313460817398, 5500.917486237709, 6426.132472116298, 6442.162518872517, 6446.387593178641, 6451.161349024596, 6470.158879345655, 5246.76389562463, 6260.123582698335, 6262.937370626236, 6269.968650156902, 6281.654509002049, 6204.565680402509, 6249.78125765596, 6449.9355006451215, 6450.612963222222, 6466.967665161644, 6166.013437849922, 6198.0, 6218.284897236876, 6261.530385221035, 6268.27914789805, 5608.635438696471, 6171.074338849208, 6224.346443623354, 6233.937660623517, 6248.937510624835, 6090.634561926298, 6121.204243448323, 6176.382361763967, 6191.659458729813, 6227.06594010902, 6125.23545181825, 6129.601575897731, 6135.877282454415, 6178.165947597017, 6180.289266734383, 6095.217231112331, 6096.62825864177, 6117.174181485442, 6140.324564298013, 6142.447179753844, 6175.135481032748, 6181.289151747606, 6184.536159788124, 6216.813495595139, 6224.62652240867, 5932.940670593239, 6011.21854158974, 6079.969600151971, 6086.7260973255425, 6092.817215483543], "value": 5755.991835905455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.73290590816185, 521.4681025354137, 528.9312389389379, 532.7203218310386, 560.7411361493448, 26079.95680172793, 38940.83177504676, 40678.389824152626, 40785.59214407855, 43678.78160609193, 38141.80929095358, 38339.0, 38720.419193712114, 38728.0, 38879.80560097196, 8331.166883311666, 8632.007319158283, 9828.508574571279, 9866.408015519057, 9881.555330010167, 8714.912850871506, 8909.866352004725, 8923.553822308859, 8938.687145949893, 11813.350265735382, 11003.449827508633, 11404.486798094105, 11820.822687659693, 12225.449854756513, 12261.570845020426, 12145.635630931087, 12196.085293603015, 12198.207116537485, 12222.938885305517, 12263.754724905497, 11916.940415297955, 11950.820737688942, 11972.521099156023, 11995.700107497296, 12013.639590812203, 39890.40164397536, 40120.79939600312, 40171.0, 40185.59814401848, 40244.195116097806, 3247.7401807855313, 3332.41682705528, 3785.0, 4008.9198216035807, 4022.517297924268, 30508.694913050807, 30668.0, 31344.0, 31549.053528394186, 32458.675413246037, 3223.161977885743, 3259.6251431085493, 3271.9509207361907, 3276.1645780326103, 3352.860027590631, 536326.0, 537887.0, 538429.0, 539270.0, 539696.3015184938, 33313.0, 33416.0, 33762.83118584391, 63078.68460657667, 63428.36571634317, 34254.14364640854, 34327.65672343295, 34328.0, 35585.82207088948, 35805.0, 15066.924665376602, 15248.771268430983, 15265.542033739006, 15273.923630381776, 15322.923385383001, 12735.617931462071, 12803.231806091664, 12823.29471879037, 12847.935760321325, 12910.096293259381, 7297.452691048193, 7374.815629609303, 7666.769996900102, 7725.420593455513, 7800.024996875391, 3227.8063316200632, 3270.73834093272, 3272.3946069977133, 3295.638448782229, 3303.5209894565633, 939.3002213351098, 965.56066989521, 965.75856035991, 969.3699095587924, 990.6384169778123, 29018.27454313659, 29943.700562994527, 30042.54936175959, 30278.0, 30681.926132585253, 1028.4446398944635, 1033.4987531047436, 1050.5850189175233, 1051.8001579699833, 1077.7682798198425, 15708.13605251722, 15756.369745210062, 16121.355145794038, 16547.089910054823, 16698.998060116188, 706167.0, 710989.0, 712113.0, 712332.0, 712536.0, 49321.753391232814, 50081.499185007684, 58479.12281315784, 59313.40686593079, 59346.0, 1316.7564000659718, 1351.2568087551808, 1356.3150608942422, 1358.7350466659104, 1362.4413990263945, 24697.0, 29895.665128556673, 30991.845040774653, 31450.0, 31630.525542116426, 50095.499045009085, 50951.47145585639, 51086.0, 51134.488655112975, 51253.48746512487, 634421.0, 635569.0, 636231.0, 636551.0, 637371.0, 25850.870745646906, 26835.792389342918, 26849.597256040783, 26878.92484300606, 26885.86557067202, 45802.85492862705, 46495.0, 46540.7672961633, 46643.30035049409, 46846.29730553976, 38641.03397415087, 38793.612063879, 39065.609343906195, 39175.41236881506, 39778.0, 38619.420708689955, 38664.5443613366, 39575.2084958305, 40030.59969400385, 40139.79580612586, 31907.521387178745, 37206.0, 37818.81090594529, 37985.0, 38349.42475862808, 32731.672683272864, 34480.48279275863, 34791.47812782861, 34914.127146821535, 35448.46827297541, 25412.872935635205, 25580.0, 25676.486470270116, 26154.346141346618, 26186.607200892384], "value": 19024.657916586544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.34983630120576, 370.4369358574968, 380.5357463894049, 384.4137690022715, 403.1936127744511, 14933.25333733313, 14999.1750453725, 16499.17504124795, 20472.590548189066, 20653.896730516328, 19508.31720889769, 20144.0, 20473.897630511863, 20688.793112068874, 20929.0, 4939.456659767423, 5686.630369026, 5833.649981001132, 5838.153467747175, 5838.883222335551, 4168.083021735213, 4410.2723050696595, 5733.856653583673, 5777.046787280094, 5825.417458254183, 4257.552956939523, 6262.248530176385, 6597.307282735315, 6613.768518101868, 6635.867282654344, 5412.431694672042, 6523.18460192476, 6582.078509008743, 6615.503837212228, 6615.669216539202, 5648.943510564924, 5694.174344719992, 5699.287589051369, 5699.74351154199, 5708.628939118944, 25180.0, 25437.10970116037, 25843.74156258432, 25996.0, 26346.20961371162, 2293.9655905161435, 2444.3889027743066, 2684.8523331216775, 3137.576427182324, 3166.1609673436556, 15404.614884627861, 15517.844821551753, 15563.221838908123, 15818.841811581968, 15958.521244362688, 1722.905240211788, 1757.455188891435, 1872.3914727713411, 1931.7875033746277, 1944.9416517504499, 123453.76546234512, 124805.37597312046, 126541.0, 128439.35780321038, 131675.0, 10326.432046237529, 10490.73773155662, 10971.615993440191, 10989.175811814146, 11102.722431939266, 13818.309084545732, 13825.239611821446, 13829.170249784844, 13846.723065538632, 13879.375428105759, 8496.235338819535, 8765.0, 8816.647334106563, 8859.734207973772, 8894.86657700135, 8847.0, 8847.46915185091, 8858.829586751288, 9076.137766912132, 9092.499912504876, 5456.727163641882, 6737.124173857367, 6760.492963027793, 6763.526553141233, 6771.153605799275, 1680.4958512446217, 1792.524980880068, 1811.148760082759, 1848.159087615132, 1849.306510058728, 703.5075447186989, 891.5497673674882, 974.2352253481125, 992.4095163377923, 1028.6502589119734, 16739.0, 18828.717569236473, 20651.58696826055, 21735.56528869414, 21826.345209643736, 917.8485549884327, 943.1134733350628, 951.6621599332137, 994.4381424495137, 1060.8620879285643, 9933.453660048623, 11461.828072578917, 11749.177557571058, 11775.411229438494, 11779.293242405483, 441556.0, 604284.0, 605378.0, 625060.0, 626475.0, 97779.0, 137505.0, 137939.0, 140671.0, 144626.0, 870.0864092702637, 882.9779255518663, 914.1270087066836, 914.3416739947228, 914.6570036236411, 17742.467725968243, 17924.910375448562, 18416.35542755997, 18419.631607367508, 18722.15750291213, 56381.8723625517, 56423.71788141033, 57232.0, 58370.4162958365, 59697.70151149217, 62380.0, 78468.0, 81693.0, 83241.75137373066, 88402.0, 7536.886946695914, 7726.266004729542, 7869.213078692085, 7893.36853051743, 8031.59842007909, 11895.940520297343, 12114.575989840314, 12221.633350999484, 12235.021198304292, 12333.0, 10680.57277708883, 10731.302465339728, 10873.619423320146, 11116.166287528305, 11126.777464450828, 10287.331323463952, 10549.470326802724, 10564.894351056391, 10917.890821091687, 10955.726106847393, 10665.89334106649, 10961.739399968787, 11017.334058705173, 11124.165687573302, 11333.0, 7101.680424380812, 7523.586202758901, 7556.055493063367, 7617.0, 7822.295993360625, 8694.826103477768, 10250.641227557, 10511.26421150512, 10682.8397574038, 11008.449577520933], "value": 9698.272766265443, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.7397698209716, 1471.9337629806657, 1525.3822202008184, 1829.4145873320542, 1869.429823903709, 8088.231617996281, 8507.361947853913, 9182.494962777044, 9185.724428267155, 9192.54037298134, 8032.477888937215, 8281.461704989171, 8296.211859873318, 8297.1702829717, 8297.170282971714, 2308.284431826135, 2389.199618127929, 2390.115657206827, 2391.1869964212165, 2401.1235898896953, 2358.433975845793, 2374.2165085521824, 2397.5924092904247, 2398.628212627037, 2403.9519209615796, 2369.786719195272, 2384.1178763857397, 2389.6057150570223, 2397.3886658901956, 2406.5427568761966, 2358.905643774247, 2368.810495160392, 2373.8931748071204, 2375.0499800080106, 2375.7386687464364, 2369.5024044950583, 2374.085976898889, 2374.7387787343378, 2375.168690958168, 2375.750546192642, 8965.731028069169, 8969.865452018224, 9071.410358326688, 9072.8639070414, 9073.09269073094, 5179.974100129475, 5344.305240318772, 5347.7058761768085, 5353.57171426285, 5355.812546560852, 3016.2610160510817, 3446.7414943879307, 3500.912477188065, 3633.1643721943838, 3637.563492380905, 1095.5782023920767, 1100.6808025672544, 1104.1111904916538, 1124.7806677697852, 1125.0212315285671, 11893.94053029738, 12038.638840834701, 12064.457099430547, 12085.274883507018, 12097.637070887888, 4522.412086428743, 4589.196890544142, 4752.596029337545, 4758.928616070762, 4759.524047595212, 9864.704058878246, 9880.95059524712, 9882.654107106217, 9889.653862114936, 9909.950450247703, 5327.627066105335, 5342.171963345688, 5356.678599284055, 5364.544013758796, 5367.221752845816, 4255.276602977439, 4368.0, 4396.648268138541, 4822.71063736177, 4826.806927722922, 3974.423708562242, 3991.720579559461, 4049.5140583130215, 4074.6536544394057, 4105.609967053125, 1292.4571679894466, 1303.2571434282559, 1305.9412326445142, 1315.0, 1318.6241921052647, 793.4406243598249, 874.7900503879023, 895.3285036222833, 900.6802585082332, 924.2051835421532, 5534.695591742493, 5983.37174596661, 6088.786892458743, 6114.969425152845, 6187.84530386735, 718.482692461427, 898.60910503931, 933.3186773655269, 941.7316064921464, 968.0658164870933, 3811.5426148862316, 3911.3546264865977, 3947.3684210526176, 3949.249642567903, 3958.3270843956598, 10575.471226438647, 11100.333979961228, 11108.389038602954, 11170.0, 11217.60738374153, 11090.0, 11095.334279943068, 11096.278741881752, 11110.500027498781, 11121.944390277997, 8057.717979870677, 8305.792355191048, 8423.0, 8428.957855210685, 8483.999999999876, 5776.19133321327, 5816.040353341651, 5896.292444906639, 5898.882022359443, 5919.585629005928, 10351.120154786928, 10451.477426128511, 10468.371897685858, 10475.371477711056, 10495.317804342692, 10077.596896124072, 10342.844857327296, 10416.062554370143, 10436.112930401001, 10581.788364232518, 7067.222605513492, 7222.241664625349, 7244.492885498175, 7534.510256833289, 7773.261540153676, 8272.007359116944, 8510.0, 8523.147685231428, 8624.094470080801, 8632.741017769225, 7425.814354640961, 7471.327580517779, 7527.548347098973, 7574.166841647304, 7696.076470823313, 7299.233580473974, 7337.0, 7365.300296471826, 7469.962650186714, 7519.060117485315, 6911.827204319932, 7037.507374483737, 7053.717851286096, 7057.788266352018, 7059.71761129549, 4146.419501269765, 5001.0, 5028.723420211923, 5062.367204099488, 5073.467285935071, 4943.9505604944925, 4946.183879659816, 4975.328330675313, 4993.151164302005, 5144.074066668036], "value": 4617.601335448329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.93892252088324, 300.63472880450234, 307.44966509947193, 309.9876004959802, 314.50151509856875, 5406.324209473816, 5473.974629387128, 5580.0, 5657.292838395206, 5670.461306175906, 5104.566111880486, 5196.454372290902, 5376.542993845528, 5444.646098003637, 5590.748416321265, 3614.9457758133517, 4007.479027726406, 4142.772147531885, 4146.917061658765, 4148.502179738421, 3463.4977928200396, 4183.330667093266, 4196.05588742532, 4216.524216524207, 4255.744655320691, 3321.534985102088, 3999.800009999503, 4114.136031433402, 4140.337545992642, 4158.896027599304, 3909.179072394786, 3919.176972835708, 4125.773082480462, 4150.8132134053885, 4202.0, 3493.8602455901732, 3547.0422985793693, 3560.786352818839, 3562.6437356264164, 3578.4453409721536, 4317.963688714717, 5420.430854760272, 5429.511343979021, 5448.0, 5465.699386533739, 4199.91600167998, 4476.776161191928, 4717.764111794397, 4766.428028636586, 4772.639797657685, 5827.825165245049, 5832.912506312408, 5854.648721076749, 5900.380460051719, 5916.603775470941, 3643.908902277438, 3808.733388662795, 3825.800164905163, 3927.3912543555793, 3988.4615576897036, 4868.805247790048, 5232.58139348855, 6043.305019922721, 6086.786962456337, 6156.0, 3947.684185265172, 3994.6404823566018, 3995.5205375354562, 4018.33697439925, 4021.778802165909, 3991.5850910199492, 4056.269871423172, 4056.51321841375, 4061.817218225187, 4071.0, 4094.6314831665295, 4163.125743593819, 4351.8694439166875, 4558.908821823545, 4723.031778485402, 4391.8462853799965, 4805.543473370024, 4806.812900130432, 5041.1430056889685, 5819.780659022175, 1198.2391181599573, 1296.6434230586665, 1301.7136230029378, 1358.1918758338772, 1372.2298235276382, 853.8505761491714, 933.7161403070778, 978.1392374710209, 980.1472718734603, 991.137710192123, 4155.854545090968, 4960.13994751968, 5068.935523540098, 5345.49414103474, 5421.376541697677, 5167.475594699573, 5851.829634073202, 5938.138969849348, 5942.732577034044, 5956.404359564096, 5049.293098966147, 5122.667026643257, 5458.372287186945, 5513.889722205534, 5546.916796247979, 2624.370151163707, 2952.7342539171577, 3118.656947735747, 3145.874165033373, 3149.2126968257935, 5014.724190169576, 5284.682919024871, 5476.12382018883, 5649.774009039593, 6354.0, 4770.570648641569, 5092.745362731848, 5389.652586853286, 5721.083437048552, 6113.633182009094, 4925.802967881388, 6126.324205476678, 6138.232720909887, 6174.129030001161, 6176.973283091343, 5705.804749340383, 5919.6152250103605, 5956.0, 5956.017257152521, 5965.254343207099, 5287.4930644766055, 5799.420057994167, 5890.322612899571, 5908.231929849092, 5946.494547963472, 5587.273654424899, 5962.284525856751, 5999.791363439899, 6189.938100618936, 6204.224471941007, 3453.292075124644, 3889.4943657324366, 3925.5485619154165, 3931.4692516509904, 3945.6251656092627, 5182.429932707475, 5438.912217556425, 5474.315710536183, 5480.862978425412, 5950.98833198366, 5427.918581221206, 5711.571632127524, 5759.934412133769, 5791.82624521265, 5831.1836342912875, 4296.591823776736, 5262.842174721555, 5741.224934633771, 5745.798897038583, 5747.540196784331, 5444.794858082483, 5558.666480011212, 5641.407652196624, 5642.5987729571, 5653.2085508028085, 5324.8583335832045, 5668.886622267614, 5768.50967667753, 5814.215080964016, 5827.388124246893, 5481.835544933659, 5628.889166562539, 5666.914996274977, 5676.489115979582, 5681.801136960186], "value": 4172.874643923092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.9298673639267, 689.9586024838507, 695.2387136085985, 728.4136270302406, 821.7329367955416, 14362.210078445694, 15879.285432155537, 15999.760003599926, 16044.117573533451, 16069.357225710972, 13601.727965440685, 13609.38757755901, 14739.557813265592, 14773.48292809752, 14782.556523304318, 678.3589507915023, 701.1516065560678, 837.9120192379804, 859.9398042137053, 868.288003836854, 814.352589691197, 844.5059640110543, 844.6114787197896, 849.3926842307749, 866.8656358264479, 897.0536084430922, 900.2213085680871, 901.5717534171282, 901.7249738829687, 904.6697955246353, 700.2577268095835, 892.6563273139823, 894.5124906925741, 895.9462432254053, 896.4755617963499, 537.1432565058764, 632.8101569529123, 650.2229835346762, 656.3961155736733, 656.8292244016542, 14760.335784889705, 14777.335019924129, 14788.18664973426, 14808.0, 14816.0, 13072.08495405322, 13356.332183390792, 13375.0, 13384.330783460788, 13860.930695346458, 11055.447227638586, 11192.0, 11971.580994665232, 12179.208351457128, 12215.93892030543, 3992.061865461614, 4349.3041113421705, 4432.889177770549, 4433.357163211349, 4625.283081122431, 103133.4843325786, 105968.0, 106515.46742266239, 106921.93078069275, 109129.0, 10940.945295273472, 11029.22795404314, 11045.944770276097, 11228.270162439416, 11437.085033197323, 21771.67342489864, 21818.345449636538, 21823.0, 21829.235976740736, 21857.234996775038, 6878.931210687829, 7934.365250779923, 8006.759797206093, 8110.716124935717, 8119.685889521458, 4305.74165550068, 4456.331550267421, 4479.17135329965, 4535.773211339486, 4631.212693842055, 3340.732741380684, 3472.808995505221, 3477.1133360992785, 3481.5473988381855, 3493.1965647900615, 634.1819053421127, 639.3255115852727, 646.8641585267146, 651.8663673946829, 661.3254480430031, 564.3087218157806, 650.1515522243424, 663.0650782396798, 673.8382788130912, 684.7432212920155, 9255.213306868991, 9270.629174833066, 9283.0, 9372.109649583279, 9729.805403891882, 570.0736303506801, 606.3088079589272, 633.8859902226128, 636.5862189576719, 675.5170053411736, 4392.978035109868, 4673.415823022122, 4682.063587282489, 4684.484706682262, 4689.708722400333, 166938.16530917268, 169457.0, 172208.0, 173032.4045139324, 176927.57681058077, 100218.0, 136011.0, 137848.0, 141444.5855541452, 143202.0, 124626.37686811508, 124890.0, 125003.0, 126167.0, 129560.35219823841, 8568.14318568163, 8889.511076890833, 8907.0, 8911.108889111038, 9184.173424391836, 66634.33365666281, 68046.0, 68215.3178468209, 68368.6581567089, 70020.64989675018, 99921.50039249758, 101354.0, 102750.48624756829, 109965.45017274862, 110239.0, 11458.4270786462, 11511.36687482163, 11673.35796531165, 11881.168318217988, 12177.208481448677, 12367.319797411228, 12657.746845063231, 12839.358032098544, 12922.966162706773, 13145.34273286351, 10150.390976541432, 11180.944095279472, 11628.534858605899, 12004.279743215435, 12255.080868934687, 13164.934175329063, 13623.795643065163, 13727.588172354845, 13995.51015714445, 14815.777763333774, 10849.620263290746, 12903.290319032543, 13693.246871422167, 13798.93100534491, 14219.0, 10014.949925250326, 10830.566777328819, 11050.668479945614, 11141.442927853413, 11738.471768770596, 11075.05862001739, 11474.254173478697, 11621.24461909973, 11732.765344693229, 11735.823962640396], "value": 7807.406839207657, "unit": "score"}], "name": "dromaeo_css", "value": 7366.403628308238, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 109.0, 144.0, 109.0, 107.0, 108.0, 107.0, 138.0, 109.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 181.0, 184.0, 185.0, 184.0, 186.0, 245.0, 238.0, 183.0], "value": 195.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 59.0, 90.0, 63.0, 76.0, 86.0, 82.0, 74.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 93.0, 68.0, 68.0, 74.0, 126.0, 97.0, 93.0, 89.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 87.0, 88.0, 85.0, 90.0, 86.0, 89.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 96.0, 93.0, 95.0, 94.0, 95.0, 94.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 141.0, 91.0, 84.0, 87.0, 85.0, 85.0, 89.0, 84.0, 86.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 50.0, 52.0, 75.0, 87.0, 88.0, 84.0, 58.0, 57.0, 57.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 67.0, 76.0, 73.0, 69.0, 70.0, 71.0, 70.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 101.0, 103.0, 78.0, 82.0, 82.0, 84.0, 80.0, 82.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 152.0, 156.0, 147.0, 139.0, 142.0, 151.0, 205.0, 136.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 166.0, 159.0, 163.0, 164.0, 165.0, 163.0, 165.0, 166.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1467.9, "alertThreshold": 2.0}]} 12:55:29 INFO - Return code: 0 12:55:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:55:29 INFO - # TBPL SUCCESS # 12:55:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:55:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:55:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:55:29 INFO - 2016-10-13 12:55:29.271 screenresolution[1668:10275] starting screenresolution argv=screenresolution get 12:55:29 INFO - 2016-10-13 12:55:29.273 screenresolution[1668:10275] Display 0: 1600x1200x32@60 12:55:29 INFO - 2016-10-13 12:55:29.279 screenresolution[1669:10278] starting screenresolution argv=screenresolution list 12:55:29 INFO - Available Modes on Display 0 12:55:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:55:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:55:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:55:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:55:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:55:29 INFO - Intel Iris: 12:55:29 INFO - Chipset Model: Intel Iris 12:55:29 INFO - Type: GPU 12:55:29 INFO - Bus: Built-In 12:55:29 INFO - VRAM (Dynamic, Max): 1536 MB 12:55:29 INFO - Vendor: Intel (0x8086) 12:55:29 INFO - Device ID: 0x0a2e 12:55:29 INFO - Revision ID: 0x0009 12:55:29 INFO - Displays: 12:55:29 INFO - Display: 12:55:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:55:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:55:29 INFO - Display Serial Number: 1600x1200 60 12:55:29 INFO - Main Display: Yes 12:55:29 INFO - Mirror: Off 12:55:29 INFO - Online: Yes 12:55:29 INFO - Rotation: Supported 12:55:29 INFO - Return code: 0 12:55:29 INFO - Running post-action listener: _resource_record_post_action 12:55:29 INFO - [mozharness: 2016-10-13 19:55:29.514925Z] Finished run-tests step (success) 12:55:29 INFO - Running post-run listener: _resource_record_post_run 12:55:29 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 38548480; Write bytes: 663559168; Read time: 378; Write time: 1888 12:55:29 INFO - TinderboxPrint: CPU usage
53.3% 12:55:29 INFO - TinderboxPrint: I/O read bytes / time
38,548,480 / 378 12:55:29 INFO - TinderboxPrint: I/O write bytes / time
663,559,168 / 1,888 12:55:29 INFO - TinderboxPrint: CPU idle
2,260.8 (46.7%) 12:55:29 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 12:55:29 INFO - TinderboxPrint: CPU user
1,611.9 (33.3%) 12:55:29 INFO - TinderboxPrint: Swap in / out
401,891,328 / 0 12:55:29 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356227584; Write bytes: 356341760; Read time: 27652; Write time: 767 12:55:29 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37602304; Write bytes: 297030656; Read time: 364; Write time: 1091 12:55:29 INFO - Running post-run listener: _upload_blobber_files 12:55:29 INFO - Blob upload gear active. 12:55:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:55:29 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 12:55:29 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'] 12:55:29 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 12:55:30 INFO - (blobuploader) - INFO - Open directory for files ... 12:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:31 INFO - (blobuploader) - INFO - Done attempting. 12:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:32 INFO - (blobuploader) - INFO - Done attempting. 12:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:35 INFO - (blobuploader) - INFO - Done attempting. 12:55:35 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:35 INFO - Return code: 0 12:55:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9aaaf7d1f5e1ca394a1d06a37fbbcb4adc5f933f9b706d10eb872a996a9fed6295fbe6f2f1215a3e88d360ac87bef0bf15ad6085090aae213f36fdfbfc0afda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c73c3828a33f0f9b9ecfe891fa584f302a3fa0d0448554fbe85dc7a4a0787ed177336f921615f6e5c6395054a4584016adcb82a3e91bc5333661fb6f1c05327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ac117aeade9045cee45b7134845b162f18e101d0142b58e0fefbcfcd4994c8c18bed63916b9089c975402df4fba02d2a5e5f90300f1a9d9253b5fccc991ab90"} 12:55:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:35 INFO - Contents: 12:55:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9aaaf7d1f5e1ca394a1d06a37fbbcb4adc5f933f9b706d10eb872a996a9fed6295fbe6f2f1215a3e88d360ac87bef0bf15ad6085090aae213f36fdfbfc0afda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c73c3828a33f0f9b9ecfe891fa584f302a3fa0d0448554fbe85dc7a4a0787ed177336f921615f6e5c6395054a4584016adcb82a3e91bc5333661fb6f1c05327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ac117aeade9045cee45b7134845b162f18e101d0142b58e0fefbcfcd4994c8c18bed63916b9089c975402df4fba02d2a5e5f90300f1a9d9253b5fccc991ab90"} 12:55:35 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:35 INFO - Copying logs to upload dir... 12:55:35 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.460841 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-13 12:55:35.154092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 12:55:35.157678) ========= 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.yhHCI0NyxD/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.CKTiwz52OH/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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/f9aaaf7d1f5e1ca394a1d06a37fbbcb4adc5f933f9b706d10eb872a996a9fed6295fbe6f2f1215a3e88d360ac87bef0bf15ad6085090aae213f36fdfbfc0afda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c73c3828a33f0f9b9ecfe891fa584f302a3fa0d0448554fbe85dc7a4a0787ed177336f921615f6e5c6395054a4584016adcb82a3e91bc5333661fb6f1c05327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ac117aeade9045cee45b7134845b162f18e101d0142b58e0fefbcfcd4994c8c18bed63916b9089c975402df4fba02d2a5e5f90300f1a9d9253b5fccc991ab90"} build_url:https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010960 build_url: 'https://queue.taskcluster.net/v1/task/ME-CxKrvQzyJLTlb7Cp6xg/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/f9aaaf7d1f5e1ca394a1d06a37fbbcb4adc5f933f9b706d10eb872a996a9fed6295fbe6f2f1215a3e88d360ac87bef0bf15ad6085090aae213f36fdfbfc0afda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c73c3828a33f0f9b9ecfe891fa584f302a3fa0d0448554fbe85dc7a4a0787ed177336f921615f6e5c6395054a4584016adcb82a3e91bc5333661fb6f1c05327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ac117aeade9045cee45b7134845b162f18e101d0142b58e0fefbcfcd4994c8c18bed63916b9089c975402df4fba02d2a5e5f90300f1a9d9253b5fccc991ab90"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 12:55:35.190137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 12:55:35.190519) ========= 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.yhHCI0NyxD/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.CKTiwz52OH/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005200 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 12:55:35.239593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 12:55:35.239900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 12:55:35.240237) ========= ========= Total master_lag: 0.17 =========