builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0092 starttime: 1473780367.54 results: success (0) buildid: 20160913061607 builduid: 1dbb812b2c784b2c89d94ee85cfc2ee4 revision: 4c2d01fe1c38a9829008491681f3dd773b760bc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:07.545282) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:07.545987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:07.546465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:07.635410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:07.635959) ========= 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.61EQLHUqmt/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.E64oBPIi0R/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-13 08:26:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-09-13 08:26:08 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.610429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:08.270544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:08.270846) ========= 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.61EQLHUqmt/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.E64oBPIi0R/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.026354 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:08.318999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-13 08:26:08.319354) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4c2d01fe1c38a9829008491681f3dd773b760bc4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4c2d01fe1c38a9829008491681f3dd773b760bc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.61EQLHUqmt/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.E64oBPIi0R/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-13 08:26:08,387 truncating revision to first 12 chars 2016-09-13 08:26:08,387 Setting DEBUG logging. 2016-09-13 08:26:08,387 attempt 1/10 2016-09-13 08:26:08,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4c2d01fe1c38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 08:26:10,288 unpacking tar archive at: autoland-4c2d01fe1c38/testing/mozharness/ program finished with exit code 0 elapsedTime=2.150499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-13 08:26:10.492034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:10.492347) ========= script_repo_revision: 4c2d01fe1c38a9829008491681f3dd773b760bc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:10.492845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:10.493125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 08:26:10.511947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-13 08:26:10.512361) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.61EQLHUqmt/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.E64oBPIi0R/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:10 INFO - MultiFileLogger online at 20160913 08:26:10 in /builds/slave/test 08:26:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 08:26:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:10 INFO - {'append_to_log': False, 08:26:10 INFO - 'base_work_dir': '/builds/slave/test', 08:26:10 INFO - 'blob_upload_branch': 'Autoland', 08:26:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:10 INFO - 'branch': 'Autoland', 08:26:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:10 INFO - 'config_files': ('talos/mac_config.py',), 08:26:10 INFO - 'default_actions': ('clobber', 08:26:10 INFO - 'read-buildbot-config', 08:26:10 INFO - 'download-and-extract', 08:26:10 INFO - 'populate-webroot', 08:26:10 INFO - 'create-virtualenv', 08:26:10 INFO - 'install', 08:26:10 INFO - 'run-tests'), 08:26:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:10 INFO - 'download_minidump_stackwalk': True, 08:26:10 INFO - 'download_symbols': 'ondemand', 08:26:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:10 INFO - 'installer_path': 'installer.exe', 08:26:10 INFO - 'log_level': 'info', 08:26:10 INFO - 'log_name': 'talos', 08:26:10 INFO - 'log_to_console': True, 08:26:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:26:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:26:10 INFO - 'opt_config_files': (), 08:26:10 INFO - 'pip_index': False, 08:26:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:10 INFO - 'cmd': ('bash', 08:26:10 INFO - '-c', 08:26:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:10 INFO - 'enabled': True, 08:26:10 INFO - 'halt_on_failure': False, 08:26:10 INFO - 'name': 'check_screen_resolution'},), 08:26:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:10 INFO - 'cmd': ('bash', 08:26:10 INFO - '-c', 08:26:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:10 INFO - 'enabled': True, 08:26:10 INFO - 'halt_on_failure': False, 08:26:10 INFO - 'name': 'check_screen_resolution'},), 08:26:10 INFO - 'run_cmd_checks_enabled': True, 08:26:10 INFO - 'sps_profile': False, 08:26:10 INFO - 'sps_profile_interval': 0, 08:26:10 INFO - 'suite': 'dromaeojs', 08:26:10 INFO - 'system_bits': '32', 08:26:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:10 INFO - 'title': 't-yosemite-r7-0092', 08:26:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:10 INFO - 'use_talos_json': True, 08:26:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:10 INFO - 'work_dir': 'build'} 08:26:10 INFO - [mozharness: 2016-09-13 15:26:10.714082Z] Running clobber step. 08:26:10 INFO - Running pre-action listener: _resource_record_pre_action 08:26:10 INFO - Running main action method: clobber 08:26:10 INFO - rmtree: /builds/slave/test/build 08:26:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:12 INFO - Running post-action listener: _resource_record_post_action 08:26:12 INFO - [mozharness: 2016-09-13 15:26:12.827191Z] Finished clobber step (success) 08:26:12 INFO - [mozharness: 2016-09-13 15:26:12.827312Z] Running read-buildbot-config step. 08:26:12 INFO - Running pre-action listener: _resource_record_pre_action 08:26:12 INFO - Running main action method: read_buildbot_config 08:26:12 INFO - Using buildbot properties: 08:26:12 INFO - { 08:26:12 INFO - "project": "", 08:26:12 INFO - "product": "firefox", 08:26:12 INFO - "script_repo_revision": "production", 08:26:12 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 08:26:12 INFO - "repository": "", 08:26:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 08:26:12 INFO - "buildid": "20160913061607", 08:26:12 INFO - "pgo_build": "False", 08:26:12 INFO - "basedir": "/builds/slave/test", 08:26:12 INFO - "buildnumber": 220, 08:26:12 INFO - "slavename": "t-yosemite-r7-0092", 08:26:12 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:26:12 INFO - "platform": "yosemite_r7", 08:26:12 INFO - "scheduler": "tests-autoland-macosx64-talos", 08:26:12 INFO - "branch": "autoland", 08:26:12 INFO - "repo_path": "integration/autoland", 08:26:12 INFO - "revision": "4c2d01fe1c38a9829008491681f3dd773b760bc4", 08:26:12 INFO - "stage_platform": "macosx64", 08:26:12 INFO - "builduid": "1dbb812b2c784b2c89d94ee85cfc2ee4", 08:26:12 INFO - "slavebuilddir": "test" 08:26:12 INFO - } 08:26:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:26:12 INFO - Running post-action listener: _resource_record_post_action 08:26:12 INFO - [mozharness: 2016-09-13 15:26:12.830531Z] Finished read-buildbot-config step (success) 08:26:12 INFO - [mozharness: 2016-09-13 15:26:12.830647Z] Running download-and-extract step. 08:26:12 INFO - Running pre-action listener: _resource_record_pre_action 08:26:12 INFO - Running main action method: download_and_extract 08:26:12 INFO - mkdir: /builds/slave/test/build/tests 08:26: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')]} 08:26:12 INFO - trying https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:26:12 INFO - Downloading https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:26:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:26:13 INFO - Downloaded 1199 bytes. 08:26:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:26:13 INFO - Using the following test package requirements: 08:26:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:26:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:26:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:26:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'jsshell-mac.zip'], 08:26:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:26:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:26:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:26:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:26:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:26:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:26:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:26:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:26:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:26:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:26:13 INFO - Fetch https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 08:26:13 INFO - Expected file size: 16424748 08:26:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:26:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:26:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:26:21 INFO - Fetch https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 08:26:22 INFO - Expected file size: 16424748 08:26:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:26:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:26:28 INFO - Fetch https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip into memory 08:26:29 INFO - Expected file size: 14414048 08:26:30 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')]} 08:26:30 INFO - trying https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:26:30 INFO - Downloading https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:26:34 INFO - Downloaded 111448123 bytes. 08:26:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:26:34 INFO - mkdir: /builds/slave/test/properties 08:26:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:34 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:34 INFO - Contents: 08:26:34 INFO - build_url:https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:26:34 INFO - Running post-action listener: _resource_record_post_action 08:26:34 INFO - Running post-action listener: set_extra_try_arguments 08:26:34 INFO - [mozharness: 2016-09-13 15:26:34.800798Z] Finished download-and-extract step (success) 08:26:34 INFO - [mozharness: 2016-09-13 15:26:34.800893Z] Running populate-webroot step. 08:26:34 INFO - Running pre-action listener: _resource_record_pre_action 08:26:34 INFO - Running main action method: populate_webroot 08:26:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:34 INFO - '--tppagecycles', 08:26:34 INFO - '7'], 08:26:34 INFO - 'tests': ['tsvgm']}}, 08:26:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['damp', 'tps']}, 08:26:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'tests': ['damp', 'tps']}, 08:26:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['dromaeo_dom']}, 08:26:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['basic_compositor_video']}, 08:26:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:26:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['a11yr', 08:26:34 INFO - 'ts_paint', 08:26:34 INFO - 'tpaint', 08:26:34 INFO - 'sessionrestore', 08:26:34 INFO - 'sessionrestore_no_auto_restore', 08:26:34 INFO - 'tabpaint']}, 08:26:34 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:34 INFO - 'ts_paint', 08:26:34 INFO - 'tpaint', 08:26:34 INFO - 'sessionrestore', 08:26:34 INFO - 'sessionrestore_no_auto_restore', 08:26:34 INFO - 'tabpaint']}, 08:26:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:34 INFO - 'ts_paint', 08:26:34 INFO - 'tpaint', 08:26:34 INFO - 'sessionrestore', 08:26:34 INFO - 'sessionrestore_no_auto_restore', 08:26:34 INFO - 'tabpaint']}, 08:26:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:34 INFO - 'ts_paint', 08:26:34 INFO - 'tpaint', 08:26:34 INFO - 'sessionrestore', 08:26:34 INFO - 'sessionrestore_no_auto_restore', 08:26:34 INFO - 'tabpaint']}, 08:26:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['a11yr', 08:26:34 INFO - 'ts_paint', 08:26:34 INFO - 'tpaint', 08:26:34 INFO - 'sessionrestore', 08:26:34 INFO - 'sessionrestore_no_auto_restore', 08:26:34 INFO - 'tabpaint']}, 08:26:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['a11yr', 08:26:34 INFO - 'ts_paint', 08:26:34 INFO - 'tpaint', 08:26:34 INFO - 'sessionrestore', 08:26:34 INFO - 'sessionrestore_no_auto_restore', 08:26:34 INFO - 'tabpaint']}, 08:26:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['tsvgx', 08:26:34 INFO - 'tsvgr_opacity', 08:26:34 INFO - 'tart', 08:26:34 INFO - 'tscrollx', 08:26:34 INFO - 'cart']}, 08:26:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:34 INFO - 'tsvgr_opacity', 08:26:34 INFO - 'tart', 08:26:34 INFO - 'tscrollx', 08:26:34 INFO - 'cart']}, 08:26:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'talos_options': ['--disable-e10s'], 08:26:34 INFO - 'tests': ['tp5o']}, 08:26:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'tests': ['tp5o']}, 08:26:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'talos_options': ['--disable-e10s', 08:26:34 INFO - '--xperf_path', 08:26:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:34 INFO - 'tests': ['tp5n']}, 08:26:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:34 INFO - 'talos_options': ['--xperf_path', 08:26:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:34 INFO - 'tests': ['tp5n']}}, 08:26:34 INFO - 'talos.zip': {'path': '', 08:26:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:34 INFO - Running post-action listener: _resource_record_post_action 08:26:34 INFO - [mozharness: 2016-09-13 15:26:34.820036Z] Finished populate-webroot step (success) 08:26:34 INFO - [mozharness: 2016-09-13 15:26:34.820148Z] Running create-virtualenv step. 08:26:34 INFO - Running pre-action listener: _resource_record_pre_action 08:26:34 INFO - Running main action method: create_virtualenv 08:26:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:34 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 08:26:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:34 INFO - Using real prefix '/tools/python27' 08:26:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:35 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:38 INFO - Installing pip.................done. 08:26:38 INFO - Return code: 0 08:26:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:38 INFO - 'HOME': '/Users/cltbld', 08:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:38 INFO - 'LOGNAME': 'cltbld', 08:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:38 INFO - 'MOZ_NO_REMOTE': '1', 08:26:38 INFO - 'NO_EM_RESTART': '1', 08:26:38 INFO - 'PAGER': '/bin/cat', 08:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:38 INFO - 'PWD': '/builds/slave/test', 08:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:38 INFO - 'SHELL': '/bin/bash', 08:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:26:38 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:38 INFO - 'USER': 'cltbld', 08:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:38 INFO - 'XPC_FLAGS': '0x0', 08:26:38 INFO - 'XPC_SERVICE_NAME': '0', 08:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:38 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 08:26:38 INFO - Cleaning up... 08:26:38 INFO - Return code: 0 08:26:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:38 INFO - 'HOME': '/Users/cltbld', 08:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:38 INFO - 'LOGNAME': 'cltbld', 08:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:38 INFO - 'MOZ_NO_REMOTE': '1', 08:26:38 INFO - 'NO_EM_RESTART': '1', 08:26:38 INFO - 'PAGER': '/bin/cat', 08:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:38 INFO - 'PWD': '/builds/slave/test', 08:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:38 INFO - 'SHELL': '/bin/bash', 08:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:26:38 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:38 INFO - 'USER': 'cltbld', 08:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:38 INFO - 'XPC_FLAGS': '0x0', 08:26:38 INFO - 'XPC_SERVICE_NAME': '0', 08:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:39 INFO - Downloading/unpacking psutil>=3.1.1 08:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:42 INFO - Installing collected packages: psutil 08:26:42 INFO - Running setup.py install for psutil 08:26:43 INFO - building 'psutil._psutil_osx' extension 08:26:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:26:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:26:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:26:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:26:43 INFO - building 'psutil._psutil_posix' extension 08:26:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:26:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:26:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:26:43 INFO - ^ 08:26:43 INFO - 1 warning generated. 08:26:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:26:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:44 INFO - Successfully installed psutil 08:26:44 INFO - Cleaning up... 08:26:44 INFO - Return code: 0 08:26:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:44 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')]} 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 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')]} 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 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 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:44 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 08:26:44 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 08:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:44 INFO - 'HOME': '/Users/cltbld', 08:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:44 INFO - 'LOGNAME': 'cltbld', 08:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:44 INFO - 'MOZ_NO_REMOTE': '1', 08:26:44 INFO - 'NO_EM_RESTART': '1', 08:26:44 INFO - 'PAGER': '/bin/cat', 08:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:44 INFO - 'PWD': '/builds/slave/test', 08:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:44 INFO - 'SHELL': '/bin/bash', 08:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:26:44 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:44 INFO - 'USER': 'cltbld', 08:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:44 INFO - 'XPC_FLAGS': '0x0', 08:26:44 INFO - 'XPC_SERVICE_NAME': '0', 08:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:26:44 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 08:26:44 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 08:26:44 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 08:26:44 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 08:26:44 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 08:26:44 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 08:26:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:26:47 INFO - Installing collected packages: mozsystemmonitor 08:26:47 INFO - Running setup.py install for mozsystemmonitor 08:26:47 INFO - Successfully installed mozsystemmonitor 08:26:47 INFO - Cleaning up... 08:26:47 INFO - Return code: 0 08:26:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:26:47 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')]} 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:47 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')]} 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:47 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 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:47 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 08:26:47 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 08:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:47 INFO - 'HOME': '/Users/cltbld', 08:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:47 INFO - 'LOGNAME': 'cltbld', 08:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:47 INFO - 'MOZ_NO_REMOTE': '1', 08:26:47 INFO - 'NO_EM_RESTART': '1', 08:26:47 INFO - 'PAGER': '/bin/cat', 08:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:47 INFO - 'PWD': '/builds/slave/test', 08:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:47 INFO - 'SHELL': '/bin/bash', 08:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:26:47 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:47 INFO - 'USER': 'cltbld', 08:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:47 INFO - 'XPC_FLAGS': '0x0', 08:26:47 INFO - 'XPC_SERVICE_NAME': '0', 08:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:47 INFO - Downloading/unpacking jsonschema==2.5.1 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:26:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:26:50 INFO - warning: no files found matching '*.txt' 08:26:50 INFO - no previously-included directories found matching 'build' 08:26:50 INFO - no previously-included directories found matching 'dist' 08:26:50 INFO - no previously-included directories found matching '.git*' 08:26:50 INFO - Installing collected packages: jsonschema, functools32 08:26:50 INFO - Running setup.py install for functools32 08:26:50 INFO - warning: no files found matching '*.txt' 08:26:50 INFO - no previously-included directories found matching 'build' 08:26:50 INFO - no previously-included directories found matching 'dist' 08:26:50 INFO - no previously-included directories found matching '.git*' 08:26:50 INFO - Successfully installed jsonschema functools32 08:26:50 INFO - Cleaning up... 08:26:50 INFO - Return code: 0 08:26:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:26:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:26:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:50 INFO - 'HOME': '/Users/cltbld', 08:26:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:50 INFO - 'LOGNAME': 'cltbld', 08:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:50 INFO - 'MOZ_NO_REMOTE': '1', 08:26:50 INFO - 'NO_EM_RESTART': '1', 08:26:50 INFO - 'PAGER': '/bin/cat', 08:26:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:50 INFO - 'PWD': '/builds/slave/test', 08:26:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:50 INFO - 'SHELL': '/bin/bash', 08:26:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:26:50 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:26:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:50 INFO - 'USER': 'cltbld', 08:26:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:50 INFO - 'XPC_FLAGS': '0x0', 08:26:50 INFO - 'XPC_SERVICE_NAME': '0', 08:26:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:26:50 INFO - Cleaning up... 08:26:50 INFO - Return code: 0 08:26:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:26:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:26:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:50 INFO - 'HOME': '/Users/cltbld', 08:26:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:50 INFO - 'LOGNAME': 'cltbld', 08:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:50 INFO - 'MOZ_NO_REMOTE': '1', 08:26:50 INFO - 'NO_EM_RESTART': '1', 08:26:50 INFO - 'PAGER': '/bin/cat', 08:26:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:50 INFO - 'PWD': '/builds/slave/test', 08:26:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:50 INFO - 'SHELL': '/bin/bash', 08:26:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:26:50 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:26:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:50 INFO - 'USER': 'cltbld', 08:26:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:50 INFO - 'XPC_FLAGS': '0x0', 08:26:50 INFO - 'XPC_SERVICE_NAME': '0', 08:26:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:54 INFO - Downloading docopt-0.6.1.tar.gz 08:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:54 INFO - Running setup.py install for blobuploader 08:26:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:55 INFO - Running setup.py install for requests 08:26:55 INFO - Running setup.py install for docopt 08:26:55 INFO - Successfully installed blobuploader requests docopt 08:26:55 INFO - Cleaning up... 08:26:55 INFO - Return code: 0 08:26:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:26:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:26:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:55 INFO - 'HOME': '/Users/cltbld', 08:26:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:55 INFO - 'LOGNAME': 'cltbld', 08:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:55 INFO - 'MOZ_NO_REMOTE': '1', 08:26:55 INFO - 'NO_EM_RESTART': '1', 08:26:55 INFO - 'PAGER': '/bin/cat', 08:26:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:55 INFO - 'PWD': '/builds/slave/test', 08:26:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:55 INFO - 'SHELL': '/bin/bash', 08:26:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:26:55 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:26:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:55 INFO - 'USER': 'cltbld', 08:26:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:55 INFO - 'XPC_FLAGS': '0x0', 08:26:55 INFO - 'XPC_SERVICE_NAME': '0', 08:26:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-jaizkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-qyJQYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-sEsG4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Qwb_jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-ZmTFn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-_dCGB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-DsYUdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-6HZ11l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:56 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-B60tOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-3wDtsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-doNclx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-U6MSKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-U6rVGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-211TK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-qnKaOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-WZEcHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:57 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-WO2QRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:57 INFO - Running setup.py install for manifestparser 08:26:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozcrash 08:26:58 INFO - Running setup.py install for mozdebug 08:26:58 INFO - Running setup.py install for mozdevice 08:26:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozfile 08:26:58 INFO - Running setup.py install for mozhttpd 08:26:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozinfo 08:26:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozInstall 08:26:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for mozleak 08:26:59 INFO - Running setup.py install for mozlog 08:26:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for moznetwork 08:26:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for mozprocess 08:26:59 INFO - Running setup.py install for mozprofile 08:26:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for mozrunner 08:27:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Running setup.py install for mozscreenshot 08:27:00 INFO - Running setup.py install for moztest 08:27:00 INFO - Running setup.py install for mozversion 08:27:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:27:00 INFO - Cleaning up... 08:27:00 INFO - Return code: 0 08:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:00 INFO - 'HOME': '/Users/cltbld', 08:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:00 INFO - 'LOGNAME': 'cltbld', 08:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:00 INFO - 'MOZ_NO_REMOTE': '1', 08:27:00 INFO - 'NO_EM_RESTART': '1', 08:27:00 INFO - 'PAGER': '/bin/cat', 08:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:00 INFO - 'PWD': '/builds/slave/test', 08:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:00 INFO - 'SHELL': '/bin/bash', 08:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:27:00 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:00 INFO - 'USER': 'cltbld', 08:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:00 INFO - 'XPC_FLAGS': '0x0', 08:27:00 INFO - 'XPC_SERVICE_NAME': '0', 08:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-sWmoYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-g6IwOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Tpokxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-SOL7A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-5RmhFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-dcbcwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-32zQue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-9eroEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-9uWHos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-XGGY1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:01 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-UJBDl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:02 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-86p_s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:02 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-rRJIsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:02 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Lwx70q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:02 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Dx3hfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:02 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-PK733f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:02 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-MGK25O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27: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 08:27: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 08:27: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 08:27: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 08:27: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 08:27: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 08:27:05 INFO - Downloading blessings-1.6.tar.gz 08:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:05 INFO - Installing collected packages: blessings 08:27:05 INFO - Running setup.py install for blessings 08:27:05 INFO - Successfully installed blessings 08:27:05 INFO - Cleaning up... 08:27:05 INFO - Return code: 0 08:27:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:05 INFO - Reading from file tmpfile_stdout 08:27:05 INFO - Current package versions: 08:27:05 INFO - blessings == 1.6 08:27:05 INFO - blobuploader == 1.2.4 08:27:05 INFO - docopt == 0.6.1 08:27:05 INFO - functools32 == 3.2.3-2 08:27:05 INFO - jsonschema == 2.5.1 08:27:05 INFO - manifestparser == 1.1 08:27:05 INFO - mozInstall == 1.12 08:27:05 INFO - mozcrash == 0.17 08:27:05 INFO - mozdebug == 0.1 08:27:05 INFO - mozdevice == 0.48 08:27:05 INFO - mozfile == 1.2 08:27:05 INFO - mozhttpd == 0.7 08:27:05 INFO - mozinfo == 0.9 08:27:05 INFO - mozleak == 0.1 08:27:05 INFO - mozlog == 3.3 08:27:05 INFO - moznetwork == 0.27 08:27:05 INFO - mozprocess == 0.23 08:27:05 INFO - mozprofile == 0.28 08:27:05 INFO - mozrunner == 6.12 08:27:05 INFO - mozscreenshot == 0.1 08:27:05 INFO - mozsystemmonitor == 0.3 08:27:05 INFO - moztest == 0.7 08:27:05 INFO - mozversion == 1.4 08:27:05 INFO - psutil == 3.1.1 08:27:05 INFO - requests == 1.2.3 08:27:05 INFO - wsgiref == 0.1.2 08:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:05 INFO - 'HOME': '/Users/cltbld', 08:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:05 INFO - 'LOGNAME': 'cltbld', 08:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:05 INFO - 'MOZ_NO_REMOTE': '1', 08:27:05 INFO - 'NO_EM_RESTART': '1', 08:27:05 INFO - 'PAGER': '/bin/cat', 08:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:05 INFO - 'PWD': '/builds/slave/test', 08:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:05 INFO - 'SHELL': '/bin/bash', 08:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:27:05 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:05 INFO - 'USER': 'cltbld', 08:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:05 INFO - 'XPC_FLAGS': '0x0', 08:27:05 INFO - 'XPC_SERVICE_NAME': '0', 08:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 INFO - Cleaning up... 08:27:06 INFO - Return code: 0 08:27:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27:06 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')]} 08:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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')]} 08:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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 0x101476490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2815d44c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, '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.61EQLHUqmt/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.E64oBPIi0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:27:06 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 08:27:06 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 08:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:06 INFO - 'HOME': '/Users/cltbld', 08:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:06 INFO - 'LOGNAME': 'cltbld', 08:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:06 INFO - 'MOZ_NO_REMOTE': '1', 08:27:06 INFO - 'NO_EM_RESTART': '1', 08:27:06 INFO - 'PAGER': '/bin/cat', 08:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:06 INFO - 'PWD': '/builds/slave/test', 08:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:06 INFO - 'SHELL': '/bin/bash', 08:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:27:06 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:06 INFO - 'USER': 'cltbld', 08:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:06 INFO - 'XPC_FLAGS': '0x0', 08:27:06 INFO - 'XPC_SERVICE_NAME': '0', 08:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:27:06 INFO - Cleaning up... 08:27:06 INFO - Return code: 0 08:27:06 INFO - Running post-action listener: _resource_record_post_action 08:27:06 INFO - Running post-action listener: _start_resource_monitoring 08:27:06 INFO - Starting resource monitoring. 08:27:06 INFO - [mozharness: 2016-09-13 15:27:06.360731Z] Finished create-virtualenv step (success) 08:27:06 INFO - [mozharness: 2016-09-13 15:27:06.361776Z] Running install step. 08:27:06 INFO - Running pre-action listener: _resource_record_pre_action 08:27:06 INFO - Running main action method: install 08:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:06 INFO - Reading from file tmpfile_stdout 08:27:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:06 INFO - Reading from file tmpfile_stdout 08:27:06 INFO - Output received: 08:27:06 INFO - Usage: mozinstall [options] installer 08:27:06 INFO - Options: 08:27:06 INFO - -h, --help show this help message and exit 08:27:06 INFO - -d DEST, --destination=DEST 08:27:06 INFO - Directory to install application into. [default: 08:27:06 INFO - "/builds/slave/test"] 08:27:06 INFO - --app=APP Application being installed. [default: firefox] 08:27:06 INFO - mkdir: /builds/slave/test/build/application 08:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:27:40 INFO - Reading from file tmpfile_stdout 08:27:40 INFO - Output received: 08:27:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:27:40 INFO - Running post-action listener: _resource_record_post_action 08:27:40 INFO - [mozharness: 2016-09-13 15:27:40.626633Z] Finished install step (success) 08:27:40 INFO - [mozharness: 2016-09-13 15:27:40.626770Z] Running run-tests step. 08:27:40 INFO - Running pre-action listener: _resource_record_pre_action 08:27:40 INFO - Running main action method: run_tests 08:27:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:40 INFO - 2016-09-13 08:27:40.641 screenresolution[1643:8177] starting screenresolution argv=screenresolution get 08:27:40 INFO - 2016-09-13 08:27:40.644 screenresolution[1643:8177] Display 0: 1600x1200x32@60 08:27:40 INFO - 2016-09-13 08:27:40.650 screenresolution[1644:8179] starting screenresolution argv=screenresolution list 08:27:40 INFO - Available Modes on Display 0 08:27:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:40 INFO - Intel Iris: 08:27:40 INFO - Chipset Model: Intel Iris 08:27:40 INFO - Type: GPU 08:27:40 INFO - Bus: Built-In 08:27:40 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:40 INFO - Vendor: Intel (0x8086) 08:27:40 INFO - Device ID: 0x0a2e 08:27:40 INFO - Revision ID: 0x0009 08:27:40 INFO - Displays: 08:27:40 INFO - Display: 08:27:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:40 INFO - Display Serial Number: 1600x1200 60 08:27:40 INFO - Main Display: Yes 08:27:40 INFO - Mirror: Off 08:27:40 INFO - Online: Yes 08:27:40 INFO - Rotation: Supported 08:27:40 INFO - Return code: 0 08:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:40 INFO - Python 2.7.3 08:27:40 INFO - Return code: 0 08:27:40 INFO - grabbing minidump binary from tooltool 08:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:40 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 0x10128ad30>, '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 0x1010b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101282b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:40 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 08:27:40 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 08:27:40 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 08:27:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:41 INFO - Return code: 0 08:27:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:27:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:27:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 08:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0092 --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 08:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EQLHUqmt/Render', 08:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:41 INFO - 'HOME': '/Users/cltbld', 08:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:41 INFO - 'LOGNAME': 'cltbld', 08:27:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:41 INFO - 'MOZ_NO_REMOTE': '1', 08:27:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:41 INFO - 'NO_EM_RESTART': '1', 08:27:41 INFO - 'PAGER': '/bin/cat', 08:27:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:41 INFO - 'PWD': '/builds/slave/test', 08:27:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:41 INFO - 'SHELL': '/bin/bash', 08:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E64oBPIi0R/Listeners', 08:27:41 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:41 INFO - 'USER': 'cltbld', 08:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:41 INFO - 'XPC_FLAGS': '0x0', 08:27:41 INFO - 'XPC_SERVICE_NAME': '0', 08:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 08:27:41 INFO - mozversion application_buildid: 20160913061607 08:27:41 INFO - mozversion application_changeset: 4c2d01fe1c38a9829008491681f3dd773b760bc4 08:27:41 INFO - mozversion application_display_name: Nightly 08:27:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:41 INFO - mozversion application_name: Firefox 08:27:41 INFO - mozversion application_remotingname: firefox 08:27:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:27:41 INFO - mozversion application_vendor: Mozilla 08:27:41 INFO - mozversion application_version: 51.0a1 08:27:41 INFO - mozversion platform_buildid: 20160913061607 08:27:41 INFO - mozversion platform_changeset: 4c2d01fe1c38a9829008491681f3dd773b760bc4 08:27:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:27:41 INFO - mozversion platform_version: 51.0a1 08:27:41 INFO - using testdate: 1473780461 08:27:41 INFO - actual date: 1473780461 08:27:41 INFO - starting webserver on 'localhost:49272' 08:27:41 INFO - SUITE-START | Running 2 tests 08:27:41 INFO - TEST-START | dromaeo_css 08:27:41 INFO - operating with platform_type : mac_ 08:27:41 INFO - Initialising browser for dromaeo_css test... 08:27:41 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpbOm5He/profile http://localhost:49272/getInfo.html) 08:27:43 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 08:27:43 INFO - PROCESS | 1654 | colorDepth:24 08:27:43 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 08:27:43 INFO - PROCESS | 1654 | __metrics 08:27:43 INFO - PROCESS | 1654 | 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" 08:27:43 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:44 INFO - TEST-INFO | 1654: exit 0 08:27:44 INFO - Browser initialized. 08:27:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:44 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpbOm5He/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:56 INFO - PROCESS | 1657 | RSS: Main: 229314560 08:27:56 INFO - PROCESS | 1657 | 08:28:47 INFO - PROCESS | 1657 | 1473780527275 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] 08:30:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 08:31:00 INFO - PROCESS | 1657 | RSS: Main: 341950464 08:31:00 INFO - PROCESS | 1657 | 08:34:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 08:34:04 INFO - PROCESS | 1657 | RSS: Main: 371691520 08:34:04 INFO - PROCESS | 1657 | 08:37:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 08:37:07 INFO - PROCESS | 1657 | RSS: Main: 361328640 08:37:07 INFO - PROCESS | 1657 | 08:40:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 08:40:10 INFO - PROCESS | 1657 | RSS: Main: 349052928 08:40:10 INFO - PROCESS | 1657 | 08:43:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 08:43:14 INFO - PROCESS | 1657 | RSS: Main: 325390336 08:43:14 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 08:46:17 INFO - PROCESS | 1657 | RSS: Main: 471613440 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | __start_tp_report 08:46:17 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 08:46:17 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 08:46:17 INFO - PROCESS | 1657 | |i|pagename|runs| 08:46:17 INFO - PROCESS | 1657 | |0;dojo.html;3273.6889995450424;3304.206990322323;3357.3956687796185;3372.173817414733;3385.9322813543745;5612.719364031792;5663.688497132656;5669.8582535436635;5716;5743.454371834674;5667.801626943058;5691.601587888849;5703.03048481758;5712.457316554931;5722;5188.636795424312;5206.505381988705;5241.5020573045695;5257.395399529065;5286.682799032051;5287.576993840484;5307.124324486455;5313.123334649778;5323.680579165262;5429.429909859467;5300.416954135042;5352.812651557197;5365.570754339663;5368.355797304329;5425.484578964992;5155.819546315898;5321.574274058066;5343.465653434664;5414.35027796663;5422.15956526735;5242.135047717122;5269.841904742864;5294.894102117974;5346.6524675896335;5347.598930080259;5629.408912064257;5644.774209031634;5694.857628559278;5696.031674615326;5752.395998420189;5227.60792940531;6061.696915154269;6174.7530098796;6183.536234782365;6247.437730604267;5786.42135786418;6262.530310226705;6263.655498947556;6273.749050037993;6278.780242691484;5660.745266463019;5710.37185909558;5715.714214289269;5828.06750919855;5845.7369418376275;6175.2589689237575;6185.41238582334;6233.501319894398;6290.654014029181;6298.149749783721;5200.947990520122;6017.6389416634265;6168.013117901114;6174.783882564088;6186.505079593621;6122.123558664931;6169.9383006170265;6234.937650623527;6284.748610055638;6284.780032698834;6128.479079278222;6128.961487065963;6166.136740856284;6167.352427995085;6216.53375996793;6165.5375846810775;6249.625022498664;6262.1859158310035;6264.436200741864;6284.371562843679;4841.588464980516;4876.536729010738;4931.605471562339;4948.62885283598;4973.825916092919;4371.519132895379;4388.648908087345;4425.800838962255;4442.400275962768;4468.776561171929;5715.371309155989;5720.370759216483;5732.742026608813;5742.425757424307;5746.396628354046;6277.52918531112;6283.96858015707;6292.433680968643;6294.685265736694;6321.051842223703;5535.944640553624;5571.4428557143965;5706.572007099401;5708.343540492813;5708.543316534668;4611.861644150681;5403.675779453167;5430.104032834538;5447.509724124848;5473.124300112043;6359.809205723743;6362.936370636235;6363.459105976044;6371.904421433682;6376.884045292055;6097.433938678448;6098.3414614785315;6131.957816599936;6164.47601953839;6290.811275661737;5422.755975981011;6239.282482514387;6368.363163683594;6387.552871298964;6402.231732192166;6145;6173.170489524341;6211.161493198541;6231.937680623136;6232.220972378453;6111.327753947151;6173.722182501888;6255.53083518747;6259.937400625936;6274.937250627435;5968.46283834457;6008.909866352095;6012.398760123952;6032.306284777307;6137.539684523589;6001.2498437695285;6171.814845554641;6186.969065154645;6190.380961903954;6195.1636529068;4968.55283024515;5723.484886360247;5853.619514731528;5990.161377407254;6019.18740969981;6039.275286965592;6064.575479716554;6088.939110609014;6098.268207814913;6105.793350785129;5957.314908785372;6006.189164462741;6009.969950150221;6019.1573179754;6073.483753880793 08:46:17 INFO - PROCESS | 1657 | |1;ext.html;465.8975025494391;470.6799376424032;501.5305155893234;517.9844604661856;533.565144407308;27714.44571108579;29468.410631787377;40246.798766006126;41610.791946040306;41784;42940.57059429405;43357.34963975535;43390;43417.56582434175;43536.12927741443;9755.414675119498;9944.204463642927;9946.30375873689;9953.800923981516;9977.600895964153;8730.607122679463;8901.599428025755;9757.853632195523;11884.049276057938;12081.939590302036;11980.041596672289;12039.976601988797;12055.035597152251;12064.57773977911;12075.154739168262;12116.151869369147;12166.878331216663;12170.81743773844;12178.208416452902;12183.51265949361;11838.348890811001;11913.583024594098;11924.165308428413;11951.342676152808;11965.04279657634;39716.801415993024;39999.80000099981;40029;40041.59958400408;40270.79864600658;3306.1404034950847;3423;3426.9828650856834;3630.3173063599666;3723.1809002019513;30182;30624.77500899961;30790.53814192789;31336.843315783502;31389.686103139135;2593.8054645901443;3155.96844031559;3171.413288541627;3171.6194056713343;3278.7704860659765;416105;417811;420547;421754;423574.88212559046;60235.69882150561;60817;60898.08652870211;60910.695446522484;60922;34362;58480.4151958475;58750.70624646849;63768;63835.6808215956;15615.297311621005;16310.918445407697;16417.83582164187;16431.096289703943;16438.424655137012;11422.714432139262;12511.812322815165;12620.936895315464;12621.305828179538;12627.747445051047;16851.41020064292;17028.148592570324;18467;18507.259709611735;18870.962097084794;6807.421369183576;7907.802304942423;7996.480228785111;8013.318867896294;8087.797805054921;852.2798235491;904.7466709321401;931.5560880634989;954.8663187153804;1078.3853203673987;29090.854545727136;30001.39997200044;30110.946116885803;30601.89118952158;30754.846225768728;1041.9479026048666;1048.9213309001855;1082.637316498966;1100.0594491709473;1134.5631931706353;15586.688266234612;15615.765763513557;15637.452689155825;15659.530214093595;15961.760573591406;573253;574744;578257;578380;581275;57152;57421.10946686425;57465.85068298611;57468;57472.71263643655;1201.6995751062234;1240.9565665201856;1346.6902612399203;1347.3667376333108;1358.3140514040347;29841.612670985836;30895.0731478056;31124;31802.522962155123;31912.840435797672;50042.49957500524;54652.18021729598;55270.72364638312;55495;59256.70371648114;626529;630172;632543;633340;634518;26196.345091372867;26915.86542067277;26964.730352697006;27390.5891411625;27727.44545109046;46988.59034228978;47315.29027064528;47412.7629361851;47814.52185478101;47835.043299134515;38659.22681546297;38765.41851872168;38916.63791767274;39025.6097439022;40799.980000500225;38489.80755096207;38684.6131538681;38748;39772.40341394823;40340.79829600833;37896.62103379041;38381;38550.42174367443;38558.80720596379;38721.4191787129;32231.677683222868;33855.98432047042;33867.15332116717;33928.97173914134;34417.48373774446;21529.246476373253;25121.246362609152;25352.87323563444;25500;25626.359341016625 08:46:17 INFO - PROCESS | 1657 | |2;jquery.html;353.87437459701823;373.8560654148152;375.643139017933;384.5155104568243;404.9473568436103;15005.39978400864;15130.54608361748;16787.580310492245;20154.69767953482;20726.378208653765;12097;14677.192754398504;20209.595808083828;20724.27465038724;20943.952802359858;5486.561075113981;5762.711864406784;5766.711664416763;5767.625104368223;5775.624584402;5264.789408423659;5583.916241256385;6913.965430172842;6981.441484681213;7036.577805331696;5690.374058853523;6741.359570840762;6977.755778547752;6991.126109236346;6992.6154061526595;6908.3437073477935;6936.79189624312;6937.861242775141;6944;6965.094537710065;4764.547368000034;6001.12983617373;6089.512838972872;6091.725872335711;6092.299385570672;13397.66505837352;13482.258475783829;13488.527901523497;24135.63796543053;25225.747742522522;2128.4998025464;2172.1420039084474;2549.974500254992;2940.676695487018;2962.42232764611;10237;11636.709082272926;12263.75472490554;16096;16211.108389038598;1827.4740591606026;1870.9906450467797;1872.1481725814722;1985.7617085949778;2017.818396344336;112949;116940.41529792381;122222;130815;135641.3217933904;10762.300450470695;10925.180611454172;11119;11374.20380573352;11542.884571154349;14574;14592.562223133324;14600.050996685182;14603.634909127357;14607.561773146823;7511.699532018658;8377.748667539983;8488.066312705598;8596.8710469343;8598.097199794056;8227.300679442315;8302.958485207657;8518.957405212934;8567.700130495403;8568.528730919734;3825.770453772727;3923.8234279457492;4467.8212871484775;4549.385832912581;4573.725576465423;1640.5488490664925;1856.7493388392663;1912.1108684461792;1927.575933294673;1933.8162874526897;818.7461886815106;888.0675290944482;922.8846394200591;962.1773383756927;969.2004096620317;19560.608787824163;20301.796982030286;21061.578768424544;21070.367888963356;21077;887.5695287785419;917.7567944494714;926.333040211047;932.3566738950103;932.7807965128189;10377.481125943672;11071.557137714562;11813.763724725457;11992.280463172237;12058.879411205951;570988;570999;572893;599133.0839917784;626165;97226;120539.39730301293;122530;123145;144677;431.81431984247075;453.3403897329378;454.54091367718183;454.9454065512094;456.1766012347744;9760.121589057018;9763.365381250196;10016.148627366463;11062.778744425228;11090.500927458123;51936.74031629818;52837.735811320694;53008;53612.73193634007;55150.44849551453;68368.3163168362;79122.81315780383;79500.20499794927;79570.6021469889;82417.58791206006;7419.9258007421395;7968.442209045543;8035.638396272065;8254.215849494289;8366.748997530083;10937.781244375226;11923.523059077539;12477.750444990868;12674.619761407173;12978.351082445652;11066.557337706401;11091.279066860629;11131.499082541142;11169.944150279196;11171.497282622464;10751.139908807432;10922.672319830417;11112.555497779998;11208.831867522156;11227.66317010491;11073.335599864035;11276.041536469493;11401.20191586581;11429.59996400122;11629.24409913353;7991.64037618297;8090;8112.675492980451;8120.645012946416;8384.622691978997;8286.875696864432;10002.649907253211;10362.896371036193;10537.315074520131;10803.945980270048 08:46:17 INFO - PROCESS | 1657 | |3;mootools.html;1285.8392700912386;1304.823848780415;1390.5758743583206;1613.8305477924819;1883.8681292309543;7449.925500744991;8271.66913323467;8762.34282428818;8927.062658420853;8969.551522423886;8866.911330886689;8980.101989801016;8998.235150012257;9010.594523246453;9015.90984090159;2372.1697405907967;2396.149366974725;2403.230966090852;2407.325948734357;2408.554417432772;2353.2704861492994;2391.689080419552;2392.0431827269144;2396.149366974725;2396.628522579003;2360.693109895711;2362.724128970354;2369.609014512603;2385.1771138957033;2390.259019703897;2144.8713077215416;2309.9422514437106;2323.7327707313707;2364.609839376501;2370.8221883358647;2083.718513114439;2186.562687462514;2303.5623231585946;2313.595120853844;2327.290176496168;8912.64349426022;8921.687740929101;9024.278057755364;9029.593668284877;9044.276457883354;4853.029394121155;5016;5197.22041693749;5217.165253559412;5354.491323324278;3272.8527216275324;3574.1593079564045;3650.233450975298;3662;3716.3310604091253;1080.4489710247751;1093.2675107677796;1110.211749657744;1115.33080151909;1117.463617463622;11928.821067683992;12035;12037.337946412943;12045.277283362939;12051.397430128547;4133.91732165355;4565.246734288805;4887.853364399074;4911.877203069952;4912.680675756064;10248;10249.795004100026;10253.641122560675;10253.74365640865;10258.28192026551;5449.809256675997;5457.208704737791;5468;5475.7262136893;5497.862553436196;4789.114013907439;4959.454460009396;4978.950210497848;4998.425181104147;5016.573591244712;3742.569604495518;3796.6711650922507;3858.3826587745825;3881.3207688654375;3887.358585833362;1074.9623763168252;1082.9207920791941;1138.584416687903;1211.8911196255328;1263.5451237554473;760.2663429790279;862.2239984014437;904.8099899021148;906.9682561110329;951.058452132384;5807.651540907559;5917.674527900921;5951.613145145639;6099.878002440015;6135.018397056449;848.5121055393174;924.2098006204733;945.7399215215734;968.5738275158908;1003.448103543063;3504.2641045380756;3888.475055867478;3985.5815139410524;4116.91766164675;4119.423280740699;9290.674826381044;10509.632162874263;10830.079443247254;11004;11007.229493935507;10845.102107131379;10975.50610222542;10981.17641176915;10986.615468458565;11008.559657613605;8254.215849494289;8346.8330633387;8463.57682115904;8465.238128568459;8490.617922193516;5833.329167145663;5897.616654917417;5928;5974.790882319098;5993.550483713826;10050.145737612385;10085.243606729378;10105.848412273968;10204.387736735524;10320.535575898952;8231.547264900488;10137.18902487814;10168.644097456554;10350.016748408889;10372.01465860742;7473.177950425557;7639.465237433326;7644.12092609357;7647.508735796467;7678.923210768045;8058.3150432213915;8197.344212463107;8282.337413006824;8306.044804847279;8362.540060296498;7552.055993000875;7553.584552849646;7621.31408173267;7646.9617651911385;7780.649870755717;7467.365273951775;7524.435667324863;7532.209118042527;7567.129780075142;7575.545467271982;6679.632620205935;6919.238883722685;7005.929940700732;7055.400290975119;7097.574145551283;4845.781939812788;4921.926171107365;4997.550220480174;5015.573676237561;5155.510226528474;4977.129002424634;5125.026245013435;5148.76830542619;5155;5261.131913234273 08:46:17 INFO - PROCESS | 1657 | |4;prototype.html;290.3510653689003;293.2990153533055;304.5720762328928;310.4412058295068;315.13338319621045;5201.6098792590565;5260.370344462323;5274.4725527447235;5348.46515348465;5500.202470641764;5197.350331208599;5405.594580406466;5419.214213938976;5429.864253393657;5431.306711436222;3712.6287371262792;4102.630763231308;4170.416141740159;4198.055437526547;4201.907504048954;3669.834857431422;3925.4700615416837;4176.2900306947895;4191;4200.621944025037;3931.5085614298214;4083.3262511685534;4139.482564679415;4174.290370636983;4200.327947528396;3431.2965842002577;4143.834246630131;4145.2124096421885;4156.771377574232;4164.687648426365;3563.3051554946796;3575.982120089409;3578.8389522471552;3581.194231297963;3583.8208089595414;3873;4808.335914163256;4826.710397376169;4954;5033.521815427529;4708.0113176233035;4742.691725037862;4743.35964644772;4743.549362810528;4750.216214324632;4327.307630779061;5095.210242412432;5492.642978206404;5654.830355089354;5758.568107391962;3262.21706790371;3343.765936384454;3795.582485926546;3932.646061854447;3950.9455083356493;5983.491403230731;5996.460318571306;6009.729562169713;6024.018111035022;6031.45716885478;3365.5793025871767;3501.83084308701;3938.5470670873215;3985.442038114666;4051.1290072634524;3397.8301084946147;3781.9810900945317;3917.0449381532385;4015.9598404015587;4084.4894388201474;3787.996181012034;3824.8852534424013;4368.344748287782;4567.862964111082;4582.679212455096;5076.766222862003;5277.970795694802;5541.833744987657;5710.8001219957105;5755.740991655385;1334.9866501334861;1394.6583087143715;1400.2298735695326;1406.5709958462767;1411.4848080450768;849.1254008371387;866.843968085738;907.7654390029686;921.755734730297;934.8831396075491;5278.392984806796;5291.232771248147;5313.256144139824;5319.627626066215;5501.669899806025;5804.1293805929445;5837.766489340379;5848.824535263949;5882.3529411764675;5949.196858424058;4422.977885110554;4584.4498660161;4851.787053236691;4882.902341953141;5299.39057008449;2541.682289713786;2768.363276446388;3055.960973269099;3092.5515800208846;3123.843807809646;5431.37539182999;5652.241259562427;5854.443827836434;6160.414760597736;6175.783847565313;6033.577649564489;6049.969750151221;6074.848128796727;6083.330833608299;6084.239470066242;6140.662263575457;6143.631382117087;6149.84625384369;6218.31598524171;6238.376162383725;5561.221429000024;5563.554915606661;5894.882102357843;5899.764009439746;5907;5317.069512835315;5368.7852485901685;5403.86490337729;5836.387179346108;5871.207387002871;4828.517148285144;5226.529612334908;5231.973840130927;6144.41628045335;6159.322474527888;3895.435161901565;3952.9011774705864;3963.8216280268034;3980.482537270136;3989.1423343981182;4577.8168873244695;5336.67979921206;5518.172274158908;5960.5827592068135;6003.669798161143;5670.8015219467125;5710.600257981901;5829.446202610745;5853.2976042875125;5887.735051922759;4864.659473836798;5834.411836720471;5853.414658534112;5875.853103672272;5889.822035592812;5027.49725027509;5144.922826157535;5650.152477128299;5683.7442315095095;5694.402087780723;5310;5709.686772042536;5827.94172058274;5832;5832.154337621106;4495.280755079171;4717.905641887074;5603.439656034364;5728.398518155534;5760.423957604374 08:46:17 INFO - PROCESS | 1657 | |5;yui.html;643.7328508668903;681.17237556369;708.5606923707302;755.3202118093715;830.4602008694347;14679.486217982372;15742.921285393571;15898.841011589895;15955.361785528594;16014.679706405894;14934.402623895032;15535.223238838069;15546.222688865568;15617.453389131382;15727.60680982976;842.8356470488258;874.4927941793744;879.3053487744673;880.3353468131584;882.2853488674162;705.8552996635703;720.240146645289;722.0468980945154;849.7833052571585;870.6212797433105;893;896.0009589307907;896.5651658945407;897.3135551303258;899.5637115998768;888.6711916590871;889.155302462663;889.2308153447286;890.692711014699;891.777055736066;548.1339483615877;560.976218401419;664.8936170212743;666.7799626123368;668.5520701130255;14941.850581494155;15166;15166.393344266216;15170;15185.848141518665;11614.18700690952;11754.588589399416;11768.751214698988;11878.643640690792;12279.324637144953;9910.20718342531;11932.105092118127;12235.877641223562;12515.937420312932;12722.10945233834;4431.8448854289945;4586.656000799953;4634.351190833286;4704.905901881977;4715.646326525524;108528;113701.43149284367;114234;114337;114467.1256230665;10146.188304935587;10710.464476776286;10711.517981690842;10794.24440289188;11142.944285278683;21020.369388918356;21350.35948921535;21350.35948921535;21385.251516197168;21410.78589214088;7394.272984730969;7663.808404789925;7877.4091943104495;7978.920210797934;7986.720464783704;4257.425247591597;4333.220020396296;4347.543507931685;4372.606465418127;4440.644748420119;3490;3622.7826330420257;3628.8911332660064;3629.6007439181667;3668.174660701321;653.8430776613578;672.4821887146869;674.8920172772333;681.2370145437142;685.3591891581387;576.2192229529012;598.8233471126028;620.221621864557;622.8349487385756;691.2051141187675;7205.603691796897;7463.9626801866725;7467.626618669045;9324.953375233215;9631.518424078908;572.2989338060926;656.2354856592017;686.4302628818069;687.7283473028226;696.4150113904344;4449.510553839075;4536;4945.082203061926;5107.336046313955;5135.435102138762;139998.1000664972;151889;152595.23702381417;152753;158515;83663;84446.57776711076;88371.55814221017;90855.54572227097;115933.10167245887;109546;113624;117973.4101329505;118365.81634183893;120085;9653.276004299845;9943.801123977335;10042.849357259502;10051.849222261819;10056;64446.033309501334;64639.35360646333;64649;65631.67184164049;65986.67006664936;61862;93637;93969.5301523488;94758.52620736852;97053.51473242589;12809.679758006125;13201.735965280832;13259;13426.462941482232;13815.447382105005;14695.632609184855;15148.772768408704;15451.150186739836;15493.690126197638;15861.841381586037;13035.47858085666;13611.183329000292;13634;13915.373808178454;13981.650458738613;13502.257375844423;13659.38532766008;13937.651558710708;14069.085509441853;14467.710645787236;13224.933875330562;13381.39783709755;13427.992900532303;13568;13654.86345136536;11097.556097756;11188.88811111911;11604.88395116038;11691.766164676828;11772.941135294268;10251.692449226535;11293.43532823372;11469.827952580552;11480.655580332603;11574.768504630028 08:46:17 INFO - PROCESS | 1657 | __end_tp_report 08:46:17 INFO - PROCESS | 1657 | __start_cc_report 08:46:17 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1425 08:46:17 INFO - PROCESS | 1657 | __end_cc_report 08:46:17 INFO - PROCESS | 1657 | __startTimestamp1473781577908__endTimestamp 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | ------- Summary: start ------- 08:46:17 INFO - PROCESS | 1657 | Number of tests: 6 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5728.68 Median:5957.31 stddev:636.05 (10.7%) stddev-sans-first:608.15 08:46:17 INFO - PROCESS | 1657 | Values: 3273.7 3304.2 3357.4 3372.2 3385.9 5612.7 5663.7 5669.9 5716.0 5743.5 5667.8 5691.6 5703.0 5712.5 5722.0 5188.6 5206.5 5241.5 5257.4 5286.7 5287.6 5307.1 5313.1 5323.7 5429.4 5300.4 5352.8 5365.6 5368.4 5425.5 5155.8 5321.6 5343.5 5414.4 5422.2 5242.1 5269.8 5294.9 5346.7 5347.6 5629.4 5644.8 5694.9 5696.0 5752.4 5227.6 6061.7 6174.8 6183.5 6247.4 5786.4 6262.5 6263.7 6273.7 6278.8 5660.7 5710.4 5715.7 5828.1 5845.7 6175.3 6185.4 6233.5 6290.7 6298.1 5200.9 6017.6 6168.0 6174.8 6186.5 6122.1 6169.9 6234.9 6284.7 6284.8 6128.5 6129.0 6166.1 6167.4 6216.5 6165.5 6249.6 6262.2 6264.4 6284.4 4841.6 4876.5 4931.6 4948.6 4973.8 4371.5 4388.6 4425.8 4442.4 4468.8 5715.4 5720.4 5732.7 5742.4 5746.4 6277.5 6284.0 6292.4 6294.7 6321.1 5535.9 5571.4 5706.6 5708.3 5708.5 4611.9 5403.7 5430.1 5447.5 5473.1 6359.8 6362.9 6363.5 6371.9 6376.9 6097.4 6098.3 6132.0 6164.5 6290.8 5422.8 6239.3 6368.4 6387.6 6402.2 6145.0 6173.2 6211.2 6231.9 6232.2 6111.3 6173.7 6255.5 6259.9 6274.9 5968.5 6008.9 6012.4 6032.3 6137.5 6001.2 6171.8 6187.0 6190.4 6195.2 4968.6 5723.5 5853.6 5990.2 6019.2 6039.3 6064.6 6088.9 6098.3 6105.8 5957.3 6006.2 6010.0 6019.2 6073.5 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:68207.42 Median:20809.90 stddev:146908.38 (706.0%) stddev-sans-first:147232.45 08:46:17 INFO - PROCESS | 1657 | Values: 465.9 470.7 501.5 518.0 533.6 27714.4 29468.4 40246.8 41610.8 41784.0 42940.6 43357.3 43390.0 43417.6 43536.1 9755.4 9944.2 9946.3 9953.8 9977.6 8730.6 8901.6 9757.9 11884.0 12081.9 11980.0 12040.0 12055.0 12064.6 12075.2 12116.2 12166.9 12170.8 12178.2 12183.5 11838.3 11913.6 11924.2 11951.3 11965.0 39716.8 39999.8 40029.0 40041.6 40270.8 3306.1 3423.0 3427.0 3630.3 3723.2 30182.0 30624.8 30790.5 31336.8 31389.7 2593.8 3156.0 3171.4 3171.6 3278.8 416105.0 417811.0 420547.0 421754.0 423574.9 60235.7 60817.0 60898.1 60910.7 60922.0 34362.0 58480.4 58750.7 63768.0 63835.7 15615.3 16310.9 16417.8 16431.1 16438.4 11422.7 12511.8 12620.9 12621.3 12627.7 16851.4 17028.1 18467.0 18507.3 18871.0 6807.4 7907.8 7996.5 8013.3 8087.8 852.3 904.7 931.6 954.9 1078.4 29090.9 30001.4 30110.9 30601.9 30754.8 1041.9 1048.9 1082.6 1100.1 1134.6 15586.7 15615.8 15637.5 15659.5 15961.8 573253.0 574744.0 578257.0 578380.0 581275.0 57152.0 57421.1 57465.9 57468.0 57472.7 1201.7 1241.0 1346.7 1347.4 1358.3 29841.6 30895.1 31124.0 31802.5 31912.8 50042.5 54652.2 55270.7 55495.0 59256.7 626529.0 630172.0 632543.0 633340.0 634518.0 26196.3 26915.9 26964.7 27390.6 27727.4 46988.6 47315.3 47412.8 47814.5 47835.0 38659.2 38765.4 38916.6 39025.6 40800.0 38489.8 38684.6 38748.0 39772.4 40340.8 37896.6 38381.0 38550.4 38558.8 38721.4 32231.7 33856.0 33867.2 33929.0 34417.5 21529.2 25121.2 25352.9 25500.0 25626.4 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34236.98 Median:1658.15 stddev:98407.47 (5934.8%) stddev-sans-first:98650.64 08:46:17 INFO - PROCESS | 1657 | Values: 353.9 373.9 375.6 384.5 404.9 15005.4 15130.5 16787.6 20154.7 20726.4 12097.0 14677.2 20209.6 20724.3 20944.0 5486.6 5762.7 5766.7 5767.6 5775.6 5264.8 5583.9 6914.0 6981.4 7036.6 5690.4 6741.4 6977.8 6991.1 6992.6 6908.3 6936.8 6937.9 6944.0 6965.1 4764.5 6001.1 6089.5 6091.7 6092.3 13397.7 13482.3 13488.5 24135.6 25225.7 2128.5 2172.1 2550.0 2940.7 2962.4 10237.0 11636.7 12263.8 16096.0 16211.1 1827.5 1871.0 1872.1 1985.8 2017.8 112949.0 116940.4 122222.0 130815.0 135641.3 10762.3 10925.2 11119.0 11374.2 11542.9 14574.0 14592.6 14600.1 14603.6 14607.6 7511.7 8377.7 8488.1 8596.9 8598.1 8227.3 8303.0 8519.0 8567.7 8568.5 3825.8 3923.8 4467.8 4549.4 4573.7 1640.5 1856.7 1912.1 1927.6 1933.8 818.7 888.1 922.9 962.2 969.2 19560.6 20301.8 21061.6 21070.4 21077.0 887.6 917.8 926.3 932.4 932.8 10377.5 11071.6 11813.8 11992.3 12058.9 570988.0 570999.0 572893.0 599133.1 626165.0 97226.0 120539.4 122530.0 123145.0 144677.0 431.8 453.3 454.5 454.9 456.2 9760.1 9763.4 10016.1 11062.8 11090.5 51936.7 52837.7 53008.0 53612.7 55150.4 68368.3 79122.8 79500.2 79570.6 82417.6 7419.9 7968.4 8035.6 8254.2 8366.7 10937.8 11923.5 12477.8 12674.6 12978.4 11066.6 11091.3 11131.5 11169.9 11171.5 10751.1 10922.7 11112.6 11208.8 11227.7 11073.3 11276.0 11401.2 11429.6 11629.2 7991.6 8090.0 8112.7 8120.6 8384.6 8286.9 10002.6 10362.9 10537.3 10803.9 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5762.21 Median:4912.28 stddev:3265.07 (66.5%) stddev-sans-first:3256.90 08:46:17 INFO - PROCESS | 1657 | Values: 1285.8 1304.8 1390.6 1613.8 1883.9 7449.9 8271.7 8762.3 8927.1 8969.6 8866.9 8980.1 8998.2 9010.6 9015.9 2372.2 2396.1 2403.2 2407.3 2408.6 2353.3 2391.7 2392.0 2396.1 2396.6 2360.7 2362.7 2369.6 2385.2 2390.3 2144.9 2309.9 2323.7 2364.6 2370.8 2083.7 2186.6 2303.6 2313.6 2327.3 8912.6 8921.7 9024.3 9029.6 9044.3 4853.0 5016.0 5197.2 5217.2 5354.5 3272.9 3574.2 3650.2 3662.0 3716.3 1080.4 1093.3 1110.2 1115.3 1117.5 11928.8 12035.0 12037.3 12045.3 12051.4 4133.9 4565.2 4887.9 4911.9 4912.7 10248.0 10249.8 10253.6 10253.7 10258.3 5449.8 5457.2 5468.0 5475.7 5497.9 4789.1 4959.5 4979.0 4998.4 5016.6 3742.6 3796.7 3858.4 3881.3 3887.4 1075.0 1082.9 1138.6 1211.9 1263.5 760.3 862.2 904.8 907.0 951.1 5807.7 5917.7 5951.6 6099.9 6135.0 848.5 924.2 945.7 968.6 1003.4 3504.3 3888.5 3985.6 4116.9 4119.4 9290.7 10509.6 10830.1 11004.0 11007.2 10845.1 10975.5 10981.2 10986.6 11008.6 8254.2 8346.8 8463.6 8465.2 8490.6 5833.3 5897.6 5928.0 5974.8 5993.6 10050.1 10085.2 10105.8 10204.4 10320.5 8231.5 10137.2 10168.6 10350.0 10372.0 7473.2 7639.5 7644.1 7647.5 7678.9 8058.3 8197.3 8282.3 8306.0 8362.5 7552.1 7553.6 7621.3 7647.0 7780.6 7467.4 7524.4 7532.2 7567.1 7575.5 6679.6 6919.2 7005.9 7055.4 7097.6 4845.8 4921.9 4997.6 5015.6 5155.5 4977.1 5125.0 5148.8 5155.0 5261.1 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4608.96 Median:5214.07 stddev:1440.96 (27.6%) stddev-sans-first:1408.08 08:46:17 INFO - PROCESS | 1657 | Values: 290.4 293.3 304.6 310.4 315.1 5201.6 5260.4 5274.5 5348.5 5500.2 5197.4 5405.6 5419.2 5429.9 5431.3 3712.6 4102.6 4170.4 4198.1 4201.9 3669.8 3925.5 4176.3 4191.0 4200.6 3931.5 4083.3 4139.5 4174.3 4200.3 3431.3 4143.8 4145.2 4156.8 4164.7 3563.3 3576.0 3578.8 3581.2 3583.8 3873.0 4808.3 4826.7 4954.0 5033.5 4708.0 4742.7 4743.4 4743.5 4750.2 4327.3 5095.2 5492.6 5654.8 5758.6 3262.2 3343.8 3795.6 3932.6 3950.9 5983.5 5996.5 6009.7 6024.0 6031.5 3365.6 3501.8 3938.5 3985.4 4051.1 3397.8 3782.0 3917.0 4016.0 4084.5 3788.0 3824.9 4368.3 4567.9 4582.7 5076.8 5278.0 5541.8 5710.8 5755.7 1335.0 1394.7 1400.2 1406.6 1411.5 849.1 866.8 907.8 921.8 934.9 5278.4 5291.2 5313.3 5319.6 5501.7 5804.1 5837.8 5848.8 5882.4 5949.2 4423.0 4584.4 4851.8 4882.9 5299.4 2541.7 2768.4 3056.0 3092.6 3123.8 5431.4 5652.2 5854.4 6160.4 6175.8 6033.6 6050.0 6074.8 6083.3 6084.2 6140.7 6143.6 6149.8 6218.3 6238.4 5561.2 5563.6 5894.9 5899.8 5907.0 5317.1 5368.8 5403.9 5836.4 5871.2 4828.5 5226.5 5232.0 6144.4 6159.3 3895.4 3952.9 3963.8 3980.5 3989.1 4577.8 5336.7 5518.2 5960.6 6003.7 5670.8 5710.6 5829.4 5853.3 5887.7 4864.7 5834.4 5853.4 5875.9 5889.8 5027.5 5144.9 5650.2 5683.7 5694.4 5310.0 5709.7 5827.9 5832.0 5832.2 4495.3 4717.9 5603.4 5728.4 5760.4 08:46:17 INFO - PROCESS | 1657 | 08:46:17 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24180.76 Median:3629.25 stddev:38149.88 (1051.2%) stddev-sans-first:38215.96 08:46:17 INFO - PROCESS | 1657 | Values: 643.7 681.2 708.6 755.3 830.5 14679.5 15742.9 15898.8 15955.4 16014.7 14934.4 15535.2 15546.2 15617.5 15727.6 842.8 874.5 879.3 880.3 882.3 705.9 720.2 722.0 849.8 870.6 893.0 896.0 896.6 897.3 899.6 888.7 889.2 889.2 890.7 891.8 548.1 561.0 664.9 666.8 668.6 14941.9 15166.0 15166.4 15170.0 15185.8 11614.2 11754.6 11768.8 11878.6 12279.3 9910.2 11932.1 12235.9 12515.9 12722.1 4431.8 4586.7 4634.4 4704.9 4715.6 108528.0 113701.4 114234.0 114337.0 114467.1 10146.2 10710.5 10711.5 10794.2 11142.9 21020.4 21350.4 21350.4 21385.3 21410.8 7394.3 7663.8 7877.4 7978.9 7986.7 4257.4 4333.2 4347.5 4372.6 4440.6 3490.0 3622.8 3628.9 3629.6 3668.2 653.8 672.5 674.9 681.2 685.4 576.2 598.8 620.2 622.8 691.2 7205.6 7464.0 7467.6 9325.0 9631.5 572.3 656.2 686.4 687.7 696.4 4449.5 4536.0 4945.1 5107.3 5135.4 139998.1 151889.0 152595.2 152753.0 158515.0 83663.0 84446.6 88371.6 90855.5 115933.1 109546.0 113624.0 117973.4 118365.8 120085.0 9653.3 9943.8 10042.8 10051.8 10056.0 64446.0 64639.4 64649.0 65631.7 65986.7 61862.0 93637.0 93969.5 94758.5 97053.5 12809.7 13201.7 13259.0 13426.5 13815.4 14695.6 15148.8 15451.2 15493.7 15861.8 13035.5 13611.2 13634.0 13915.4 13981.7 13502.3 13659.4 13937.7 14069.1 14467.7 13224.9 13381.4 13428.0 13568.0 13654.9 11097.6 11188.9 11604.9 11691.8 11772.9 10251.7 11293.4 11469.8 11480.7 11574.8 08:46:17 INFO - PROCESS | 1657 | -------- Summary: end -------- 08:46:17 INFO - PROCESS | 1657 | 08:46:18 INFO - TEST-INFO | 1657: exit 0 08:46:18 INFO - TEST-OK | dromaeo_css | took 1117330ms 08:46:18 INFO - TEST-START | kraken 08:46:18 INFO - operating with platform_type : mac_ 08:46:18 INFO - Initialising browser for kraken test... 08:46:18 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmp1qH3P8/profile http://localhost:49272/getInfo.html) 08:46:20 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:46:20 INFO - PROCESS | 1663 | colorDepth:24 08:46:20 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:46:20 INFO - PROCESS | 1663 | __metrics 08:46:21 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" 08:46:21 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] 08:46:21 INFO - TEST-INFO | 1663: exit 0 08:46:21 INFO - Browser initialized. 08:46:21 INFO - Running cycle 1/1 for kraken test... 08:46:21 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmp1qH3P8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:33 INFO - PROCESS | 1664 | RSS: Main: 229507072 08:46:33 INFO - PROCESS | 1664 | 08:46:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:37 INFO - PROCESS | 1664 | RSS: Main: 290693120 08:46:37 INFO - PROCESS | 1664 | 08:46:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 08:46:40 INFO - PROCESS | 1664 | RSS: Main: 290971648 08:46:40 INFO - PROCESS | 1664 | 08:46:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 08:46:44 INFO - PROCESS | 1664 | RSS: Main: 381681664 08:46:44 INFO - PROCESS | 1664 | 08:46:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 08:46:47 INFO - PROCESS | 1664 | RSS: Main: 283860992 08:46:47 INFO - PROCESS | 1664 | 08:46:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:49 INFO - PROCESS | 1664 | RSS: Main: 288301056 08:46:49 INFO - PROCESS | 1664 | 08:46:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:53 INFO - PROCESS | 1664 | RSS: Main: 326348800 08:46:53 INFO - PROCESS | 1664 | 08:46:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:56 INFO - PROCESS | 1664 | RSS: Main: 325533696 08:46:56 INFO - PROCESS | 1664 | 08:46:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 08:46:59 INFO - PROCESS | 1664 | RSS: Main: 326782976 08:46:59 INFO - PROCESS | 1664 | 08:47:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:47:02 INFO - PROCESS | 1664 | RSS: Main: 302891008 08:47:02 INFO - PROCESS | 1664 | 08:47:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:47:04 INFO - PROCESS | 1664 | RSS: Main: 306425856 08:47:04 INFO - PROCESS | 1664 | 08:47:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:47:07 INFO - PROCESS | 1664 | RSS: Main: 306176000 08:47:07 INFO - PROCESS | 1664 | 08:47:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:47:10 INFO - PROCESS | 1664 | RSS: Main: 319934464 08:47:10 INFO - PROCESS | 1664 | 08:47:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:14 INFO - PROCESS | 1664 | RSS: Main: 316162048 08:47:14 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 08:47:16 INFO - PROCESS | 1664 | RSS: Main: 359817216 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | __start_tp_report 08:47:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 08:47:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 08:47:16 INFO - PROCESS | 1664 | |i|pagename|runs| 08:47:16 INFO - PROCESS | 1664 | |0;ai-astar;105;113;113;113;113;113;114;111;112;114 08:47:16 INFO - PROCESS | 1664 | |1;audio-beat-detection;151;138;137;150;107;109;108;107;139;106 08:47:16 INFO - PROCESS | 1664 | |2;audio-dft;183;184;184;182;183;183;182;186;181;190 08:47:16 INFO - PROCESS | 1664 | |3;audio-fft;83;58;59;88;62;58;58;58;82;57 08:47:16 INFO - PROCESS | 1664 | |4;audio-oscillator;88;70;93;70;68;69;91;67;69;90 08:47:16 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;87;85;88;86;86;84;86;119;87;85 08:47:16 INFO - PROCESS | 1664 | |6;imaging-darkroom;93;93;100;141;93;91;94;93;93;93 08:47:16 INFO - PROCESS | 1664 | |7;imaging-desaturate;86;86;86;84;87;86;85;86;86;85 08:47:16 INFO - PROCESS | 1664 | |8;json-parse-financial;52;54;52;52;54;55;53;53;55;53 08:47:16 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;70;65;72;76;72;68;70;69;71;70 08:47:16 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;85;85;85;90;85;86;86;83;85;89 08:47:16 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;137;137;138;136;132;138;140;135;181;137 08:47:16 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;166;167;166;167;168;170;167;167;164;167 08:47:16 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;69;67;67;67;66;66;66;66;65;66 08:47:16 INFO - PROCESS | 1664 | __end_tp_report 08:47:16 INFO - PROCESS | 1664 | __start_cc_report 08:47:16 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1920 08:47:16 INFO - PROCESS | 1664 | __end_cc_report 08:47:16 INFO - PROCESS | 1664 | __startTimestamp1473781636275__endTimestamp 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | ------- Summary: start ------- 08:47:16 INFO - PROCESS | 1664 | Number of tests: 14 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.64 (2.3%) stddev-sans-first:0.93 08:47:16 INFO - PROCESS | 1664 | Values: 105.0 113.0 113.0 113.0 113.0 113.0 114.0 111.0 112.0 114.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:137.50 stddev:19.33 (14.1%) stddev-sans-first:18.11 08:47:16 INFO - PROCESS | 1664 | Values: 151.0 138.0 137.0 150.0 107.0 109.0 108.0 107.0 139.0 106.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:183.80 Median:183.50 stddev:2.57 (1.4%) stddev-sans-first:2.71 08:47:16 INFO - PROCESS | 1664 | Values: 183.0 184.0 184.0 182.0 183.0 183.0 182.0 186.0 181.0 190.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:12.61 (20.8%) stddev-sans-first:11.83 08:47:16 INFO - PROCESS | 1664 | Values: 83.0 58.0 59.0 88.0 62.0 58.0 58.0 58.0 82.0 57.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.00 stddev:11.29 (14.3%) stddev-sans-first:11.31 08:47:16 INFO - PROCESS | 1664 | Values: 88.0 70.0 93.0 70.0 68.0 69.0 91.0 67.0 69.0 90.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:86.00 stddev:10.50 (12.2%) stddev-sans-first:11.10 08:47:16 INFO - PROCESS | 1664 | Values: 87.0 85.0 88.0 86.0 86.0 84.0 86.0 119.0 87.0 85.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:93.00 stddev:15.15 (16.3%) stddev-sans-first:15.95 08:47:16 INFO - PROCESS | 1664 | Values: 93.0 93.0 100.0 141.0 93.0 91.0 94.0 93.0 93.0 93.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 08:47:16 INFO - PROCESS | 1664 | Values: 86.0 86.0 86.0 84.0 87.0 86.0 85.0 86.0 86.0 85.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.16 (2.2%) stddev-sans-first:1.13 08:47:16 INFO - PROCESS | 1664 | Values: 52.0 54.0 52.0 52.0 54.0 55.0 53.0 53.0 55.0 53.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:2.87 (4.1%) stddev-sans-first:3.04 08:47:16 INFO - PROCESS | 1664 | Values: 70.0 65.0 72.0 76.0 72.0 68.0 70.0 69.0 71.0 70.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.08 (2.4%) stddev-sans-first:2.18 08:47:16 INFO - PROCESS | 1664 | Values: 85.0 85.0 85.0 90.0 85.0 86.0 86.0 83.0 85.0 89.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:137.50 stddev:14.18 (10.3%) stddev-sans-first:14.96 08:47:16 INFO - PROCESS | 1664 | Values: 137.0 137.0 138.0 136.0 132.0 138.0 140.0 135.0 181.0 137.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:167.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 08:47:16 INFO - PROCESS | 1664 | Values: 166.0 167.0 166.0 167.0 168.0 170.0 167.0 167.0 164.0 167.0 08:47:16 INFO - PROCESS | 1664 | 08:47:16 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:0.67 08:47:16 INFO - PROCESS | 1664 | Values: 69.0 67.0 67.0 67.0 66.0 66.0 66.0 66.0 65.0 66.0 08:47:16 INFO - PROCESS | 1664 | -------- Summary: end -------- 08:47:16 INFO - PROCESS | 1664 | 08:47:17 INFO - TEST-INFO | 1664: exit 0 08:47:17 INFO - TEST-OK | kraken | took 58516ms 08:47:17 INFO - SUITE-END | took 1175s 08:47:17 INFO - Completed test suite (00:19:36) 08:47:17 INFO - javascript benchmark 08:47:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.6889995450424, 3304.206990322323, 3357.3956687796185, 3372.173817414733, 3385.9322813543745, 5612.719364031792, 5663.688497132656, 5669.8582535436635, 5716.0, 5743.454371834674, 5667.801626943058, 5691.601587888849, 5703.03048481758, 5712.457316554931, 5722.0, 5188.636795424312, 5206.505381988705, 5241.5020573045695, 5257.395399529065, 5286.682799032051, 5287.576993840484, 5307.124324486455, 5313.123334649778, 5323.680579165262, 5429.429909859467, 5300.416954135042, 5352.812651557197, 5365.570754339663, 5368.355797304329, 5425.484578964992, 5155.819546315898, 5321.574274058066, 5343.465653434664, 5414.35027796663, 5422.15956526735, 5242.135047717122, 5269.841904742864, 5294.894102117974, 5346.6524675896335, 5347.598930080259, 5629.408912064257, 5644.774209031634, 5694.857628559278, 5696.031674615326, 5752.395998420189, 5227.60792940531, 6061.696915154269, 6174.7530098796, 6183.536234782365, 6247.437730604267, 5786.42135786418, 6262.530310226705, 6263.655498947556, 6273.749050037993, 6278.780242691484, 5660.745266463019, 5710.37185909558, 5715.714214289269, 5828.06750919855, 5845.7369418376275, 6175.2589689237575, 6185.41238582334, 6233.501319894398, 6290.654014029181, 6298.149749783721, 5200.947990520122, 6017.6389416634265, 6168.013117901114, 6174.783882564088, 6186.505079593621, 6122.123558664931, 6169.9383006170265, 6234.937650623527, 6284.748610055638, 6284.780032698834, 6128.479079278222, 6128.961487065963, 6166.136740856284, 6167.352427995085, 6216.53375996793, 6165.5375846810775, 6249.625022498664, 6262.1859158310035, 6264.436200741864, 6284.371562843679, 4841.588464980516, 4876.536729010738, 4931.605471562339, 4948.62885283598, 4973.825916092919, 4371.519132895379, 4388.648908087345, 4425.800838962255, 4442.400275962768, 4468.776561171929, 5715.371309155989, 5720.370759216483, 5732.742026608813, 5742.425757424307, 5746.396628354046, 6277.52918531112, 6283.96858015707, 6292.433680968643, 6294.685265736694, 6321.051842223703, 5535.944640553624, 5571.4428557143965, 5706.572007099401, 5708.343540492813, 5708.543316534668, 4611.861644150681, 5403.675779453167, 5430.104032834538, 5447.509724124848, 5473.124300112043, 6359.809205723743, 6362.936370636235, 6363.459105976044, 6371.904421433682, 6376.884045292055, 6097.433938678448, 6098.3414614785315, 6131.957816599936, 6164.47601953839, 6290.811275661737, 5422.755975981011, 6239.282482514387, 6368.363163683594, 6387.552871298964, 6402.231732192166, 6145.0, 6173.170489524341, 6211.161493198541, 6231.937680623136, 6232.220972378453, 6111.327753947151, 6173.722182501888, 6255.53083518747, 6259.937400625936, 6274.937250627435, 5968.46283834457, 6008.909866352095, 6012.398760123952, 6032.306284777307, 6137.539684523589, 6001.2498437695285, 6171.814845554641, 6186.969065154645, 6190.380961903954, 6195.1636529068, 4968.55283024515, 5723.484886360247, 5853.619514731528, 5990.161377407254, 6019.18740969981, 6039.275286965592, 6064.575479716554, 6088.939110609014, 6098.268207814913, 6105.793350785129, 5957.314908785372, 6006.189164462741, 6009.969950150221, 6019.1573179754, 6073.483753880793], "value": 5688.912403846729, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.8975025494391, 470.6799376424032, 501.5305155893234, 517.9844604661856, 533.565144407308, 27714.44571108579, 29468.410631787377, 40246.798766006126, 41610.791946040306, 41784.0, 42940.57059429405, 43357.34963975535, 43390.0, 43417.56582434175, 43536.12927741443, 9755.414675119498, 9944.204463642927, 9946.30375873689, 9953.800923981516, 9977.600895964153, 8730.607122679463, 8901.599428025755, 9757.853632195523, 11884.049276057938, 12081.939590302036, 11980.041596672289, 12039.976601988797, 12055.035597152251, 12064.57773977911, 12075.154739168262, 12116.151869369147, 12166.878331216663, 12170.81743773844, 12178.208416452902, 12183.51265949361, 11838.348890811001, 11913.583024594098, 11924.165308428413, 11951.342676152808, 11965.04279657634, 39716.801415993024, 39999.80000099981, 40029.0, 40041.59958400408, 40270.79864600658, 3306.1404034950847, 3423.0, 3426.9828650856834, 3630.3173063599666, 3723.1809002019513, 30182.0, 30624.77500899961, 30790.53814192789, 31336.843315783502, 31389.686103139135, 2593.8054645901443, 3155.96844031559, 3171.413288541627, 3171.6194056713343, 3278.7704860659765, 416105.0, 417811.0, 420547.0, 421754.0, 423574.88212559046, 60235.69882150561, 60817.0, 60898.08652870211, 60910.695446522484, 60922.0, 34362.0, 58480.4151958475, 58750.70624646849, 63768.0, 63835.6808215956, 15615.297311621005, 16310.918445407697, 16417.83582164187, 16431.096289703943, 16438.424655137012, 11422.714432139262, 12511.812322815165, 12620.936895315464, 12621.305828179538, 12627.747445051047, 16851.41020064292, 17028.148592570324, 18467.0, 18507.259709611735, 18870.962097084794, 6807.421369183576, 7907.802304942423, 7996.480228785111, 8013.318867896294, 8087.797805054921, 852.2798235491, 904.7466709321401, 931.5560880634989, 954.8663187153804, 1078.3853203673987, 29090.854545727136, 30001.39997200044, 30110.946116885803, 30601.89118952158, 30754.846225768728, 1041.9479026048666, 1048.9213309001855, 1082.637316498966, 1100.0594491709473, 1134.5631931706353, 15586.688266234612, 15615.765763513557, 15637.452689155825, 15659.530214093595, 15961.760573591406, 573253.0, 574744.0, 578257.0, 578380.0, 581275.0, 57152.0, 57421.10946686425, 57465.85068298611, 57468.0, 57472.71263643655, 1201.6995751062234, 1240.9565665201856, 1346.6902612399203, 1347.3667376333108, 1358.3140514040347, 29841.612670985836, 30895.0731478056, 31124.0, 31802.522962155123, 31912.840435797672, 50042.49957500524, 54652.18021729598, 55270.72364638312, 55495.0, 59256.70371648114, 626529.0, 630172.0, 632543.0, 633340.0, 634518.0, 26196.345091372867, 26915.86542067277, 26964.730352697006, 27390.5891411625, 27727.44545109046, 46988.59034228978, 47315.29027064528, 47412.7629361851, 47814.52185478101, 47835.043299134515, 38659.22681546297, 38765.41851872168, 38916.63791767274, 39025.6097439022, 40799.980000500225, 38489.80755096207, 38684.6131538681, 38748.0, 39772.40341394823, 40340.79829600833, 37896.62103379041, 38381.0, 38550.42174367443, 38558.80720596379, 38721.4191787129, 32231.677683222868, 33855.98432047042, 33867.15332116717, 33928.97173914134, 34417.48373774446, 21529.246476373253, 25121.246362609152, 25352.87323563444, 25500.0, 25626.359341016625], "value": 20232.242525892583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.87437459701823, 373.8560654148152, 375.643139017933, 384.5155104568243, 404.9473568436103, 15005.39978400864, 15130.54608361748, 16787.580310492245, 20154.69767953482, 20726.378208653765, 12097.0, 14677.192754398504, 20209.595808083828, 20724.27465038724, 20943.952802359858, 5486.561075113981, 5762.711864406784, 5766.711664416763, 5767.625104368223, 5775.624584402, 5264.789408423659, 5583.916241256385, 6913.965430172842, 6981.441484681213, 7036.577805331696, 5690.374058853523, 6741.359570840762, 6977.755778547752, 6991.126109236346, 6992.6154061526595, 6908.3437073477935, 6936.79189624312, 6937.861242775141, 6944.0, 6965.094537710065, 4764.547368000034, 6001.12983617373, 6089.512838972872, 6091.725872335711, 6092.299385570672, 13397.66505837352, 13482.258475783829, 13488.527901523497, 24135.63796543053, 25225.747742522522, 2128.4998025464, 2172.1420039084474, 2549.974500254992, 2940.676695487018, 2962.42232764611, 10237.0, 11636.709082272926, 12263.75472490554, 16096.0, 16211.108389038598, 1827.4740591606026, 1870.9906450467797, 1872.1481725814722, 1985.7617085949778, 2017.818396344336, 112949.0, 116940.41529792381, 122222.0, 130815.0, 135641.3217933904, 10762.300450470695, 10925.180611454172, 11119.0, 11374.20380573352, 11542.884571154349, 14574.0, 14592.562223133324, 14600.050996685182, 14603.634909127357, 14607.561773146823, 7511.699532018658, 8377.748667539983, 8488.066312705598, 8596.8710469343, 8598.097199794056, 8227.300679442315, 8302.958485207657, 8518.957405212934, 8567.700130495403, 8568.528730919734, 3825.770453772727, 3923.8234279457492, 4467.8212871484775, 4549.385832912581, 4573.725576465423, 1640.5488490664925, 1856.7493388392663, 1912.1108684461792, 1927.575933294673, 1933.8162874526897, 818.7461886815106, 888.0675290944482, 922.8846394200591, 962.1773383756927, 969.2004096620317, 19560.608787824163, 20301.796982030286, 21061.578768424544, 21070.367888963356, 21077.0, 887.5695287785419, 917.7567944494714, 926.333040211047, 932.3566738950103, 932.7807965128189, 10377.481125943672, 11071.557137714562, 11813.763724725457, 11992.280463172237, 12058.879411205951, 570988.0, 570999.0, 572893.0, 599133.0839917784, 626165.0, 97226.0, 120539.39730301293, 122530.0, 123145.0, 144677.0, 431.81431984247075, 453.3403897329378, 454.54091367718183, 454.9454065512094, 456.1766012347744, 9760.121589057018, 9763.365381250196, 10016.148627366463, 11062.778744425228, 11090.500927458123, 51936.74031629818, 52837.735811320694, 53008.0, 53612.73193634007, 55150.44849551453, 68368.3163168362, 79122.81315780383, 79500.20499794927, 79570.6021469889, 82417.58791206006, 7419.9258007421395, 7968.442209045543, 8035.638396272065, 8254.215849494289, 8366.748997530083, 10937.781244375226, 11923.523059077539, 12477.750444990868, 12674.619761407173, 12978.351082445652, 11066.557337706401, 11091.279066860629, 11131.499082541142, 11169.944150279196, 11171.497282622464, 10751.139908807432, 10922.672319830417, 11112.555497779998, 11208.831867522156, 11227.66317010491, 11073.335599864035, 11276.041536469493, 11401.20191586581, 11429.59996400122, 11629.24409913353, 7991.64037618297, 8090.0, 8112.675492980451, 8120.645012946416, 8384.622691978997, 8286.875696864432, 10002.649907253211, 10362.896371036193, 10537.315074520131, 10803.945980270048], "value": 9179.389175268409, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.8392700912386, 1304.823848780415, 1390.5758743583206, 1613.8305477924819, 1883.8681292309543, 7449.925500744991, 8271.66913323467, 8762.34282428818, 8927.062658420853, 8969.551522423886, 8866.911330886689, 8980.101989801016, 8998.235150012257, 9010.594523246453, 9015.90984090159, 2372.1697405907967, 2396.149366974725, 2403.230966090852, 2407.325948734357, 2408.554417432772, 2353.2704861492994, 2391.689080419552, 2392.0431827269144, 2396.149366974725, 2396.628522579003, 2360.693109895711, 2362.724128970354, 2369.609014512603, 2385.1771138957033, 2390.259019703897, 2144.8713077215416, 2309.9422514437106, 2323.7327707313707, 2364.609839376501, 2370.8221883358647, 2083.718513114439, 2186.562687462514, 2303.5623231585946, 2313.595120853844, 2327.290176496168, 8912.64349426022, 8921.687740929101, 9024.278057755364, 9029.593668284877, 9044.276457883354, 4853.029394121155, 5016.0, 5197.22041693749, 5217.165253559412, 5354.491323324278, 3272.8527216275324, 3574.1593079564045, 3650.233450975298, 3662.0, 3716.3310604091253, 1080.4489710247751, 1093.2675107677796, 1110.211749657744, 1115.33080151909, 1117.463617463622, 11928.821067683992, 12035.0, 12037.337946412943, 12045.277283362939, 12051.397430128547, 4133.91732165355, 4565.246734288805, 4887.853364399074, 4911.877203069952, 4912.680675756064, 10248.0, 10249.795004100026, 10253.641122560675, 10253.74365640865, 10258.28192026551, 5449.809256675997, 5457.208704737791, 5468.0, 5475.7262136893, 5497.862553436196, 4789.114013907439, 4959.454460009396, 4978.950210497848, 4998.425181104147, 5016.573591244712, 3742.569604495518, 3796.6711650922507, 3858.3826587745825, 3881.3207688654375, 3887.358585833362, 1074.9623763168252, 1082.9207920791941, 1138.584416687903, 1211.8911196255328, 1263.5451237554473, 760.2663429790279, 862.2239984014437, 904.8099899021148, 906.9682561110329, 951.058452132384, 5807.651540907559, 5917.674527900921, 5951.613145145639, 6099.878002440015, 6135.018397056449, 848.5121055393174, 924.2098006204733, 945.7399215215734, 968.5738275158908, 1003.448103543063, 3504.2641045380756, 3888.475055867478, 3985.5815139410524, 4116.91766164675, 4119.423280740699, 9290.674826381044, 10509.632162874263, 10830.079443247254, 11004.0, 11007.229493935507, 10845.102107131379, 10975.50610222542, 10981.17641176915, 10986.615468458565, 11008.559657613605, 8254.215849494289, 8346.8330633387, 8463.57682115904, 8465.238128568459, 8490.617922193516, 5833.329167145663, 5897.616654917417, 5928.0, 5974.790882319098, 5993.550483713826, 10050.145737612385, 10085.243606729378, 10105.848412273968, 10204.387736735524, 10320.535575898952, 8231.547264900488, 10137.18902487814, 10168.644097456554, 10350.016748408889, 10372.01465860742, 7473.177950425557, 7639.465237433326, 7644.12092609357, 7647.508735796467, 7678.923210768045, 8058.3150432213915, 8197.344212463107, 8282.337413006824, 8306.044804847279, 8362.540060296498, 7552.055993000875, 7553.584552849646, 7621.31408173267, 7646.9617651911385, 7780.649870755717, 7467.365273951775, 7524.435667324863, 7532.209118042527, 7567.129780075142, 7575.545467271982, 6679.632620205935, 6919.238883722685, 7005.929940700732, 7055.400290975119, 7097.574145551283, 4845.781939812788, 4921.926171107365, 4997.550220480174, 5015.573676237561, 5155.510226528474, 4977.129002424634, 5125.026245013435, 5148.76830542619, 5155.0, 5261.131913234273], "value": 4598.811304458114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.3510653689003, 293.2990153533055, 304.5720762328928, 310.4412058295068, 315.13338319621045, 5201.6098792590565, 5260.370344462323, 5274.4725527447235, 5348.46515348465, 5500.202470641764, 5197.350331208599, 5405.594580406466, 5419.214213938976, 5429.864253393657, 5431.306711436222, 3712.6287371262792, 4102.630763231308, 4170.416141740159, 4198.055437526547, 4201.907504048954, 3669.834857431422, 3925.4700615416837, 4176.2900306947895, 4191.0, 4200.621944025037, 3931.5085614298214, 4083.3262511685534, 4139.482564679415, 4174.290370636983, 4200.327947528396, 3431.2965842002577, 4143.834246630131, 4145.2124096421885, 4156.771377574232, 4164.687648426365, 3563.3051554946796, 3575.982120089409, 3578.8389522471552, 3581.194231297963, 3583.8208089595414, 3873.0, 4808.335914163256, 4826.710397376169, 4954.0, 5033.521815427529, 4708.0113176233035, 4742.691725037862, 4743.35964644772, 4743.549362810528, 4750.216214324632, 4327.307630779061, 5095.210242412432, 5492.642978206404, 5654.830355089354, 5758.568107391962, 3262.21706790371, 3343.765936384454, 3795.582485926546, 3932.646061854447, 3950.9455083356493, 5983.491403230731, 5996.460318571306, 6009.729562169713, 6024.018111035022, 6031.45716885478, 3365.5793025871767, 3501.83084308701, 3938.5470670873215, 3985.442038114666, 4051.1290072634524, 3397.8301084946147, 3781.9810900945317, 3917.0449381532385, 4015.9598404015587, 4084.4894388201474, 3787.996181012034, 3824.8852534424013, 4368.344748287782, 4567.862964111082, 4582.679212455096, 5076.766222862003, 5277.970795694802, 5541.833744987657, 5710.8001219957105, 5755.740991655385, 1334.9866501334861, 1394.6583087143715, 1400.2298735695326, 1406.5709958462767, 1411.4848080450768, 849.1254008371387, 866.843968085738, 907.7654390029686, 921.755734730297, 934.8831396075491, 5278.392984806796, 5291.232771248147, 5313.256144139824, 5319.627626066215, 5501.669899806025, 5804.1293805929445, 5837.766489340379, 5848.824535263949, 5882.3529411764675, 5949.196858424058, 4422.977885110554, 4584.4498660161, 4851.787053236691, 4882.902341953141, 5299.39057008449, 2541.682289713786, 2768.363276446388, 3055.960973269099, 3092.5515800208846, 3123.843807809646, 5431.37539182999, 5652.241259562427, 5854.443827836434, 6160.414760597736, 6175.783847565313, 6033.577649564489, 6049.969750151221, 6074.848128796727, 6083.330833608299, 6084.239470066242, 6140.662263575457, 6143.631382117087, 6149.84625384369, 6218.31598524171, 6238.376162383725, 5561.221429000024, 5563.554915606661, 5894.882102357843, 5899.764009439746, 5907.0, 5317.069512835315, 5368.7852485901685, 5403.86490337729, 5836.387179346108, 5871.207387002871, 4828.517148285144, 5226.529612334908, 5231.973840130927, 6144.41628045335, 6159.322474527888, 3895.435161901565, 3952.9011774705864, 3963.8216280268034, 3980.482537270136, 3989.1423343981182, 4577.8168873244695, 5336.67979921206, 5518.172274158908, 5960.5827592068135, 6003.669798161143, 5670.8015219467125, 5710.600257981901, 5829.446202610745, 5853.2976042875125, 5887.735051922759, 4864.659473836798, 5834.411836720471, 5853.414658534112, 5875.853103672272, 5889.822035592812, 5027.49725027509, 5144.922826157535, 5650.152477128299, 5683.7442315095095, 5694.402087780723, 5310.0, 5709.686772042536, 5827.94172058274, 5832.0, 5832.154337621106, 4495.280755079171, 4717.905641887074, 5603.439656034364, 5728.398518155534, 5760.423957604374], "value": 4150.453829896972, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.7328508668903, 681.17237556369, 708.5606923707302, 755.3202118093715, 830.4602008694347, 14679.486217982372, 15742.921285393571, 15898.841011589895, 15955.361785528594, 16014.679706405894, 14934.402623895032, 15535.223238838069, 15546.222688865568, 15617.453389131382, 15727.60680982976, 842.8356470488258, 874.4927941793744, 879.3053487744673, 880.3353468131584, 882.2853488674162, 705.8552996635703, 720.240146645289, 722.0468980945154, 849.7833052571585, 870.6212797433105, 893.0, 896.0009589307907, 896.5651658945407, 897.3135551303258, 899.5637115998768, 888.6711916590871, 889.155302462663, 889.2308153447286, 890.692711014699, 891.777055736066, 548.1339483615877, 560.976218401419, 664.8936170212743, 666.7799626123368, 668.5520701130255, 14941.850581494155, 15166.0, 15166.393344266216, 15170.0, 15185.848141518665, 11614.18700690952, 11754.588589399416, 11768.751214698988, 11878.643640690792, 12279.324637144953, 9910.20718342531, 11932.105092118127, 12235.877641223562, 12515.937420312932, 12722.10945233834, 4431.8448854289945, 4586.656000799953, 4634.351190833286, 4704.905901881977, 4715.646326525524, 108528.0, 113701.43149284367, 114234.0, 114337.0, 114467.1256230665, 10146.188304935587, 10710.464476776286, 10711.517981690842, 10794.24440289188, 11142.944285278683, 21020.369388918356, 21350.35948921535, 21350.35948921535, 21385.251516197168, 21410.78589214088, 7394.272984730969, 7663.808404789925, 7877.4091943104495, 7978.920210797934, 7986.720464783704, 4257.425247591597, 4333.220020396296, 4347.543507931685, 4372.606465418127, 4440.644748420119, 3490.0, 3622.7826330420257, 3628.8911332660064, 3629.6007439181667, 3668.174660701321, 653.8430776613578, 672.4821887146869, 674.8920172772333, 681.2370145437142, 685.3591891581387, 576.2192229529012, 598.8233471126028, 620.221621864557, 622.8349487385756, 691.2051141187675, 7205.603691796897, 7463.9626801866725, 7467.626618669045, 9324.953375233215, 9631.518424078908, 572.2989338060926, 656.2354856592017, 686.4302628818069, 687.7283473028226, 696.4150113904344, 4449.510553839075, 4536.0, 4945.082203061926, 5107.336046313955, 5135.435102138762, 139998.1000664972, 151889.0, 152595.23702381417, 152753.0, 158515.0, 83663.0, 84446.57776711076, 88371.55814221017, 90855.54572227097, 115933.10167245887, 109546.0, 113624.0, 117973.4101329505, 118365.81634183893, 120085.0, 9653.276004299845, 9943.801123977335, 10042.849357259502, 10051.849222261819, 10056.0, 64446.033309501334, 64639.35360646333, 64649.0, 65631.67184164049, 65986.67006664936, 61862.0, 93637.0, 93969.5301523488, 94758.52620736852, 97053.51473242589, 12809.679758006125, 13201.735965280832, 13259.0, 13426.462941482232, 13815.447382105005, 14695.632609184855, 15148.772768408704, 15451.150186739836, 15493.690126197638, 15861.841381586037, 13035.47858085666, 13611.183329000292, 13634.0, 13915.373808178454, 13981.650458738613, 13502.257375844423, 13659.38532766008, 13937.651558710708, 14069.085509441853, 14467.710645787236, 13224.933875330562, 13381.39783709755, 13427.992900532303, 13568.0, 13654.86345136536, 11097.556097756, 11188.88811111911, 11604.88395116038, 11691.766164676828, 11772.941135294268, 10251.692449226535, 11293.43532823372, 11469.827952580552, 11480.655580332603, 11574.768504630028], "value": 7790.892059757651, "unit": "score"}], "name": "dromaeo_css", "value": 7345.873340213773, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 111.0, 112.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 137.0, 150.0, 107.0, 109.0, 108.0, 107.0, 139.0, 106.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 184.0, 182.0, 183.0, 183.0, 182.0, 186.0, 181.0, 190.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 88.0, 62.0, 58.0, 58.0, 58.0, 82.0, 57.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 70.0, 68.0, 69.0, 91.0, 67.0, 69.0, 90.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 86.0, 86.0, 84.0, 86.0, 119.0, 87.0, 85.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 100.0, 141.0, 93.0, 91.0, 94.0, 93.0, 93.0, 93.0], "value": 98.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 84.0, 87.0, 86.0, 85.0, 86.0, 86.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 52.0, 54.0, 55.0, 53.0, 53.0, 55.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 72.0, 76.0, 72.0, 68.0, 70.0, 69.0, 71.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 90.0, 85.0, 86.0, 86.0, 83.0, 85.0, 89.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 138.0, 136.0, 132.0, 138.0, 140.0, 135.0, 181.0, 137.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 166.0, 167.0, 168.0, 170.0, 167.0, 167.0, 164.0, 167.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1422.3, "alertThreshold": 2.0}]} 08:47:17 INFO - Return code: 0 08:47:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:47:17 INFO - # TBPL SUCCESS # 08:47:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:47:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:47:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:47:17 INFO - 2016-09-13 08:47:17.600 screenresolution[1668:10473] starting screenresolution argv=screenresolution get 08:47:17 INFO - 2016-09-13 08:47:17.603 screenresolution[1668:10473] Display 0: 1600x1200x32@60 08:47:17 INFO - 2016-09-13 08:47:17.609 screenresolution[1669:10476] starting screenresolution argv=screenresolution list 08:47:17 INFO - Available Modes on Display 0 08:47:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:47:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:47:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:47:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:47:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:47:17 INFO - Intel Iris: 08:47:17 INFO - Chipset Model: Intel Iris 08:47:17 INFO - Type: GPU 08:47:17 INFO - Bus: Built-In 08:47:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:47:17 INFO - Vendor: Intel (0x8086) 08:47:17 INFO - Device ID: 0x0a2e 08:47:17 INFO - Revision ID: 0x0009 08:47:17 INFO - Displays: 08:47:17 INFO - Display: 08:47:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:47:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:47:17 INFO - Display Serial Number: 1600x1200 60 08:47:17 INFO - Main Display: Yes 08:47:17 INFO - Mirror: Off 08:47:17 INFO - Online: Yes 08:47:17 INFO - Rotation: Supported 08:47:17 INFO - Return code: 0 08:47:17 INFO - Running post-action listener: _resource_record_post_action 08:47:17 INFO - [mozharness: 2016-09-13 15:47:17.846972Z] Finished run-tests step (success) 08:47:17 INFO - Running post-run listener: _resource_record_post_run 08:47:17 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32857088; Write bytes: 705563136; Read time: 307; Write time: 1996 08:47:17 INFO - TinderboxPrint: CPU usage
53.8% 08:47:17 INFO - TinderboxPrint: I/O read bytes / time
32,857,088 / 307 08:47:17 INFO - TinderboxPrint: I/O write bytes / time
705,563,136 / 1,996 08:47:17 INFO - TinderboxPrint: CPU idle
2,236.7 (46.2%) 08:47:17 INFO - TinderboxPrint: CPU system
977.1 (20.2%) 08:47:17 INFO - TinderboxPrint: CPU user
1,632.0 (33.7%) 08:47:17 INFO - TinderboxPrint: Swap in / out
433,553,408 / 0 08:47:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401854976; Write bytes: 395220480; Read time: 30003; Write time: 705 08:47:17 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29142016; Write bytes: 297489408; Read time: 278; Write time: 1254 08:47:18 INFO - Running post-run listener: _upload_blobber_files 08:47:18 INFO - Blob upload gear active. 08:47:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:47:18 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 08:47:18 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:47:18 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:47:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:47:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:19 INFO - (blobuploader) - INFO - Done attempting. 08:47:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:47:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:20 INFO - (blobuploader) - INFO - Done attempting. 08:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:22 INFO - (blobuploader) - INFO - Done attempting. 08:47:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:47:22 INFO - Return code: 0 08:47:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:47:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:47:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b34ccc6ad6f7096dde02c74118d7687fa78074bccf355f709a7d7b10664db0def7d9418536829e655ee7aafabeb65bd5cea1eb39585d0b9f2587f6f4ff5a3b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bbaf81a4f9ab420ae864bbfcf82945cc83e899c169db3fbe092e0d67f80dffffee9a28ac1c382cc8b3088f960799e2085f89cc0ed079baecdebfe29858adee1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7b53b570aeb04e00f57e6084e39faed3ed88a42fdb42a44ad987ee9f6f117214e45c3dc66ac515a66e94f223622b2889caaac6a744b07e8fd672f387349ecc39"} 08:47:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:47:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:47:22 INFO - Contents: 08:47:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b34ccc6ad6f7096dde02c74118d7687fa78074bccf355f709a7d7b10664db0def7d9418536829e655ee7aafabeb65bd5cea1eb39585d0b9f2587f6f4ff5a3b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bbaf81a4f9ab420ae864bbfcf82945cc83e899c169db3fbe092e0d67f80dffffee9a28ac1c382cc8b3088f960799e2085f89cc0ed079baecdebfe29858adee1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7b53b570aeb04e00f57e6084e39faed3ed88a42fdb42a44ad987ee9f6f117214e45c3dc66ac515a66e94f223622b2889caaac6a744b07e8fd672f387349ecc39"} 08:47:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:47:22 INFO - Copying logs to upload dir... 08:47:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:47:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.469838 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-13 08:47:23.022564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 08:47:23.025711) ========= 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.61EQLHUqmt/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.E64oBPIi0R/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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/Autoland/sha512/b34ccc6ad6f7096dde02c74118d7687fa78074bccf355f709a7d7b10664db0def7d9418536829e655ee7aafabeb65bd5cea1eb39585d0b9f2587f6f4ff5a3b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bbaf81a4f9ab420ae864bbfcf82945cc83e899c169db3fbe092e0d67f80dffffee9a28ac1c382cc8b3088f960799e2085f89cc0ed079baecdebfe29858adee1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7b53b570aeb04e00f57e6084e39faed3ed88a42fdb42a44ad987ee9f6f117214e45c3dc66ac515a66e94f223622b2889caaac6a744b07e8fd672f387349ecc39"} build_url:https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/S8LjyGykQ_G-Z19886AaFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b34ccc6ad6f7096dde02c74118d7687fa78074bccf355f709a7d7b10664db0def7d9418536829e655ee7aafabeb65bd5cea1eb39585d0b9f2587f6f4ff5a3b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bbaf81a4f9ab420ae864bbfcf82945cc83e899c169db3fbe092e0d67f80dffffee9a28ac1c382cc8b3088f960799e2085f89cc0ed079baecdebfe29858adee1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7b53b570aeb04e00f57e6084e39faed3ed88a42fdb42a44ad987ee9f6f117214e45c3dc66ac515a66e94f223622b2889caaac6a744b07e8fd672f387349ecc39"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 08:47:23.095224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:47:23.095579) ========= 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.61EQLHUqmt/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.E64oBPIi0R/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.005190 ========= master_lag: 0.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:47:23.782942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 08:47:23.783252) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 08:47:23.784078) ========= ========= Total master_lag: 0.85 =========