builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0111 starttime: 1480475438.65 results: success (0) buildid: 20161129164126 builduid: d6472abbd91349a089aa6c0718327cf0 revision: 9afe68360fa82c16b760b448b2156230a90caf11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:38.654598) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:38.655166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:38.655510) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:38.681389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:38.681866) ========= 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.F7y3o4AK0a/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.MSSq5lS8au/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-11-29 19:10:38-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 137M=0s 2016-11-29 19:10:39 (137 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.362641 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:39.136825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:39.137185) ========= 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.F7y3o4AK0a/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.MSSq5lS8au/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.025444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:39.187954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 19:10:39.188364) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9afe68360fa82c16b760b448b2156230a90caf11 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9afe68360fa82c16b760b448b2156230a90caf11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F7y3o4AK0a/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.MSSq5lS8au/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-11-29 19:10:39,276 truncating revision to first 12 chars 2016-11-29 19:10:39,276 Setting DEBUG logging. 2016-11-29 19:10:39,277 attempt 1/10 2016-11-29 19:10:39,277 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9afe68360fa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 19:10:40,072 unpacking tar archive at: mozilla-beta-9afe68360fa8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.065449 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 19:10:40.279457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:40.280113) ========= script_repo_revision: 9afe68360fa82c16b760b448b2156230a90caf11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:40.280653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:40.280955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 19:10:40.301454) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-29 19:10:40.301855) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F7y3o4AK0a/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.MSSq5lS8au/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:10:40 INFO - MultiFileLogger online at 20161129 19:10:40 in /builds/slave/test 19:10:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:10:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:40 INFO - {'append_to_log': False, 19:10:40 INFO - 'base_work_dir': '/builds/slave/test', 19:10:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:10:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:40 INFO - 'branch': 'Mozilla-Beta', 19:10:40 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:40 INFO - 'config_files': ('talos/mac_config.py',), 19:10:40 INFO - 'default_actions': ('clobber', 19:10:40 INFO - 'read-buildbot-config', 19:10:40 INFO - 'download-and-extract', 19:10:40 INFO - 'populate-webroot', 19:10:40 INFO - 'create-virtualenv', 19:10:40 INFO - 'install', 19:10:40 INFO - 'run-tests'), 19:10:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:40 INFO - 'download_minidump_stackwalk': True, 19:10:40 INFO - 'download_symbols': 'ondemand', 19:10:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:40 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:40 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:40 INFO - 'installer_path': 'installer.exe', 19:10:40 INFO - 'log_level': 'info', 19:10:40 INFO - 'log_name': 'talos', 19:10:40 INFO - 'log_to_console': True, 19:10:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:10:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:10:40 INFO - 'opt_config_files': (), 19:10:40 INFO - 'pip_index': False, 19:10:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:10:40 INFO - 'cmd': ('bash', 19:10:40 INFO - '-c', 19:10:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:10:40 INFO - 'enabled': True, 19:10:40 INFO - 'halt_on_failure': False, 19:10:40 INFO - 'name': 'check_screen_resolution'},), 19:10:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:10:40 INFO - 'cmd': ('bash', 19:10:40 INFO - '-c', 19:10:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:10:40 INFO - 'enabled': True, 19:10:40 INFO - 'halt_on_failure': False, 19:10:40 INFO - 'name': 'check_screen_resolution'},), 19:10:40 INFO - 'run_cmd_checks_enabled': True, 19:10:40 INFO - 'sps_profile': False, 19:10:40 INFO - 'sps_profile_interval': 0, 19:10:40 INFO - 'suite': 'dromaeojs-e10s', 19:10:40 INFO - 'system_bits': '32', 19:10:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:40 INFO - 'title': 't-yosemite-r7-0111', 19:10:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:40 INFO - 'use_talos_json': True, 19:10:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:40 INFO - 'work_dir': 'build'} 19:10:40 INFO - [mozharness: 2016-11-30 03:10:40.523743Z] Running clobber step. 19:10:40 INFO - Running pre-action listener: _resource_record_pre_action 19:10:40 INFO - Running main action method: clobber 19:10:40 INFO - rmtree: /builds/slave/test/build 19:10:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:42 INFO - Running post-action listener: _resource_record_post_action 19:10:42 INFO - [mozharness: 2016-11-30 03:10:42.894692Z] Finished clobber step (success) 19:10:42 INFO - [mozharness: 2016-11-30 03:10:42.894912Z] Running read-buildbot-config step. 19:10:42 INFO - Running pre-action listener: _resource_record_pre_action 19:10:42 INFO - Running main action method: read_buildbot_config 19:10:42 INFO - Using buildbot properties: 19:10:42 INFO - { 19:10:42 INFO - "project": "", 19:10:42 INFO - "product": "firefox", 19:10:42 INFO - "script_repo_revision": "production", 19:10:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 19:10:42 INFO - "repository": "", 19:10:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 19:10:42 INFO - "buildid": "20161129164126", 19:10:42 INFO - "pgo_build": "False", 19:10:42 INFO - "basedir": "/builds/slave/test", 19:10:42 INFO - "buildnumber": 12, 19:10:42 INFO - "slavename": "t-yosemite-r7-0111", 19:10:42 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:10:42 INFO - "platform": "yosemite_r7", 19:10:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:10:42 INFO - "branch": "mozilla-beta", 19:10:42 INFO - "repo_path": "releases/mozilla-beta", 19:10:42 INFO - "revision": "9afe68360fa82c16b760b448b2156230a90caf11", 19:10:42 INFO - "stage_platform": "macosx64", 19:10:42 INFO - "builduid": "d6472abbd91349a089aa6c0718327cf0", 19:10:42 INFO - "slavebuilddir": "test" 19:10:42 INFO - } 19:10:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 19:10:42 INFO - Running post-action listener: _resource_record_post_action 19:10:42 INFO - [mozharness: 2016-11-30 03:10:42.900426Z] Finished read-buildbot-config step (success) 19:10:42 INFO - [mozharness: 2016-11-30 03:10:42.900639Z] Running download-and-extract step. 19:10:42 INFO - Running pre-action listener: _resource_record_pre_action 19:10:42 INFO - Running main action method: download_and_extract 19:10:42 INFO - mkdir: /builds/slave/test/build/tests 19:10:42 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')]} 19:10:42 INFO - trying https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 19:10:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 19:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 19:10:44 INFO - Downloaded 1165 bytes. 19:10:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 19:10:44 INFO - Using the following test package requirements: 19:10:44 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 19:10:44 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:10:44 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 19:10:44 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:10:44 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 19:10:44 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:10:44 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:10:44 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 19:10:44 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 19:10:44 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:10:44 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 19:10:44 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:10:44 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 19:10:44 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:10:44 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 19:10:44 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:10:44 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 19:10:44 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 19:10:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 19:10:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 19:10:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 19:10:44 INFO - Expected file size: 16233053 19:10:51 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:10:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 19:10:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 19:10:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 19:10:52 INFO - Expected file size: 16233053 19:10:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 19:10:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 19:10:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 19:10:59 INFO - Expected file size: 14414089 19:11: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')]} 19:11:00 INFO - trying https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg 19:11:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 19:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 19:11:02 INFO - Downloaded 86054865 bytes. 19:11:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg 19:11:02 INFO - mkdir: /builds/slave/test/properties 19:11:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:02 INFO - Contents: 19:11:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg 19:11:03 INFO - Running post-action listener: _resource_record_post_action 19:11:03 INFO - Running post-action listener: set_extra_try_arguments 19:11:03 INFO - [mozharness: 2016-11-30 03:11:03.451628Z] Finished download-and-extract step (success) 19:11:03 INFO - [mozharness: 2016-11-30 03:11:03.451765Z] Running populate-webroot step. 19:11:03 INFO - Running pre-action listener: _resource_record_pre_action 19:11:03 INFO - Running main action method: populate_webroot 19:11:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:03 INFO - '--tppagecycles', 19:11:03 INFO - '7'], 19:11:03 INFO - 'tests': ['tsvgm']}}, 19:11:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['damp', 'tps']}, 19:11:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'tests': ['damp', 'tps']}, 19:11:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['dromaeo_dom']}, 19:11:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['basic_compositor_video']}, 19:11:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:11:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['a11yr', 19:11:03 INFO - 'ts_paint', 19:11:03 INFO - 'tpaint', 19:11:03 INFO - 'sessionrestore', 19:11:03 INFO - 'sessionrestore_no_auto_restore', 19:11:03 INFO - 'tabpaint']}, 19:11:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:03 INFO - 'ts_paint', 19:11:03 INFO - 'tpaint', 19:11:03 INFO - 'sessionrestore', 19:11:03 INFO - 'sessionrestore_no_auto_restore', 19:11:03 INFO - 'tabpaint']}, 19:11:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:03 INFO - 'ts_paint', 19:11:03 INFO - 'tpaint', 19:11:03 INFO - 'sessionrestore', 19:11:03 INFO - 'sessionrestore_no_auto_restore', 19:11:03 INFO - 'tabpaint']}, 19:11:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:03 INFO - 'ts_paint', 19:11:03 INFO - 'tpaint', 19:11:03 INFO - 'sessionrestore', 19:11:03 INFO - 'sessionrestore_no_auto_restore', 19:11:03 INFO - 'tabpaint']}, 19:11:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['a11yr', 19:11:03 INFO - 'ts_paint', 19:11:03 INFO - 'tpaint', 19:11:03 INFO - 'sessionrestore', 19:11:03 INFO - 'sessionrestore_no_auto_restore', 19:11:03 INFO - 'tabpaint']}, 19:11:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['a11yr', 19:11:03 INFO - 'ts_paint', 19:11:03 INFO - 'tpaint', 19:11:03 INFO - 'sessionrestore', 19:11:03 INFO - 'sessionrestore_no_auto_restore', 19:11:03 INFO - 'tabpaint']}, 19:11:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['tsvgx', 19:11:03 INFO - 'tsvgr_opacity', 19:11:03 INFO - 'tart', 19:11:03 INFO - 'tscrollx', 19:11:03 INFO - 'cart']}, 19:11:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:03 INFO - 'tsvgr_opacity', 19:11:03 INFO - 'tart', 19:11:03 INFO - 'tscrollx', 19:11:03 INFO - 'cart']}, 19:11:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'talos_options': ['--disable-e10s'], 19:11:03 INFO - 'tests': ['tp5o']}, 19:11:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'tests': ['tp5o']}, 19:11:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'talos_options': ['--disable-e10s', 19:11:03 INFO - '--xperf_path', 19:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:03 INFO - 'tests': ['tp5n']}, 19:11:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:03 INFO - 'talos_options': ['--xperf_path', 19:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:03 INFO - 'tests': ['tp5n']}}, 19:11:03 INFO - 'talos.zip': {'path': '', 19:11:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:03 INFO - Running post-action listener: _resource_record_post_action 19:11:03 INFO - [mozharness: 2016-11-30 03:11:03.470400Z] Finished populate-webroot step (success) 19:11:03 INFO - [mozharness: 2016-11-30 03:11:03.470530Z] Running create-virtualenv step. 19:11:03 INFO - Running pre-action listener: _resource_record_pre_action 19:11:03 INFO - Running main action method: create_virtualenv 19:11:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:03 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 19:11:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:03 INFO - Using real prefix '/tools/python27' 19:11:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:07 INFO - Installing pip.................done. 19:11:07 INFO - Return code: 0 19:11:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:07 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:07 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 19:11:07 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 19:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:07 INFO - 'HOME': '/Users/cltbld', 19:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:07 INFO - 'LOGNAME': 'cltbld', 19:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:07 INFO - 'MOZ_NO_REMOTE': '1', 19:11:07 INFO - 'NO_EM_RESTART': '1', 19:11:07 INFO - 'PAGER': '/bin/cat', 19:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:07 INFO - 'PWD': '/builds/slave/test', 19:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:07 INFO - 'SHELL': '/bin/bash', 19:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:07 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:07 INFO - 'USER': 'cltbld', 19:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:07 INFO - 'XPC_FLAGS': '0x0', 19:11:07 INFO - 'XPC_SERVICE_NAME': '0', 19:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:07 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 19:11:07 INFO - Cleaning up... 19:11:07 INFO - Return code: 0 19:11:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:07 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:07 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 19:11:07 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 19:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:07 INFO - 'HOME': '/Users/cltbld', 19:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:07 INFO - 'LOGNAME': 'cltbld', 19:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:07 INFO - 'MOZ_NO_REMOTE': '1', 19:11:07 INFO - 'NO_EM_RESTART': '1', 19:11:07 INFO - 'PAGER': '/bin/cat', 19:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:07 INFO - 'PWD': '/builds/slave/test', 19:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:07 INFO - 'SHELL': '/bin/bash', 19:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:07 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:07 INFO - 'USER': 'cltbld', 19:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:07 INFO - 'XPC_FLAGS': '0x0', 19:11:07 INFO - 'XPC_SERVICE_NAME': '0', 19:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:07 INFO - Downloading/unpacking psutil>=3.1.1 19:11:07 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 19:11:07 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 19:11:07 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 19:11:07 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 19:11:07 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 19:11:07 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 19:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:11 INFO - Installing collected packages: psutil 19:11:11 INFO - Running setup.py install for psutil 19:11:11 INFO - building 'psutil._psutil_osx' extension 19:11:11 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 19:11:11 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 19:11:11 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 19:11:12 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 19:11:12 INFO - building 'psutil._psutil_posix' extension 19:11:12 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 19:11:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:11:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:11:12 INFO - ^ 19:11:12 INFO - 1 warning generated. 19:11:12 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 19:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:12 INFO - Successfully installed psutil 19:11:12 INFO - Cleaning up... 19:11:12 INFO - Return code: 0 19:11:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:12 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:12 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 19:11:12 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 19:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:12 INFO - 'HOME': '/Users/cltbld', 19:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:12 INFO - 'LOGNAME': 'cltbld', 19:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:12 INFO - 'MOZ_NO_REMOTE': '1', 19:11:12 INFO - 'NO_EM_RESTART': '1', 19:11:12 INFO - 'PAGER': '/bin/cat', 19:11:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:12 INFO - 'PWD': '/builds/slave/test', 19:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:12 INFO - 'SHELL': '/bin/bash', 19:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:12 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:12 INFO - 'USER': 'cltbld', 19:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:12 INFO - 'XPC_FLAGS': '0x0', 19:11:12 INFO - 'XPC_SERVICE_NAME': '0', 19:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:15 INFO - Installing collected packages: mozsystemmonitor 19:11:15 INFO - Running setup.py install for mozsystemmonitor 19:11:15 INFO - Successfully installed mozsystemmonitor 19:11:15 INFO - Cleaning up... 19:11:15 INFO - Return code: 0 19:11:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:15 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')]} 19:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:15 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')]} 19:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:15 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:15 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 19:11:15 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 19:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:15 INFO - 'HOME': '/Users/cltbld', 19:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:15 INFO - 'LOGNAME': 'cltbld', 19:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:15 INFO - 'MOZ_NO_REMOTE': '1', 19:11:15 INFO - 'NO_EM_RESTART': '1', 19:11:15 INFO - 'PAGER': '/bin/cat', 19:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:15 INFO - 'PWD': '/builds/slave/test', 19:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:15 INFO - 'SHELL': '/bin/bash', 19:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:15 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:15 INFO - 'USER': 'cltbld', 19:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:15 INFO - 'XPC_FLAGS': '0x0', 19:11:15 INFO - 'XPC_SERVICE_NAME': '0', 19:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:18 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 19:11:18 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 19:11:18 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 19:11:18 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 19:11:18 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 19:11:18 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 19:11:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:18 INFO - warning: no files found matching '*.txt' 19:11:18 INFO - no previously-included directories found matching 'build' 19:11:18 INFO - no previously-included directories found matching 'dist' 19:11:18 INFO - no previously-included directories found matching '.git*' 19:11:18 INFO - Installing collected packages: jsonschema, functools32 19:11:18 INFO - Running setup.py install for functools32 19:11:19 INFO - warning: no files found matching '*.txt' 19:11:19 INFO - no previously-included directories found matching 'build' 19:11:19 INFO - no previously-included directories found matching 'dist' 19:11:19 INFO - no previously-included directories found matching '.git*' 19:11:19 INFO - Successfully installed jsonschema functools32 19:11:19 INFO - Cleaning up... 19:11:19 INFO - Return code: 0 19:11:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:11:19 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')]} 19:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:19 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')]} 19:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:19 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:19 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 19:11:19 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 19:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:19 INFO - 'HOME': '/Users/cltbld', 19:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:19 INFO - 'LOGNAME': 'cltbld', 19:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:19 INFO - 'MOZ_NO_REMOTE': '1', 19:11:19 INFO - 'NO_EM_RESTART': '1', 19:11:19 INFO - 'PAGER': '/bin/cat', 19:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:19 INFO - 'PWD': '/builds/slave/test', 19:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:19 INFO - 'SHELL': '/bin/bash', 19:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:19 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:19 INFO - 'USER': 'cltbld', 19:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:19 INFO - 'XPC_FLAGS': '0x0', 19:11:19 INFO - 'XPC_SERVICE_NAME': '0', 19:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:11:19 INFO - Cleaning up... 19:11:19 INFO - Return code: 0 19:11:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:19 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')]} 19:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:19 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')]} 19:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:19 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:19 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 19:11:19 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 19:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:19 INFO - 'HOME': '/Users/cltbld', 19:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:19 INFO - 'LOGNAME': 'cltbld', 19:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:19 INFO - 'MOZ_NO_REMOTE': '1', 19:11:19 INFO - 'NO_EM_RESTART': '1', 19:11:19 INFO - 'PAGER': '/bin/cat', 19:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:19 INFO - 'PWD': '/builds/slave/test', 19:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:19 INFO - 'SHELL': '/bin/bash', 19:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:19 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:19 INFO - 'USER': 'cltbld', 19:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:19 INFO - 'XPC_FLAGS': '0x0', 19:11:19 INFO - 'XPC_SERVICE_NAME': '0', 19:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:19 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 19:11:19 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 19:11:19 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 19:11:19 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 19:11:19 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 19:11:19 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 19:11:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:22 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 19:11:22 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 19:11:22 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 19:11:22 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 19:11:22 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 19:11:22 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 19:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:23 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 19:11:23 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 19:11:23 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 19:11:23 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 19:11:23 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 19:11:23 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 19:11:23 INFO - Downloading docopt-0.6.1.tar.gz 19:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:23 INFO - Running setup.py install for blobuploader 19:11:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:23 INFO - Running setup.py install for requests 19:11:24 INFO - Running setup.py install for docopt 19:11:24 INFO - Successfully installed blobuploader requests docopt 19:11:24 INFO - Cleaning up... 19:11:24 INFO - Return code: 0 19:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:24 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')]} 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:24 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')]} 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:24 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:24 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 19:11:24 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 19:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:24 INFO - 'HOME': '/Users/cltbld', 19:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:24 INFO - 'LOGNAME': 'cltbld', 19:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:24 INFO - 'MOZ_NO_REMOTE': '1', 19:11:24 INFO - 'NO_EM_RESTART': '1', 19:11:24 INFO - 'PAGER': '/bin/cat', 19:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:24 INFO - 'PWD': '/builds/slave/test', 19:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:24 INFO - 'SHELL': '/bin/bash', 19:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:24 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:24 INFO - 'USER': 'cltbld', 19:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:24 INFO - 'XPC_FLAGS': '0x0', 19:11:24 INFO - 'XPC_SERVICE_NAME': '0', 19:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:24 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-_oc0Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:24 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-fgYpV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-yUytNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-h3EXyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-I9phA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-K0mqmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kGV9X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-eYZAHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-KpAwSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-BKi8Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-lafFBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-1yPO8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0VSgQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-xTPOER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-yXDXLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-5HJoyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-26jjoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:26 INFO - Running setup.py install for manifestparser 19:11:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:26 INFO - Running setup.py install for mozcrash 19:11:26 INFO - Running setup.py install for mozdebug 19:11:27 INFO - Running setup.py install for mozdevice 19:11:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Running setup.py install for mozfile 19:11:27 INFO - Running setup.py install for mozhttpd 19:11:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Running setup.py install for mozinfo 19:11:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Running setup.py install for mozInstall 19:11:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:27 INFO - Running setup.py install for mozleak 19:11:27 INFO - Running setup.py install for mozlog 19:11:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:28 INFO - Running setup.py install for moznetwork 19:11:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:28 INFO - Running setup.py install for mozprocess 19:11:28 INFO - Running setup.py install for mozprofile 19:11:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:28 INFO - Running setup.py install for mozrunner 19:11:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:28 INFO - Running setup.py install for mozscreenshot 19:11:28 INFO - Running setup.py install for moztest 19:11:29 INFO - Running setup.py install for mozversion 19:11:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:29 INFO - Cleaning up... 19:11:29 INFO - Return code: 0 19:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:29 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')]} 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:29 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')]} 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:29 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:29 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 19:11:29 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 19:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:29 INFO - 'HOME': '/Users/cltbld', 19:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:29 INFO - 'LOGNAME': 'cltbld', 19:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:29 INFO - 'MOZ_NO_REMOTE': '1', 19:11:29 INFO - 'NO_EM_RESTART': '1', 19:11:29 INFO - 'PAGER': '/bin/cat', 19:11:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:29 INFO - 'PWD': '/builds/slave/test', 19:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:29 INFO - 'SHELL': '/bin/bash', 19:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:29 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:29 INFO - 'USER': 'cltbld', 19:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:29 INFO - 'XPC_FLAGS': '0x0', 19:11:29 INFO - 'XPC_SERVICE_NAME': '0', 19:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:29 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HXoBa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:29 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)) 19:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:29 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-3GETnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:29 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)) 19:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:29 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-UG6lPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:29 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)) 19:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:29 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-lYAAZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:29 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)) 19:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:29 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-LSDttn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-WFHW_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Ixf49r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-KJLsPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2lXE4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-y7YEgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-mVINrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-WUcbCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-cBbr8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:30 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)) 19:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-xpYK9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:31 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)) 19:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JUf3pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:31 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)) 19:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-VpB6bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:31 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)) 19:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2RbptX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:31 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)) 19:11:31 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)) 19:11:31 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)) 19:11:31 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)) 19:11:31 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)) 19:11:31 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)) 19:11:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:31 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 19:11:31 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 19:11:31 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 19:11:31 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 19:11:31 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 19:11:31 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 19:11:33 INFO - Downloading blessings-1.6.tar.gz 19:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:34 INFO - Installing collected packages: blessings 19:11:34 INFO - Running setup.py install for blessings 19:11:34 INFO - Successfully installed blessings 19:11:34 INFO - Cleaning up... 19:11:34 INFO - Return code: 0 19:11:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:34 INFO - Reading from file tmpfile_stdout 19:11:34 INFO - Current package versions: 19:11:34 INFO - blessings == 1.6 19:11:34 INFO - blobuploader == 1.2.4 19:11:34 INFO - docopt == 0.6.1 19:11:34 INFO - functools32 == 3.2.3-2 19:11:34 INFO - jsonschema == 2.5.1 19:11:34 INFO - manifestparser == 1.1 19:11:34 INFO - mozInstall == 1.12 19:11:34 INFO - mozcrash == 0.17 19:11:34 INFO - mozdebug == 0.1 19:11:34 INFO - mozdevice == 0.48 19:11:34 INFO - mozfile == 1.2 19:11:34 INFO - mozhttpd == 0.7 19:11:34 INFO - mozinfo == 0.9 19:11:34 INFO - mozleak == 0.1 19:11:34 INFO - mozlog == 3.4 19:11:34 INFO - moznetwork == 0.27 19:11:34 INFO - mozprocess == 0.23 19:11:34 INFO - mozprofile == 0.28 19:11:34 INFO - mozrunner == 6.12 19:11:34 INFO - mozscreenshot == 0.1 19:11:34 INFO - mozsystemmonitor == 0.3 19:11:34 INFO - moztest == 0.7 19:11:34 INFO - mozversion == 1.4 19:11:34 INFO - psutil == 3.1.1 19:11:34 INFO - requests == 1.2.3 19:11:34 INFO - wsgiref == 0.1.2 19:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:34 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')]} 19:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:35 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')]} 19:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:35 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:35 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 19:11:35 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 19:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:35 INFO - 'HOME': '/Users/cltbld', 19:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:35 INFO - 'LOGNAME': 'cltbld', 19:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:35 INFO - 'MOZ_NO_REMOTE': '1', 19:11:35 INFO - 'NO_EM_RESTART': '1', 19:11:35 INFO - 'PAGER': '/bin/cat', 19:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:35 INFO - 'PWD': '/builds/slave/test', 19:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:35 INFO - 'SHELL': '/bin/bash', 19:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:35 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:35 INFO - 'USER': 'cltbld', 19:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:35 INFO - 'XPC_FLAGS': '0x0', 19:11:35 INFO - 'XPC_SERVICE_NAME': '0', 19:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 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)) 19:11:35 INFO - Cleaning up... 19:11:35 INFO - Return code: 0 19:11:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:35 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')]} 19:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:35 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')]} 19:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:35 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 0x10871c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108692570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec61c9d590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, '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.F7y3o4AK0a/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.MSSq5lS8au/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:11:35 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 19:11:35 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 19:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:35 INFO - 'HOME': '/Users/cltbld', 19:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:35 INFO - 'LOGNAME': 'cltbld', 19:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:35 INFO - 'MOZ_NO_REMOTE': '1', 19:11:35 INFO - 'NO_EM_RESTART': '1', 19:11:35 INFO - 'PAGER': '/bin/cat', 19:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:35 INFO - 'PWD': '/builds/slave/test', 19:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:35 INFO - 'SHELL': '/bin/bash', 19:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:35 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:35 INFO - 'USER': 'cltbld', 19:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:35 INFO - 'XPC_FLAGS': '0x0', 19:11:35 INFO - 'XPC_SERVICE_NAME': '0', 19:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:36 INFO - Cleaning up... 19:11:36 INFO - Return code: 0 19:11:36 INFO - Running post-action listener: _resource_record_post_action 19:11:36 INFO - Running post-action listener: _start_resource_monitoring 19:11:36 INFO - Starting resource monitoring. 19:11:36 INFO - [mozharness: 2016-11-30 03:11:36.100392Z] Finished create-virtualenv step (success) 19:11:36 INFO - [mozharness: 2016-11-30 03:11:36.101395Z] Running install step. 19:11:36 INFO - Running pre-action listener: _resource_record_pre_action 19:11:36 INFO - Running main action method: install 19:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:36 INFO - Reading from file tmpfile_stdout 19:11:36 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:36 INFO - Reading from file tmpfile_stdout 19:11:36 INFO - Output received: 19:11:36 INFO - Usage: mozinstall [options] installer 19:11:36 INFO - Options: 19:11:36 INFO - -h, --help show this help message and exit 19:11:36 INFO - -d DEST, --destination=DEST 19:11:36 INFO - Directory to install application into. [default: 19:11:36 INFO - "/builds/slave/test"] 19:11:36 INFO - --app=APP Application being installed. [default: firefox] 19:11:36 INFO - mkdir: /builds/slave/test/build/application 19:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:11:58 INFO - Reading from file tmpfile_stdout 19:11:58 INFO - Output received: 19:11:58 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:11:58 INFO - Running post-action listener: _resource_record_post_action 19:11:58 INFO - [mozharness: 2016-11-30 03:11:58.639358Z] Finished install step (success) 19:11:58 INFO - [mozharness: 2016-11-30 03:11:58.639521Z] Running run-tests step. 19:11:58 INFO - Running pre-action listener: _resource_record_pre_action 19:11:58 INFO - Running main action method: run_tests 19:11:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:11:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:11:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:11:58 INFO - 2016-11-29 19:11:58.654 screenresolution[7070:131881] starting screenresolution argv=screenresolution get 19:11:58 INFO - 2016-11-29 19:11:58.657 screenresolution[7070:131881] Display 0: 1600x1200x32@60 19:11:58 INFO - 2016-11-29 19:11:58.662 screenresolution[7071:131883] starting screenresolution argv=screenresolution list 19:11:58 INFO - Available Modes on Display 0 19:11:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:11:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:11:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:11:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:11:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:11:58 INFO - Intel Iris: 19:11:58 INFO - Chipset Model: Intel Iris 19:11:58 INFO - Type: GPU 19:11:58 INFO - Bus: Built-In 19:11:58 INFO - VRAM (Dynamic, Max): 1536 MB 19:11:58 INFO - Vendor: Intel (0x8086) 19:11:58 INFO - Device ID: 0x0a2e 19:11:58 INFO - Revision ID: 0x0009 19:11:58 INFO - Displays: 19:11:58 INFO - Display: 19:11:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:11:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:11:58 INFO - Display Serial Number: 1600x1200 60 19:11:58 INFO - Main Display: Yes 19:11:58 INFO - Mirror: Off 19:11:58 INFO - Online: Yes 19:11:58 INFO - Rotation: Supported 19:11:58 INFO - Return code: 0 19:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:58 INFO - Python 2.7.3 19:11:58 INFO - Return code: 0 19:11:58 INFO - grabbing minidump binary from tooltool 19:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:58 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 0x108530d30>, '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 0x108396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108528b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:58 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 19:11:58 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 19:11:58 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 19:11:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:59 INFO - Return code: 0 19:11:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:11:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:11:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F7y3o4AK0a/Render', 19:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:59 INFO - 'HOME': '/Users/cltbld', 19:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:59 INFO - 'LOGNAME': 'cltbld', 19:11:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:59 INFO - 'MOZ_NO_REMOTE': '1', 19:11:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:59 INFO - 'NO_EM_RESTART': '1', 19:11:59 INFO - 'PAGER': '/bin/cat', 19:11:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:59 INFO - 'PWD': '/builds/slave/test', 19:11:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:59 INFO - 'SHELL': '/bin/bash', 19:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MSSq5lS8au/Listeners', 19:11:59 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:59 INFO - 'USER': 'cltbld', 19:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:59 INFO - 'XPC_FLAGS': '0x0', 19:11:59 INFO - 'XPC_SERVICE_NAME': '0', 19:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:11:59 INFO - mozversion application_buildid: 20161129164126 19:11:59 INFO - mozversion application_changeset: 9afe68360fa82c16b760b448b2156230a90caf11 19:11:59 INFO - mozversion application_display_name: Firefox 19:11:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:59 INFO - mozversion application_name: Firefox 19:11:59 INFO - mozversion application_remotingname: firefox 19:11:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:11:59 INFO - mozversion application_vendor: Mozilla 19:11:59 INFO - mozversion application_version: 51.0 19:11:59 INFO - mozversion platform_buildid: 20161129164126 19:11:59 INFO - mozversion platform_changeset: 9afe68360fa82c16b760b448b2156230a90caf11 19:11:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:11:59 INFO - mozversion platform_version: 51.0 19:11:59 INFO - using testdate: 1480475519 19:11:59 INFO - actual date: 1480475519 19:11:59 INFO - starting webserver on 'localhost:52628' 19:11:59 INFO - SUITE-START | Running 2 tests 19:11:59 INFO - TEST-START | dromaeo_css 19:11:59 INFO - operating with platform_type : mac_ 19:11:59 INFO - Initialising browser for dromaeo_css test... 19:11:59 INFO - TEST-INFO | started process 7081 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp6WkTi5/profile http://localhost:52628/getInfo.html) 19:12:01 INFO - PROCESS | 7081 | __metrics Screen width/height:1600/1200 19:12:01 INFO - PROCESS | 7081 | colorDepth:24 19:12:01 INFO - PROCESS | 7081 | Browser inner width/height: 1024/689 19:12:01 INFO - PROCESS | 7081 | __metrics 19:12:01 ERROR - PROCESS | 7081 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 19:12:02 INFO - TEST-INFO | 7081: exit 0 19:12:02 INFO - Browser initialized. 19:12:02 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:02 INFO - TEST-INFO | started process 7084 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp6WkTi5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:14 INFO - PROCESS | 7084 | RSS: Main: 174616576 19:12:14 INFO - PROCESS | 7084 | 19:13:03 INFO - PROCESS | 7084 | 1480475583903 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] 19:15:15 INFO - PROCESS | 7084 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52628/tests/dromaeo/cssquery-ext.html) 19:15:17 INFO - PROCESS | 7084 | RSS: Main: 186232832 19:15:17 INFO - PROCESS | 7084 | 19:18:19 INFO - PROCESS | 7084 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-ext.html (next: http://localhost:52628/tests/dromaeo/cssquery-jquery.html) 19:18:19 INFO - PROCESS | 7084 | RSS: Main: 198082560 19:18:19 INFO - PROCESS | 7084 | 19:21:21 INFO - PROCESS | 7084 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52628/tests/dromaeo/cssquery-mootools.html) 19:21:22 INFO - PROCESS | 7084 | RSS: Main: 199966720 19:21:22 INFO - PROCESS | 7084 | 19:24:24 INFO - PROCESS | 7084 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52628/tests/dromaeo/cssquery-prototype.html) 19:24:24 INFO - PROCESS | 7084 | RSS: Main: 204398592 19:24:24 INFO - PROCESS | 7084 | 19:27:27 INFO - PROCESS | 7084 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52628/tests/dromaeo/cssquery-yui.html) 19:27:28 INFO - PROCESS | 7084 | RSS: Main: 206532608 19:27:28 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-yui.html (next: http://localhost:52628/tests/dromaeo/cssquery-dojo.html) 19:30:30 INFO - PROCESS | 7084 | RSS: Main: 207233024 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | __start_tp_report 19:30:30 INFO - PROCESS | 7084 | _x_x_mozilla_page_load 19:30:30 INFO - PROCESS | 7084 | _x_x_mozilla_page_load_details 19:30:30 INFO - PROCESS | 7084 | |i|pagename|runs| 19:30:30 INFO - PROCESS | 7084 | |0;dojo.html;3560.1455650643843;3584.820758962053;3601.4777857210706;3612.241429299847;3639.3631114554946;6059.394060593939;6117.265928088625;6133.417325354096;6154.446099851024;6155.938440615592;6059.515238780898;6079.696015199244;6087.908681369783;6134.815955521331;6185.41238582334;5451.890962180764;5476.835694929158;5496.258005169291;5557.138643510242;5589.916151257714;5571.387147413801;5573.108302671573;5583.162525621169;5585.525230355424;5608.635438696471;5399.352077750676;5429.538489228401;5542.861428464301;5552.222688823568;5559.77760889566;4929.359183306147;5418.647787893774;5501.119820828668;5516.558675305966;5555.638883472561;5391.083515802323;5492.011437941169;5502.779888804443;5510.669359838423;5530.723463826833;6082.330943596201;6102.489251635852;6118.558266176196;6132.264128304588;6142.314611233269;6267.592606480564;6327.082573026885;6332.271788744308;6333.145025421555;6342.39747224013;6435.292117867031;6464.159659244268;6488.610683359014;6495.512836537278;6529.249136349285;6004.639721616717;6063.666498342545;6076.848078797977;6188.350223226586;6194.25668919728;6415;6485.54601177913;6558.672066396756;6581.868362632817;6582.275949645536;5240.4497527759795;6306.3378345274;6336.334684858116;6338.936610633835;6339.809805705836;6257.217847769029;6283.717232724538;6463.321351258144;6489.805305840832;6498.317676643885;5487.710388058803;5775.249217601685;6145.754169833246;6186.4741496973265;6232.688365581794;5286.418493965661;5791.768329266866;6298.338674439209;6311.431971122621;6325.209348831396;5048.116579598555;5122.052420302256;5175.14610089331;5176.223566464985;5176.378834539879;4563;4563;4588.151192029485;4590.036092420562;4626.976865115653;6207.037909124093;6239.313675495692;6242.250929888442;6251;6251.9684252098805;6428.19647544057;6497.317781632955;6498.3826536478955;6505.772297969548;6517.608943463408;6128.778133445034;6135.171422439398;6162.014077747539;6190.845228869224;6190.938090619036;5634.605577609528;5695.743691533891;5698.344690360579;5710.5717071219;5746.942530574641;6469.935300647122;6512.381323774234;6736.730530778714;6748.493862960199;6767.966160169168;6326.620402775849;6365.013422919455;6402.967985160044;6477.51418643613;6487.3188315226225;6619.304972977768;6665.600063996176;6682.298358672269;6700.83247918806;6708.563943343667;6214.782482613087;6274.247090349188;6369.076483909715;6376.681165941777;6377.681115944277;6279.403456671609;6291.653959032297;6322.905156422566;6346.777862774781;6458.289588145394;6301.4328710416285;6304.747810087545;6305.180326557518;6318.494520438446;6318.747250110128;6144.662043587646;6251.156093927261;6253.6560489173535;6303.842403939938;6309.463695585927;6085.604435711664;6145.569810113428;6164.116606537852;6207.689615519296;6259.12372267892;6303.46420554258;6313.621182729051;6318.715657795318;6321.273053598895;6346.301906790157;4978.8755281118265;5600;6268.6552239625435;6290.559660823698;6329.367063293634 19:30:30 INFO - PROCESS | 7084 | |1;ext.html;482.9279000618628;488.90955173292923;489.4469249747784;521.8831700161653;531.463222145633;31572.842135789317;42521.574784252145;42653;42752.57247427525;43636.345454818205;33314.66685333146;43715.56284437155;44305.77847110768;44324.113517729624;44477.555224447744;9936.602535898555;10089.798204035915;10120.595176192981;10152.492375381202;10163.237757168205;9916.900830991706;9923.801523969552;9929.602815887356;10025.949870250675;10050.296479246455;10010.84983725241;10039.548220330065;10071.748206294864;10074.647387341445;10099;9985.700428987142;9994.900050999506;10048.145907597864;10057.899421005843;10065.647702330456;10027.448490333029;10034.046765557261;10115.140213081897;10164.085232329053;10188.439635820027;41038.1792364154;42233.36649950253;42244.57755422437;42531.7873410631;42644.360334595;3016.909492715222;3330.6669333066743;3362.714169295613;3627.1838836261895;3657.2868290683327;31439.528407073685;31885.521717174262;32030.519542206886;32115.839420802746;32713;3249.203945033482;3287.309664970359;3306.991367632871;3363.630000699921;3391.1861153323025;326963;328449;329942;329972;331778;35693.82153089218;63487.682561586895;64228.67885660542;64342.678286608265;64558.67720661367;35146.76986305518;35210.47184292186;36195.63804361975;36241;36459.4531082034;15013.624659383602;15207.391704331923;15501.689966200613;15679;15679.980801247882;12990.870091298966;13101.934490327487;13169.209847409185;13187.670308242179;13215.60353189406;7979.241972012649;7995.520268783892;8065.959670201729;8095.757127286073;8164.428490005761;2968.6289213848268;3335.93328133436;3349.681780230923;3349.866005359807;3366.966330336665;929.5816882402946;951.4053716427233;974.6150270643199;1004.7889943111882;1017.389566260238;26405.603915941276;29626.851865740966;30089.69910300869;30536.419537069618;31375.37249255002;967.9419234845932;1063.6755789484282;1070.7537266428765;1095.4030053620795;1270.9537644392522;13351.866481335257;15927.681446371007;15967.520974370787;16117.274722637509;16127.435539756052;672927;679184;680995;688281;691444;56780;57237;57425.42574574201;57624.711876441186;57636.135457968165;1378.3383975691725;1412.4491448335157;1425.4298280687808;1428.1502506008908;1428.9714205716036;29766.362850042588;30776.846115769276;30801;30925.845370773;31209.8439507801;49237.507624923295;49650.75174624248;49921.251181233034;50061;50114.74942625264;561403;563861;566733;567543;568464;26528.734712652626;26612.201633951012;26676.466470670865;26761.464770704868;26918.59622105631;46208;47262;47620;47675.761621191676;47740.2838957409;39035.6096439032;39308.41037384384;39340;40186.1962760749;40824.59175408327;38622;39027.80486097551;40111.59888401079;40214.39678404885;40487.98780030405;37851.432228517144;38739.03152421212;39397.60602393939;39470.81587552378;39611;29744;32025.839870800497;35105;35360.823195884885;35698.28603427865;24158.87920560386;25311.620325695498;26485.867570662023;27028;27230.863845680644 19:30:30 INFO - PROCESS | 7084 | |2;jquery.html;328.77478926935066;376.992460150797;390.6308538431182;394.9427333036708;412.79154027216254;19772.60454790903;21093.15627374903;21707.891460542716;21789.564208715816;21917.342479725612;11968.401579921012;12335.383230838444;12376.752464950696;13000.934995325033;20693.068811903464;4951.702897826124;5623.128415095667;5817.981853175698;5835.4456326649115;5835.766569337221;5460.563154947595;5655.604107712462;5682.51698605619;5710.7430165642645;5723.084306510959;5711.286089238845;5719;5720.7711691532495;5721.970045391828;5729.226554415142;5867.647941123546;6229.283632382266;6311.274203466614;6317.93682063178;6324.272708638519;5322.361316641989;5500.257465242181;5591.6365436246515;5595.076812325961;5636.774529018834;13650.249236292;13831.585052448443;16850.747238791428;26637.733622663913;27058.45883082347;2148.79586439288;2256.5825322315422;2331.5336932613545;2364.7989920856576;2384.678068460753;10535.42055186972;10605.628802991858;10651.786964260671;10833.783324333548;10864.728381790519;1985.8709183903;2010.155734591475;2011.4770159758423;2013.9798602013939;2024;132511.33744331312;136613.31693341568;137240.31379843137;137844.999999999;139893.3005334967;9624.566894489624;11756.58851940178;11992.700182495333;12021.459034343476;12074.87925120755;15430.22848857575;15434.614134646723;15435.842311826658;15461.14963676986;15486.993345432511;8198.590070496452;8669.609867555975;8832.072632373509;9020.42142625038;9029.729108126767;6408.67956602168;8172.550509722022;9017.729468115967;9062.093790620886;9065.365424420228;3919.392494163409;4621.745803980746;4721.181990894737;4739.175417464232;4783.784729687172;1553.8601525862728;1786.7230579260236;1928.305809908432;2012.3638034175278;2013.1343522285558;864.9922839891582;888.7955770172896;897.3987428422972;995.7361299255703;1007.8538611901233;21036.68596454389;21422.57154856894;21440.57118857614;21525.354239372842;21541.353759387242;941.7598512379436;969.2149359019076;982.7346616413529;1025.3027941000191;1086.3373342261214;9332.860007099764;9676.467794271382;10123.64567240143;11190.720231994103;11376.54493820238;564856;627804;630365;634043;636385;105220;126996;128669;144666.27725273606;151567;869.6434461870602;992.6724181020246;1011.9747006324901;1017.2370721958531;1019.8368261078192;18890.811091888907;18960.810391896455;19387.127579258686;19473;19591.02044897778;53901;56589.71705141448;56664;57819;57997.42002580089;58951;78437;81742.59128704318;84157;84397;7329.157146928172;7511.924880751122;7569;7596.5946299934685;8384.790380240298;10302.948485257526;12956.67608309762;13406.195628262336;13456.798148027983;13542.322883855964;7951.483153594998;9105.635774568944;9743.561539730586;11634.76730465403;11736.589219377282;11221.66335009951;11361.375124367909;11601.651950441501;11798.351090690094;11879.940600296943;11709.590164344207;11720.120990925545;11781.823272650745;11813.940930295637;12189.878101218874;7397.260273972775;7840.647170877211;7913.841723165389;7933.960330198543;7998.3201427879285;10493.317934334244;11303.491342889425;11672.591459298883;11763;11914 19:30:30 INFO - PROCESS | 7084 | |3;mootools.html;1440.5966329427758;1559.6023014131395;1833.798282188959;1932.2657390191725;1993.561416488372;6910.930890691092;7781.533108013523;8203.712870049541;8262.33901287897;8625.870611940825;8718.651253949834;9147.496887671176;9169.679061232842;9230.907690923088;9286.767830804234;2438.5488684593406;2446.9632955505635;2447.1434997750735;2485.378655336166;2485.6644353012384;2398.784109430151;2439.9878000609974;2466.5436894174545;2476.566600844854;2476.702795664523;2452.3378687754293;2455.435249892526;2459.7417271186537;2462.655228268044;2476.4675594747127;2377.2274010946426;2398.0887262840097;2408.50625621748;2413.4207790130245;2432.440538676097;2373.537160253751;2391.677123588328;2397.9040838366445;2400.135951057618;2403.1228601560306;7818.8827167592535;9061.411008284505;9118.224950879117;9206.217471514929;9325.720228393158;5410.3507579090365;5520.1167813150105;5584.6090773645865;5587.804426845041;5591.3569939457075;3250.333681595267;3551.6093229744706;3681.1901381695984;3723.962760372389;3733.3093377724936;1102.5810192127021;1120.5517792882831;1122.5453691255054;1150.8791576884473;1152.6081132414936;12144.3320617366;12209.816852747126;12232.510699572007;12245.387730613435;12249.265044097383;4793.9280910786365;4805.711657300573;4855.830045948375;4966.329545511382;5001;10229.7442563935;10303.845442318372;10403.947980260202;10409.42748148859;10427.009434103747;5455.781768729206;5558.916616250759;5567.164925261243;5582.720863956786;5604.271444712243;4555.157295900269;4731.52684731531;4912.6561140719805;5076.289319495274;5086.287919691246;3793.165503589206;3916.1776027034643;4119.299719047769;4226.873193804191;4233.745975241495;1320.9603711888658;1328.0902581731546;1329.1227789658778;1330.7737684593642;1338.0432990411707;773.5861314196877;913.3332667153015;927.2211342472356;929.7515524862115;954.9331546791797;5899.882002359929;5946.108083787466;6148.323684394713;6159.23009623797;6164.630122192682;444.957729015743;446.6359916667905;451.36808468144204;452.66050462153385;459.3087403457775;3955.4066889966734;3969.2656858480696;3994.7003974702016;4055.168690418457;4059.4316795648633;8660;11064.336139831476;11273.154513411528;11280.210385272952;11360.659180224606;10950.288231264942;11144.387058711687;11154.498047587878;11236.662900112846;11307.208495405243;7119.430445564342;8412.663493460193;8540.786480338042;8578.356623253281;8671.609777560025;5652.943470565242;5842.824715258549;5974.551908606785;6076.787312444043;6166.167567378347;9237.937637171543;9667.70996870095;10389.220808439548;10428.53071611764;10473.005064518858;8543.700970466003;8595.742127736177;10581.259311848406;10667.733306667085;10768.19238557127;7019.438444924292;7298.014768006251;7590.316871481593;7834.334081603128;7844.84310313802;7766.184550622103;8277.917220827714;8722.738317850475;8788.16512431318;8904.910950890408;7352.860306652477;7777;7906.881396778937;7959.92040079615;8004.919950800418;7088.255733147946;7780.572068536285;7783.066032076187;7787.338076263581;7794.844103117793;5962.821115366546;7012.123484564429;7012.894806577803;7117;7139.643017848983;4923.975380123076;5033.723145227048;5117.30916326306;5121.924395876758;5326.680399176062;5068.518490743373;5112.309838171948;5316.521513063843;5353.652012619167;5403.918941215964 19:30:30 INFO - PROCESS | 7084 | |4;prototype.html;264.5185761913318;311.36636943819326;313.6095561026522;320.63127403486004;322.42930013875457;5184.963007398516;5230.058589453897;5589.965856316584;5727.770889164429;5728.255326807509;4684.789184486698;5490.725463726818;5514.889702205954;5579.69311687857;5600.96382169298;3300.6534313897055;4034.9394759078637;4085.2442298174783;4119.546849846514;4129.41017708183;4079.673626109919;4195.937060944088;4235.74585524868;4251.574842515754;4304.892377690567;3250.236194494292;3919.196564704229;4020.2160578687167;4243.893902652428;4248.514618947919;3505.4216054351;4100.138970816132;4137.9861933826405;4244.307442629105;4274.829006839738;3026.789284286281;3680.411134218512;3683.465897444882;3703.2223233121076;3711.6473934976134;4506.752128632924;5417.729113544307;5458.181272809071;5478.315210598676;5480.698561579112;4627.81183029359;4810.302506136625;4899.877503062452;4915.950840491585;4935.90128197434;5871.823845284648;5875;5891.587588868781;5914.8891520393345;5949.702514874282;4037.9097643636346;4040.959590404117;4069.97965010176;4070.247004304213;4073.348264277731;5971.820845374646;6098.817035488898;6164;6167.744256463026;6214.65819379934;3426.794392336468;3532.1346270163463;3777.6033516480925;4083.2650122977557;4089.977505623594;3218.855151518187;3499.705109109646;3678.172411207457;4126.8761937141935;4208.431861698693;4148.211839750437;4903.705777653352;4906.509349065065;4919.532644398776;4942.851714448572;4654.697444666086;5766.769329226784;5881.206232099251;6007.425581778834;6099.84750381244;1278.2075113429732;1298.8441387033427;1330.0024981264053;1418;1429.3853642933639;806.6128258435866;832.7501749475133;844.7465760271893;870.7823044238941;908.5502676175336;4635.605973492224;5367.382750983609;5442.591805614595;5555.416681248492;5638.323401191801;5241;5356.678599283978;6041.8489537761025;6049.576529642883;6134.650376917071;4918.606511479073;5330.546903513245;5431.4840090191365;5600.299962504687;5632.295963004624;2687.9596806047925;2822.294426393402;3165.4776961801504;3200.2718531992928;3218.7746857720203;5052.646314758005;5531.751071201806;6022.457978781843;6287.056941458726;6404;5884.823455296348;6104.20645316106;6140.969295153495;6142.262928448615;6211.9689401552705;5797.6375551745305;5797.94173068563;6107.755689772448;6296.811095667137;6397.808065758035;4906.994066216345;5053.418856831511;5289.788408463618;5404.703001224542;6031.487323577545;5422.6985523473295;5550.5282051026115;5721.8569535761935;5951.91072133927;5956.344802071682;4956.3804524434445;5485.845638757651;5681.778417640227;5817.981853175762;6074.7266373012435;3312.4431517186886;3413.4709120086427;3462.099854037918;4059.91880162401;4068.7355321903983;4506.752128632957;5738.598298119092;5750.884982300414;5814.622049566765;6025.644230048204;5506.559475242051;5519.724013799214;5823.223916705276;5856.4143585641095;5910.408959104056;4982.800687972585;5435.701036443033;5672.801451949162;5973.790917318047;5987.491063259497;5169.741512924414;5851.507865494272;5867.559933005127;5874.412558744091;5909.674967876808;4707.105649926503;5268;5273.920891186559;5633.549316054624;5687.971560142173;5798.594098413239;5813.447722466359;5827.601375669724;5847;5901.852453688693 19:30:30 INFO - PROCESS | 7084 | |5;yui.html;716.1299021688644;765.2882818978355;799.1528979281961;802.4583406200813;804.6901942752039;15994.040357578539;16625.168741562902;16631.750523742125;16633.085180315076;16681.74977375339;14868.776968345483;14988.550343489685;14991.92504037481;14997;15000.624984375396;717.7954283029337;749.2058418076829;875;882.9293656507496;905.8595917632745;849.4945507423073;877.2893955895745;878.4729162502512;879.5909901895617;882.74400423877;894.0523045571682;895.5925054100369;954.374884450686;958.4345236310576;959.932804703671;909.8180363927241;948.2224575847807;949.0082863407755;949.6533765175731;953.2278854128178;659.2649196146263;692.197051420355;698.3854208296717;700.8843540815759;707.4552594502256;14730.484433044792;14825.258737063212;15307.387704491806;15357.078575285519;15359.308831102515;15120.924395378062;15336.769948450783;15368.30842612074;15476.922615386964;15479.14864682442;11519.884801151966;11601.013913817336;11875.049996000385;12161.148719589632;12673.556425525063;4690.179218636725;4715.740634265114;4761.928571071437;4780.37855078841;4830.541098595628;98628;101828.98171018269;103150;118686.40656796747;118971;11630.592929247436;11767.470463829148;11775.52897884092;11816.940915295541;11831.940840295743;18446.90776546109;22331.66502502464;22560.323190304316;22760.20339288117;22768.886155569115;6702.564333318416;8392.244697977212;8396.824444577764;8532.53071081084;8577.699780507777;3960.168364643457;4541.613962813131;4571.314302854532;4661.067786442725;4690.319903613957;3689.5019172411917;3792.981035094807;3842.1355195080882;3847.3459511883048;3848.365019771706;694.624902552626;696.2028477393357;702.3889216381679;703.6165289917008;711.4486273138256;630.2279707358541;630.6846576711645;690.2028157478121;690.4821383962028;690.6167077272162;9405;10504.789904201873;10531.947340263403;10589.364638121737;10878.891211087788;637.1653134393958;653.2911790707136;677.617146312332;702.2626242445514;715.588536591462;4639.582437580634;4746.691465054761;4820.975895120502;4842.443119041355;4843.321934929113;101329;130790;156413.2179339119;159707.40292596925;160768;112150;129018;138012;142702.572974271;143961;76867.8469822953;109806.45096774625;112639;114294.42852785849;115736;8959.910400895908;9527.38072025316;9801.43557388012;9917.404955702392;10024.398536087858;62119.6894015527;66991.66504167448;67611.32388676248;68572.657136714;69316.30683693099;90140;97340;101822.4908875451;104343.4782826081;105154.47422762837;13529.255890926093;13576.981726370364;13700.314984250947;14001.369938352595;14087.929560352133;15243.466478673194;15492.380304787683;15584.92207538955;15859.841401585836;15865.96871203368;14575.489857854924;14601.050931689406;14723.730755817021;14844.109353438827;14881.404743810126;13575.660608484866;14069.718605628035;14468.493602723855;14578.489752858599;14749.631259218606;11677.591284305008;12703.237805731686;13260.80108798388;14297.28513574338;14386.280685965869;11105.500252488819;11346.716332091433;11411.486483108447;11554.942225289156;12071.698207544881;10756.677299681021;11121.332720036824;11179.441027948733;11216;11238.213325067494 19:30:30 INFO - PROCESS | 7084 | __end_tp_report 19:30:30 INFO - PROCESS | 7084 | __start_cc_report 19:30:30 INFO - PROCESS | 7084 | _x_x_mozilla_cycle_collect,356 19:30:30 INFO - PROCESS | 7084 | __end_cc_report 19:30:30 INFO - PROCESS | 7084 | __startTimestamp1480476630840__endTimestamp 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | ------- Summary: start ------- 19:30:30 INFO - PROCESS | 7084 | Number of tests: 6 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | [#0] dojo.html Cycles:165 Average:5969.22 Median:6194.26 stddev:640.39 (10.3%) stddev-sans-first:613.83 19:30:30 INFO - PROCESS | 7084 | Values: 3560.1 3584.8 3601.5 3612.2 3639.4 6059.4 6117.3 6133.4 6154.4 6155.9 6059.5 6079.7 6087.9 6134.8 6185.4 5451.9 5476.8 5496.3 5557.1 5589.9 5571.4 5573.1 5583.2 5585.5 5608.6 5399.4 5429.5 5542.9 5552.2 5559.8 4929.4 5418.6 5501.1 5516.6 5555.6 5391.1 5492.0 5502.8 5510.7 5530.7 6082.3 6102.5 6118.6 6132.3 6142.3 6267.6 6327.1 6332.3 6333.1 6342.4 6435.3 6464.2 6488.6 6495.5 6529.2 6004.6 6063.7 6076.8 6188.4 6194.3 6415.0 6485.5 6558.7 6581.9 6582.3 5240.4 6306.3 6336.3 6338.9 6339.8 6257.2 6283.7 6463.3 6489.8 6498.3 5487.7 5775.2 6145.8 6186.5 6232.7 5286.4 5791.8 6298.3 6311.4 6325.2 5048.1 5122.1 5175.1 5176.2 5176.4 4563.0 4563.0 4588.2 4590.0 4627.0 6207.0 6239.3 6242.3 6251.0 6252.0 6428.2 6497.3 6498.4 6505.8 6517.6 6128.8 6135.2 6162.0 6190.8 6190.9 5634.6 5695.7 5698.3 5710.6 5746.9 6469.9 6512.4 6736.7 6748.5 6768.0 6326.6 6365.0 6403.0 6477.5 6487.3 6619.3 6665.6 6682.3 6700.8 6708.6 6214.8 6274.2 6369.1 6376.7 6377.7 6279.4 6291.7 6322.9 6346.8 6458.3 6301.4 6304.7 6305.2 6318.5 6318.7 6144.7 6251.2 6253.7 6303.8 6309.5 6085.6 6145.6 6164.1 6207.7 6259.1 6303.5 6313.6 6318.7 6321.3 6346.3 4978.9 5600.0 6268.7 6290.6 6329.4 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | [#1] ext.html Cycles:180 Average:65683.13 Median:3379.08 stddev:146508.88 (4335.8%) stddev-sans-first:146838.09 19:30:30 INFO - PROCESS | 7084 | Values: 482.9 488.9 489.4 521.9 531.5 31572.8 42521.6 42653.0 42752.6 43636.3 33314.7 43715.6 44305.8 44324.1 44477.6 9936.6 10089.8 10120.6 10152.5 10163.2 9916.9 9923.8 9929.6 10025.9 10050.3 10010.8 10039.5 10071.7 10074.6 10099.0 9985.7 9994.9 10048.1 10057.9 10065.6 10027.4 10034.0 10115.1 10164.1 10188.4 41038.2 42233.4 42244.6 42531.8 42644.4 3016.9 3330.7 3362.7 3627.2 3657.3 31439.5 31885.5 32030.5 32115.8 32713.0 3249.2 3287.3 3307.0 3363.6 3391.2 326963.0 328449.0 329942.0 329972.0 331778.0 35693.8 63487.7 64228.7 64342.7 64558.7 35146.8 35210.5 36195.6 36241.0 36459.5 15013.6 15207.4 15501.7 15679.0 15680.0 12990.9 13101.9 13169.2 13187.7 13215.6 7979.2 7995.5 8066.0 8095.8 8164.4 2968.6 3335.9 3349.7 3349.9 3367.0 929.6 951.4 974.6 1004.8 1017.4 26405.6 29626.9 30089.7 30536.4 31375.4 967.9 1063.7 1070.8 1095.4 1271.0 13351.9 15927.7 15967.5 16117.3 16127.4 672927.0 679184.0 680995.0 688281.0 691444.0 56780.0 57237.0 57425.4 57624.7 57636.1 1378.3 1412.4 1425.4 1428.2 1429.0 29766.4 30776.8 30801.0 30925.8 31209.8 49237.5 49650.8 49921.3 50061.0 50114.7 561403.0 563861.0 566733.0 567543.0 568464.0 26528.7 26612.2 26676.5 26761.5 26918.6 46208.0 47262.0 47620.0 47675.8 47740.3 39035.6 39308.4 39340.0 40186.2 40824.6 38622.0 39027.8 40111.6 40214.4 40488.0 37851.4 38739.0 39397.6 39470.8 39611.0 29744.0 32025.8 35105.0 35360.8 35698.3 24158.9 25311.6 26485.9 27028.0 27230.9 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | [#2] jquery.html Cycles:180 Average:36043.84 Median:2348.17 stddev:103830.63 (4421.8%) stddev-sans-first:104087.27 19:30:30 INFO - PROCESS | 7084 | Values: 328.8 377.0 390.6 394.9 412.8 19772.6 21093.2 21707.9 21789.6 21917.3 11968.4 12335.4 12376.8 13000.9 20693.1 4951.7 5623.1 5818.0 5835.4 5835.8 5460.6 5655.6 5682.5 5710.7 5723.1 5711.3 5719.0 5720.8 5722.0 5729.2 5867.6 6229.3 6311.3 6317.9 6324.3 5322.4 5500.3 5591.6 5595.1 5636.8 13650.2 13831.6 16850.7 26637.7 27058.5 2148.8 2256.6 2331.5 2364.8 2384.7 10535.4 10605.6 10651.8 10833.8 10864.7 1985.9 2010.2 2011.5 2014.0 2024.0 132511.3 136613.3 137240.3 137845.0 139893.3 9624.6 11756.6 11992.7 12021.5 12074.9 15430.2 15434.6 15435.8 15461.1 15487.0 8198.6 8669.6 8832.1 9020.4 9029.7 6408.7 8172.6 9017.7 9062.1 9065.4 3919.4 4621.7 4721.2 4739.2 4783.8 1553.9 1786.7 1928.3 2012.4 2013.1 865.0 888.8 897.4 995.7 1007.9 21036.7 21422.6 21440.6 21525.4 21541.4 941.8 969.2 982.7 1025.3 1086.3 9332.9 9676.5 10123.6 11190.7 11376.5 564856.0 627804.0 630365.0 634043.0 636385.0 105220.0 126996.0 128669.0 144666.3 151567.0 869.6 992.7 1012.0 1017.2 1019.8 18890.8 18960.8 19387.1 19473.0 19591.0 53901.0 56589.7 56664.0 57819.0 57997.4 58951.0 78437.0 81742.6 84157.0 84397.0 7329.2 7511.9 7569.0 7596.6 8384.8 10302.9 12956.7 13406.2 13456.8 13542.3 7951.5 9105.6 9743.6 11634.8 11736.6 11221.7 11361.4 11601.7 11798.4 11879.9 11709.6 11720.1 11781.8 11813.9 12189.9 7397.3 7840.6 7913.8 7934.0 7998.3 10493.3 11303.5 11672.6 11763.0 11914.0 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | [#3] mootools.html Cycles:180 Average:5818.63 Median:4918.32 stddev:3278.32 (66.7%) stddev-sans-first:3271.01 19:30:30 INFO - PROCESS | 7084 | Values: 1440.6 1559.6 1833.8 1932.3 1993.6 6910.9 7781.5 8203.7 8262.3 8625.9 8718.7 9147.5 9169.7 9230.9 9286.8 2438.5 2447.0 2447.1 2485.4 2485.7 2398.8 2440.0 2466.5 2476.6 2476.7 2452.3 2455.4 2459.7 2462.7 2476.5 2377.2 2398.1 2408.5 2413.4 2432.4 2373.5 2391.7 2397.9 2400.1 2403.1 7818.9 9061.4 9118.2 9206.2 9325.7 5410.4 5520.1 5584.6 5587.8 5591.4 3250.3 3551.6 3681.2 3724.0 3733.3 1102.6 1120.6 1122.5 1150.9 1152.6 12144.3 12209.8 12232.5 12245.4 12249.3 4793.9 4805.7 4855.8 4966.3 5001.0 10229.7 10303.8 10403.9 10409.4 10427.0 5455.8 5558.9 5567.2 5582.7 5604.3 4555.2 4731.5 4912.7 5076.3 5086.3 3793.2 3916.2 4119.3 4226.9 4233.7 1321.0 1328.1 1329.1 1330.8 1338.0 773.6 913.3 927.2 929.8 954.9 5899.9 5946.1 6148.3 6159.2 6164.6 445.0 446.6 451.4 452.7 459.3 3955.4 3969.3 3994.7 4055.2 4059.4 8660.0 11064.3 11273.2 11280.2 11360.7 10950.3 11144.4 11154.5 11236.7 11307.2 7119.4 8412.7 8540.8 8578.4 8671.6 5652.9 5842.8 5974.6 6076.8 6166.2 9237.9 9667.7 10389.2 10428.5 10473.0 8543.7 8595.7 10581.3 10667.7 10768.2 7019.4 7298.0 7590.3 7834.3 7844.8 7766.2 8277.9 8722.7 8788.2 8904.9 7352.9 7777.0 7906.9 7959.9 8004.9 7088.3 7780.6 7783.1 7787.3 7794.8 5962.8 7012.1 7012.9 7117.0 7139.6 4924.0 5033.7 5117.3 5121.9 5326.7 5068.5 5112.3 5316.5 5353.7 5403.9 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | [#4] prototype.html Cycles:180 Average:4691.10 Median:5362.03 stddev:1479.39 (27.6%) stddev-sans-first:1445.74 19:30:30 INFO - PROCESS | 7084 | Values: 264.5 311.4 313.6 320.6 322.4 5185.0 5230.1 5590.0 5727.8 5728.3 4684.8 5490.7 5514.9 5579.7 5601.0 3300.7 4034.9 4085.2 4119.5 4129.4 4079.7 4195.9 4235.7 4251.6 4304.9 3250.2 3919.2 4020.2 4243.9 4248.5 3505.4 4100.1 4138.0 4244.3 4274.8 3026.8 3680.4 3683.5 3703.2 3711.6 4506.8 5417.7 5458.2 5478.3 5480.7 4627.8 4810.3 4899.9 4916.0 4935.9 5871.8 5875.0 5891.6 5914.9 5949.7 4037.9 4041.0 4070.0 4070.2 4073.3 5971.8 6098.8 6164.0 6167.7 6214.7 3426.8 3532.1 3777.6 4083.3 4090.0 3218.9 3499.7 3678.2 4126.9 4208.4 4148.2 4903.7 4906.5 4919.5 4942.9 4654.7 5766.8 5881.2 6007.4 6099.8 1278.2 1298.8 1330.0 1418.0 1429.4 806.6 832.8 844.7 870.8 908.6 4635.6 5367.4 5442.6 5555.4 5638.3 5241.0 5356.7 6041.8 6049.6 6134.7 4918.6 5330.5 5431.5 5600.3 5632.3 2688.0 2822.3 3165.5 3200.3 3218.8 5052.6 5531.8 6022.5 6287.1 6404.0 5884.8 6104.2 6141.0 6142.3 6212.0 5797.6 5797.9 6107.8 6296.8 6397.8 4907.0 5053.4 5289.8 5404.7 6031.5 5422.7 5550.5 5721.9 5951.9 5956.3 4956.4 5485.8 5681.8 5818.0 6074.7 3312.4 3413.5 3462.1 4059.9 4068.7 4506.8 5738.6 5750.9 5814.6 6025.6 5506.6 5519.7 5823.2 5856.4 5910.4 4982.8 5435.7 5672.8 5973.8 5987.5 5169.7 5851.5 5867.6 5874.4 5909.7 4707.1 5268.0 5273.9 5633.5 5688.0 5798.6 5813.4 5827.6 5847.0 5901.9 19:30:30 INFO - PROCESS | 7084 | 19:30:30 INFO - PROCESS | 7084 | [#5] yui.html Cycles:180 Average:25293.37 Median:17564.33 stddev:39735.58 (226.2%) stddev-sans-first:39804.19 19:30:30 INFO - PROCESS | 7084 | Values: 716.1 765.3 799.2 802.5 804.7 15994.0 16625.2 16631.8 16633.1 16681.7 14868.8 14988.6 14991.9 14997.0 15000.6 717.8 749.2 875.0 882.9 905.9 849.5 877.3 878.5 879.6 882.7 894.1 895.6 954.4 958.4 959.9 909.8 948.2 949.0 949.7 953.2 659.3 692.2 698.4 700.9 707.5 14730.5 14825.3 15307.4 15357.1 15359.3 15120.9 15336.8 15368.3 15476.9 15479.1 11519.9 11601.0 11875.0 12161.1 12673.6 4690.2 4715.7 4761.9 4780.4 4830.5 98628.0 101829.0 103150.0 118686.4 118971.0 11630.6 11767.5 11775.5 11816.9 11831.9 18446.9 22331.7 22560.3 22760.2 22768.9 6702.6 8392.2 8396.8 8532.5 8577.7 3960.2 4541.6 4571.3 4661.1 4690.3 3689.5 3793.0 3842.1 3847.3 3848.4 694.6 696.2 702.4 703.6 711.4 630.2 630.7 690.2 690.5 690.6 9405.0 10504.8 10531.9 10589.4 10878.9 637.2 653.3 677.6 702.3 715.6 4639.6 4746.7 4821.0 4842.4 4843.3 101329.0 130790.0 156413.2 159707.4 160768.0 112150.0 129018.0 138012.0 142702.6 143961.0 76867.8 109806.5 112639.0 114294.4 115736.0 8959.9 9527.4 9801.4 9917.4 10024.4 62119.7 66991.7 67611.3 68572.7 69316.3 90140.0 97340.0 101822.5 104343.5 105154.5 13529.3 13577.0 13700.3 14001.4 14087.9 15243.5 15492.4 15584.9 15859.8 15866.0 14575.5 14601.1 14723.7 14844.1 14881.4 13575.7 14069.7 14468.5 14578.5 14749.6 11677.6 12703.2 13260.8 14297.3 14386.3 11105.5 11346.7 11411.5 11554.9 12071.7 10756.7 11121.3 11179.4 11216.0 11238.2 19:30:30 INFO - PROCESS | 7084 | -------- Summary: end -------- 19:30:30 INFO - PROCESS | 7084 | 19:30:31 INFO - TEST-INFO | 7084: exit 0 19:30:31 INFO - TEST-OK | dromaeo_css | took 1112152ms 19:30:31 INFO - TEST-START | kraken 19:30:31 INFO - operating with platform_type : mac_ 19:30:31 INFO - Initialising browser for kraken test... 19:30:31 INFO - TEST-INFO | started process 7089 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp2zvPID/profile http://localhost:52628/getInfo.html) 19:30:33 INFO - PROCESS | 7089 | __metrics Screen width/height:1600/1200 19:30:33 INFO - PROCESS | 7089 | colorDepth:24 19:30:33 INFO - PROCESS | 7089 | Browser inner width/height: 1024/689 19:30:33 INFO - PROCESS | 7089 | __metrics 19:30:33 ERROR - PROCESS | 7089 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 19:30:34 INFO - TEST-INFO | 7089: exit 0 19:30:34 INFO - Browser initialized. 19:30:34 INFO - Running cycle 1/1 for kraken test... 19:30:34 INFO - TEST-INFO | started process 7092 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp2zvPID/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:46 INFO - PROCESS | 7092 | RSS: Main: 174665728 19:30:46 INFO - PROCESS | 7092 | 19:30:49 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:50 INFO - PROCESS | 7092 | RSS: Main: 187039744 19:30:50 INFO - PROCESS | 7092 | 19:30:52 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-dft) 19:30:53 INFO - PROCESS | 7092 | RSS: Main: 194596864 19:30:53 INFO - PROCESS | 7092 | 19:30:56 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-fft) 19:30:57 INFO - PROCESS | 7092 | RSS: Main: 198262784 19:30:57 INFO - PROCESS | 7092 | 19:30:59 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-oscillator) 19:31:00 INFO - PROCESS | 7092 | RSS: Main: 199630848 19:31:00 INFO - PROCESS | 7092 | 19:31:02 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52628/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:02 INFO - PROCESS | 7092 | RSS: Main: 199712768 19:31:02 INFO - PROCESS | 7092 | 19:31:05 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52628/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:06 INFO - PROCESS | 7092 | RSS: Main: 200613888 19:31:06 INFO - PROCESS | 7092 | 19:31:09 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52628/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:10 INFO - PROCESS | 7092 | RSS: Main: 200876032 19:31:10 INFO - PROCESS | 7092 | 19:31:13 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52628/tests/kraken/driver.html?testName=json-parse-financial) 19:31:13 INFO - PROCESS | 7092 | RSS: Main: 201093120 19:31:13 INFO - PROCESS | 7092 | 19:31:15 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52628/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:16 INFO - PROCESS | 7092 | RSS: Main: 200970240 19:31:16 INFO - PROCESS | 7092 | 19:31:17 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:18 INFO - PROCESS | 7092 | RSS: Main: 200974336 19:31:18 INFO - PROCESS | 7092 | 19:31:20 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:21 INFO - PROCESS | 7092 | RSS: Main: 201023488 19:31:21 INFO - PROCESS | 7092 | 19:31:24 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:24 INFO - PROCESS | 7092 | RSS: Main: 201428992 19:31:24 INFO - PROCESS | 7092 | 19:31:27 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:28 INFO - PROCESS | 7092 | RSS: Main: 201416704 19:31:28 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52628/tests/kraken/driver.html?testName=ai-astar) 19:31:30 INFO - PROCESS | 7092 | RSS: Main: 202727424 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | __start_tp_report 19:31:30 INFO - PROCESS | 7092 | _x_x_mozilla_page_load 19:31:30 INFO - PROCESS | 7092 | _x_x_mozilla_page_load_details 19:31:30 INFO - PROCESS | 7092 | |i|pagename|runs| 19:31:30 INFO - PROCESS | 7092 | |0;ai-astar;138;170;95;171;172;172;115;114;116;117 19:31:30 INFO - PROCESS | 7092 | |1;audio-beat-detection;145;107;105;155;96;113;114;99;116;128 19:31:30 INFO - PROCESS | 7092 | |2;audio-dft;247;278;206;199;195;202;196;202;226;180 19:31:30 INFO - PROCESS | 7092 | |3;audio-fft;84;57;58;89;71;52;83;81;66;74 19:31:30 INFO - PROCESS | 7092 | |4;audio-oscillator;88;69;75;92;57;67;105;98;102;71 19:31:30 INFO - PROCESS | 7092 | |5;imaging-gaussian-blur;132;133;89;90;127;96;96;130;89;90 19:31:30 INFO - PROCESS | 7092 | |6;imaging-darkroom;92;151;107;155;152;103;152;153;107;152 19:31:30 INFO - PROCESS | 7092 | |7;imaging-desaturate;92;81;79;137;150;148;94;93;92;96 19:31:30 INFO - PROCESS | 7092 | |8;json-parse-financial;53;55;55;54;57;65;53;58;68;58 19:31:30 INFO - PROCESS | 7092 | |9;json-stringify-tinderbox;67;73;66;75;70;72;66;67;68;68 19:31:30 INFO - PROCESS | 7092 | |10;stanford-crypto-aes;83;80;87;88;85;88;89;96;74;71 19:31:30 INFO - PROCESS | 7092 | |11;stanford-crypto-ccm;138;136;150;145;152;146;139;138;165;146 19:31:30 INFO - PROCESS | 7092 | |12;stanford-crypto-pbkdf2;162;166;165;161;165;165;162;168;163;165 19:31:30 INFO - PROCESS | 7092 | |13;stanford-crypto-sha256-iterative;68;66;67;67;68;66;64;65;76;85 19:31:30 INFO - PROCESS | 7092 | __end_tp_report 19:31:30 INFO - PROCESS | 7092 | __start_cc_report 19:31:30 INFO - PROCESS | 7092 | _x_x_mozilla_cycle_collect,937 19:31:30 INFO - PROCESS | 7092 | __end_cc_report 19:31:30 INFO - PROCESS | 7092 | __startTimestamp1480476690261__endTimestamp 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | ------- Summary: start ------- 19:31:30 INFO - PROCESS | 7092 | Number of tests: 14 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#0] ai-astar Cycles:10 Average:138.00 Median:170.50 stddev:30.38 (17.8%) stddev-sans-first:32.22 19:31:30 INFO - PROCESS | 7092 | Values: 138.0 170.0 95.0 171.0 172.0 172.0 115.0 114.0 116.0 117.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:136.50 stddev:19.37 (14.2%) stddev-sans-first:17.87 19:31:30 INFO - PROCESS | 7092 | Values: 145.0 107.0 105.0 155.0 96.0 113.0 114.0 99.0 116.0 128.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#2] audio-dft Cycles:10 Average:213.10 Median:204.00 stddev:29.32 (14.4%) stddev-sans-first:28.42 19:31:30 INFO - PROCESS | 7092 | Values: 247.0 278.0 206.0 199.0 195.0 202.0 196.0 202.0 226.0 180.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#3] audio-fft Cycles:10 Average:71.50 Median:77.50 stddev:12.89 (16.6%) stddev-sans-first:12.85 19:31:30 INFO - PROCESS | 7092 | Values: 84.0 57.0 58.0 89.0 71.0 52.0 83.0 81.0 66.0 74.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:73.00 stddev:16.69 (22.9%) stddev-sans-first:17.58 19:31:30 INFO - PROCESS | 7092 | Values: 88.0 69.0 75.0 92.0 57.0 67.0 105.0 98.0 102.0 71.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#5] imaging-gaussian-blur Cycles:10 Average:107.20 Median:89.50 stddev:20.27 (22.6%) stddev-sans-first:19.41 19:31:30 INFO - PROCESS | 7092 | Values: 132.0 133.0 89.0 90.0 127.0 96.0 96.0 130.0 89.0 90.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#6] imaging-darkroom Cycles:10 Average:132.40 Median:152.00 stddev:26.29 (17.3%) stddev-sans-first:23.47 19:31:30 INFO - PROCESS | 7092 | Values: 92.0 151.0 107.0 155.0 152.0 103.0 152.0 153.0 107.0 152.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#7] imaging-desaturate Cycles:10 Average:106.20 Median:92.00 stddev:27.53 (29.9%) stddev-sans-first:28.71 19:31:30 INFO - PROCESS | 7092 | Values: 92.0 81.0 79.0 137.0 150.0 148.0 94.0 93.0 92.0 96.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:5.08 (8.8%) stddev-sans-first:5.11 19:31:30 INFO - PROCESS | 7092 | Values: 53.0 55.0 55.0 54.0 57.0 65.0 53.0 58.0 68.0 58.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:3.16 (4.6%) stddev-sans-first:3.24 19:31:30 INFO - PROCESS | 7092 | Values: 67.0 73.0 66.0 75.0 70.0 72.0 66.0 67.0 68.0 68.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:87.50 stddev:7.43 (8.5%) stddev-sans-first:7.87 19:31:30 INFO - PROCESS | 7092 | Values: 83.0 80.0 87.0 88.0 85.0 88.0 89.0 96.0 74.0 71.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:146.00 stddev:8.75 (6.0%) stddev-sans-first:8.85 19:31:30 INFO - PROCESS | 7092 | Values: 138.0 136.0 150.0 145.0 152.0 146.0 139.0 138.0 165.0 146.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:165.00 stddev:2.15 (1.3%) stddev-sans-first:2.13 19:31:30 INFO - PROCESS | 7092 | Values: 162.0 166.0 165.0 161.0 165.0 165.0 162.0 168.0 163.0 165.0 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - PROCESS | 7092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:67.50 stddev:6.44 (9.5%) stddev-sans-first:6.82 19:31:30 INFO - PROCESS | 7092 | Values: 68.0 66.0 67.0 67.0 68.0 66.0 64.0 65.0 76.0 85.0 19:31:30 INFO - PROCESS | 7092 | -------- Summary: end -------- 19:31:30 INFO - PROCESS | 7092 | 19:31:30 INFO - TEST-INFO | 7092: exit 0 19:31:31 INFO - TEST-OK | kraken | took 59597ms 19:31:31 INFO - SUITE-END | took 1171s 19:31:31 INFO - Completed test suite (00:19:32) 19:31:31 INFO - javascript benchmark 19:31:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7433.538320937715, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3560.1455650643843, 3584.820758962053, 3601.4777857210706, 3612.241429299847, 3639.3631114554946, 6059.394060593939, 6117.265928088625, 6133.417325354096, 6154.446099851024, 6155.938440615592, 6059.515238780898, 6079.696015199244, 6087.908681369783, 6134.815955521331, 6185.41238582334, 5451.890962180764, 5476.835694929158, 5496.258005169291, 5557.138643510242, 5589.916151257714, 5571.387147413801, 5573.108302671573, 5583.162525621169, 5585.525230355424, 5608.635438696471, 5399.352077750676, 5429.538489228401, 5542.861428464301, 5552.222688823568, 5559.77760889566, 4929.359183306147, 5418.647787893774, 5501.119820828668, 5516.558675305966, 5555.638883472561, 5391.083515802323, 5492.011437941169, 5502.779888804443, 5510.669359838423, 5530.723463826833, 6082.330943596201, 6102.489251635852, 6118.558266176196, 6132.264128304588, 6142.314611233269, 6267.592606480564, 6327.082573026885, 6332.271788744308, 6333.145025421555, 6342.39747224013, 6435.292117867031, 6464.159659244268, 6488.610683359014, 6495.512836537278, 6529.249136349285, 6004.639721616717, 6063.666498342545, 6076.848078797977, 6188.350223226586, 6194.25668919728, 6415.0, 6485.54601177913, 6558.672066396756, 6581.868362632817, 6582.275949645536, 5240.4497527759795, 6306.3378345274, 6336.334684858116, 6338.936610633835, 6339.809805705836, 6257.217847769029, 6283.717232724538, 6463.321351258144, 6489.805305840832, 6498.317676643885, 5487.710388058803, 5775.249217601685, 6145.754169833246, 6186.4741496973265, 6232.688365581794, 5286.418493965661, 5791.768329266866, 6298.338674439209, 6311.431971122621, 6325.209348831396, 5048.116579598555, 5122.052420302256, 5175.14610089331, 5176.223566464985, 5176.378834539879, 4563.0, 4563.0, 4588.151192029485, 4590.036092420562, 4626.976865115653, 6207.037909124093, 6239.313675495692, 6242.250929888442, 6251.0, 6251.9684252098805, 6428.19647544057, 6497.317781632955, 6498.3826536478955, 6505.772297969548, 6517.608943463408, 6128.778133445034, 6135.171422439398, 6162.014077747539, 6190.845228869224, 6190.938090619036, 5634.605577609528, 5695.743691533891, 5698.344690360579, 5710.5717071219, 5746.942530574641, 6469.935300647122, 6512.381323774234, 6736.730530778714, 6748.493862960199, 6767.966160169168, 6326.620402775849, 6365.013422919455, 6402.967985160044, 6477.51418643613, 6487.3188315226225, 6619.304972977768, 6665.600063996176, 6682.298358672269, 6700.83247918806, 6708.563943343667, 6214.782482613087, 6274.247090349188, 6369.076483909715, 6376.681165941777, 6377.681115944277, 6279.403456671609, 6291.653959032297, 6322.905156422566, 6346.777862774781, 6458.289588145394, 6301.4328710416285, 6304.747810087545, 6305.180326557518, 6318.494520438446, 6318.747250110128, 6144.662043587646, 6251.156093927261, 6253.6560489173535, 6303.842403939938, 6309.463695585927, 6085.604435711664, 6145.569810113428, 6164.116606537852, 6207.689615519296, 6259.12372267892, 6303.46420554258, 6313.621182729051, 6318.715657795318, 6321.273053598895, 6346.301906790157, 4978.8755281118265, 5600.0, 6268.6552239625435, 6290.559660823698, 6329.367063293634], "value": 5931.101260158774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.9279000618628, 488.90955173292923, 489.4469249747784, 521.8831700161653, 531.463222145633, 31572.842135789317, 42521.574784252145, 42653.0, 42752.57247427525, 43636.345454818205, 33314.66685333146, 43715.56284437155, 44305.77847110768, 44324.113517729624, 44477.555224447744, 9936.602535898555, 10089.798204035915, 10120.595176192981, 10152.492375381202, 10163.237757168205, 9916.900830991706, 9923.801523969552, 9929.602815887356, 10025.949870250675, 10050.296479246455, 10010.84983725241, 10039.548220330065, 10071.748206294864, 10074.647387341445, 10099.0, 9985.700428987142, 9994.900050999506, 10048.145907597864, 10057.899421005843, 10065.647702330456, 10027.448490333029, 10034.046765557261, 10115.140213081897, 10164.085232329053, 10188.439635820027, 41038.1792364154, 42233.36649950253, 42244.57755422437, 42531.7873410631, 42644.360334595, 3016.909492715222, 3330.6669333066743, 3362.714169295613, 3627.1838836261895, 3657.2868290683327, 31439.528407073685, 31885.521717174262, 32030.519542206886, 32115.839420802746, 32713.0, 3249.203945033482, 3287.309664970359, 3306.991367632871, 3363.630000699921, 3391.1861153323025, 326963.0, 328449.0, 329942.0, 329972.0, 331778.0, 35693.82153089218, 63487.682561586895, 64228.67885660542, 64342.678286608265, 64558.67720661367, 35146.76986305518, 35210.47184292186, 36195.63804361975, 36241.0, 36459.4531082034, 15013.624659383602, 15207.391704331923, 15501.689966200613, 15679.0, 15679.980801247882, 12990.870091298966, 13101.934490327487, 13169.209847409185, 13187.670308242179, 13215.60353189406, 7979.241972012649, 7995.520268783892, 8065.959670201729, 8095.757127286073, 8164.428490005761, 2968.6289213848268, 3335.93328133436, 3349.681780230923, 3349.866005359807, 3366.966330336665, 929.5816882402946, 951.4053716427233, 974.6150270643199, 1004.7889943111882, 1017.389566260238, 26405.603915941276, 29626.851865740966, 30089.69910300869, 30536.419537069618, 31375.37249255002, 967.9419234845932, 1063.6755789484282, 1070.7537266428765, 1095.4030053620795, 1270.9537644392522, 13351.866481335257, 15927.681446371007, 15967.520974370787, 16117.274722637509, 16127.435539756052, 672927.0, 679184.0, 680995.0, 688281.0, 691444.0, 56780.0, 57237.0, 57425.42574574201, 57624.711876441186, 57636.135457968165, 1378.3383975691725, 1412.4491448335157, 1425.4298280687808, 1428.1502506008908, 1428.9714205716036, 29766.362850042588, 30776.846115769276, 30801.0, 30925.845370773, 31209.8439507801, 49237.507624923295, 49650.75174624248, 49921.251181233034, 50061.0, 50114.74942625264, 561403.0, 563861.0, 566733.0, 567543.0, 568464.0, 26528.734712652626, 26612.201633951012, 26676.466470670865, 26761.464770704868, 26918.59622105631, 46208.0, 47262.0, 47620.0, 47675.761621191676, 47740.2838957409, 39035.6096439032, 39308.41037384384, 39340.0, 40186.1962760749, 40824.59175408327, 38622.0, 39027.80486097551, 40111.59888401079, 40214.39678404885, 40487.98780030405, 37851.432228517144, 38739.03152421212, 39397.60602393939, 39470.81587552378, 39611.0, 29744.0, 32025.839870800497, 35105.0, 35360.823195884885, 35698.28603427865, 24158.87920560386, 25311.620325695498, 26485.867570662023, 27028.0, 27230.863845680644], "value": 18835.38927190259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.77478926935066, 376.992460150797, 390.6308538431182, 394.9427333036708, 412.79154027216254, 19772.60454790903, 21093.15627374903, 21707.891460542716, 21789.564208715816, 21917.342479725612, 11968.401579921012, 12335.383230838444, 12376.752464950696, 13000.934995325033, 20693.068811903464, 4951.702897826124, 5623.128415095667, 5817.981853175698, 5835.4456326649115, 5835.766569337221, 5460.563154947595, 5655.604107712462, 5682.51698605619, 5710.7430165642645, 5723.084306510959, 5711.286089238845, 5719.0, 5720.7711691532495, 5721.970045391828, 5729.226554415142, 5867.647941123546, 6229.283632382266, 6311.274203466614, 6317.93682063178, 6324.272708638519, 5322.361316641989, 5500.257465242181, 5591.6365436246515, 5595.076812325961, 5636.774529018834, 13650.249236292, 13831.585052448443, 16850.747238791428, 26637.733622663913, 27058.45883082347, 2148.79586439288, 2256.5825322315422, 2331.5336932613545, 2364.7989920856576, 2384.678068460753, 10535.42055186972, 10605.628802991858, 10651.786964260671, 10833.783324333548, 10864.728381790519, 1985.8709183903, 2010.155734591475, 2011.4770159758423, 2013.9798602013939, 2024.0, 132511.33744331312, 136613.31693341568, 137240.31379843137, 137844.999999999, 139893.3005334967, 9624.566894489624, 11756.58851940178, 11992.700182495333, 12021.459034343476, 12074.87925120755, 15430.22848857575, 15434.614134646723, 15435.842311826658, 15461.14963676986, 15486.993345432511, 8198.590070496452, 8669.609867555975, 8832.072632373509, 9020.42142625038, 9029.729108126767, 6408.67956602168, 8172.550509722022, 9017.729468115967, 9062.093790620886, 9065.365424420228, 3919.392494163409, 4621.745803980746, 4721.181990894737, 4739.175417464232, 4783.784729687172, 1553.8601525862728, 1786.7230579260236, 1928.305809908432, 2012.3638034175278, 2013.1343522285558, 864.9922839891582, 888.7955770172896, 897.3987428422972, 995.7361299255703, 1007.8538611901233, 21036.68596454389, 21422.57154856894, 21440.57118857614, 21525.354239372842, 21541.353759387242, 941.7598512379436, 969.2149359019076, 982.7346616413529, 1025.3027941000191, 1086.3373342261214, 9332.860007099764, 9676.467794271382, 10123.64567240143, 11190.720231994103, 11376.54493820238, 564856.0, 627804.0, 630365.0, 634043.0, 636385.0, 105220.0, 126996.0, 128669.0, 144666.27725273606, 151567.0, 869.6434461870602, 992.6724181020246, 1011.9747006324901, 1017.2370721958531, 1019.8368261078192, 18890.811091888907, 18960.810391896455, 19387.127579258686, 19473.0, 19591.02044897778, 53901.0, 56589.71705141448, 56664.0, 57819.0, 57997.42002580089, 58951.0, 78437.0, 81742.59128704318, 84157.0, 84397.0, 7329.157146928172, 7511.924880751122, 7569.0, 7596.5946299934685, 8384.790380240298, 10302.948485257526, 12956.67608309762, 13406.195628262336, 13456.798148027983, 13542.322883855964, 7951.483153594998, 9105.635774568944, 9743.561539730586, 11634.76730465403, 11736.589219377282, 11221.66335009951, 11361.375124367909, 11601.651950441501, 11798.351090690094, 11879.940600296943, 11709.590164344207, 11720.120990925545, 11781.823272650745, 11813.940930295637, 12189.878101218874, 7397.260273972775, 7840.647170877211, 7913.841723165389, 7933.960330198543, 7998.3201427879285, 10493.317934334244, 11303.491342889425, 11672.591459298883, 11763.0, 11914.0], "value": 9525.187309020446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.5966329427758, 1559.6023014131395, 1833.798282188959, 1932.2657390191725, 1993.561416488372, 6910.930890691092, 7781.533108013523, 8203.712870049541, 8262.33901287897, 8625.870611940825, 8718.651253949834, 9147.496887671176, 9169.679061232842, 9230.907690923088, 9286.767830804234, 2438.5488684593406, 2446.9632955505635, 2447.1434997750735, 2485.378655336166, 2485.6644353012384, 2398.784109430151, 2439.9878000609974, 2466.5436894174545, 2476.566600844854, 2476.702795664523, 2452.3378687754293, 2455.435249892526, 2459.7417271186537, 2462.655228268044, 2476.4675594747127, 2377.2274010946426, 2398.0887262840097, 2408.50625621748, 2413.4207790130245, 2432.440538676097, 2373.537160253751, 2391.677123588328, 2397.9040838366445, 2400.135951057618, 2403.1228601560306, 7818.8827167592535, 9061.411008284505, 9118.224950879117, 9206.217471514929, 9325.720228393158, 5410.3507579090365, 5520.1167813150105, 5584.6090773645865, 5587.804426845041, 5591.3569939457075, 3250.333681595267, 3551.6093229744706, 3681.1901381695984, 3723.962760372389, 3733.3093377724936, 1102.5810192127021, 1120.5517792882831, 1122.5453691255054, 1150.8791576884473, 1152.6081132414936, 12144.3320617366, 12209.816852747126, 12232.510699572007, 12245.387730613435, 12249.265044097383, 4793.9280910786365, 4805.711657300573, 4855.830045948375, 4966.329545511382, 5001.0, 10229.7442563935, 10303.845442318372, 10403.947980260202, 10409.42748148859, 10427.009434103747, 5455.781768729206, 5558.916616250759, 5567.164925261243, 5582.720863956786, 5604.271444712243, 4555.157295900269, 4731.52684731531, 4912.6561140719805, 5076.289319495274, 5086.287919691246, 3793.165503589206, 3916.1776027034643, 4119.299719047769, 4226.873193804191, 4233.745975241495, 1320.9603711888658, 1328.0902581731546, 1329.1227789658778, 1330.7737684593642, 1338.0432990411707, 773.5861314196877, 913.3332667153015, 927.2211342472356, 929.7515524862115, 954.9331546791797, 5899.882002359929, 5946.108083787466, 6148.323684394713, 6159.23009623797, 6164.630122192682, 444.957729015743, 446.6359916667905, 451.36808468144204, 452.66050462153385, 459.3087403457775, 3955.4066889966734, 3969.2656858480696, 3994.7003974702016, 4055.168690418457, 4059.4316795648633, 8660.0, 11064.336139831476, 11273.154513411528, 11280.210385272952, 11360.659180224606, 10950.288231264942, 11144.387058711687, 11154.498047587878, 11236.662900112846, 11307.208495405243, 7119.430445564342, 8412.663493460193, 8540.786480338042, 8578.356623253281, 8671.609777560025, 5652.943470565242, 5842.824715258549, 5974.551908606785, 6076.787312444043, 6166.167567378347, 9237.937637171543, 9667.70996870095, 10389.220808439548, 10428.53071611764, 10473.005064518858, 8543.700970466003, 8595.742127736177, 10581.259311848406, 10667.733306667085, 10768.19238557127, 7019.438444924292, 7298.014768006251, 7590.316871481593, 7834.334081603128, 7844.84310313802, 7766.184550622103, 8277.917220827714, 8722.738317850475, 8788.16512431318, 8904.910950890408, 7352.860306652477, 7777.0, 7906.881396778937, 7959.92040079615, 8004.919950800418, 7088.255733147946, 7780.572068536285, 7783.066032076187, 7787.338076263581, 7794.844103117793, 5962.821115366546, 7012.123484564429, 7012.894806577803, 7117.0, 7139.643017848983, 4923.975380123076, 5033.723145227048, 5117.30916326306, 5121.924395876758, 5326.680399176062, 5068.518490743373, 5112.309838171948, 5316.521513063843, 5353.652012619167, 5403.918941215964], "value": 4610.682419848734, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.5185761913318, 311.36636943819326, 313.6095561026522, 320.63127403486004, 322.42930013875457, 5184.963007398516, 5230.058589453897, 5589.965856316584, 5727.770889164429, 5728.255326807509, 4684.789184486698, 5490.725463726818, 5514.889702205954, 5579.69311687857, 5600.96382169298, 3300.6534313897055, 4034.9394759078637, 4085.2442298174783, 4119.546849846514, 4129.41017708183, 4079.673626109919, 4195.937060944088, 4235.74585524868, 4251.574842515754, 4304.892377690567, 3250.236194494292, 3919.196564704229, 4020.2160578687167, 4243.893902652428, 4248.514618947919, 3505.4216054351, 4100.138970816132, 4137.9861933826405, 4244.307442629105, 4274.829006839738, 3026.789284286281, 3680.411134218512, 3683.465897444882, 3703.2223233121076, 3711.6473934976134, 4506.752128632924, 5417.729113544307, 5458.181272809071, 5478.315210598676, 5480.698561579112, 4627.81183029359, 4810.302506136625, 4899.877503062452, 4915.950840491585, 4935.90128197434, 5871.823845284648, 5875.0, 5891.587588868781, 5914.8891520393345, 5949.702514874282, 4037.9097643636346, 4040.959590404117, 4069.97965010176, 4070.247004304213, 4073.348264277731, 5971.820845374646, 6098.817035488898, 6164.0, 6167.744256463026, 6214.65819379934, 3426.794392336468, 3532.1346270163463, 3777.6033516480925, 4083.2650122977557, 4089.977505623594, 3218.855151518187, 3499.705109109646, 3678.172411207457, 4126.8761937141935, 4208.431861698693, 4148.211839750437, 4903.705777653352, 4906.509349065065, 4919.532644398776, 4942.851714448572, 4654.697444666086, 5766.769329226784, 5881.206232099251, 6007.425581778834, 6099.84750381244, 1278.2075113429732, 1298.8441387033427, 1330.0024981264053, 1418.0, 1429.3853642933639, 806.6128258435866, 832.7501749475133, 844.7465760271893, 870.7823044238941, 908.5502676175336, 4635.605973492224, 5367.382750983609, 5442.591805614595, 5555.416681248492, 5638.323401191801, 5241.0, 5356.678599283978, 6041.8489537761025, 6049.576529642883, 6134.650376917071, 4918.606511479073, 5330.546903513245, 5431.4840090191365, 5600.299962504687, 5632.295963004624, 2687.9596806047925, 2822.294426393402, 3165.4776961801504, 3200.2718531992928, 3218.7746857720203, 5052.646314758005, 5531.751071201806, 6022.457978781843, 6287.056941458726, 6404.0, 5884.823455296348, 6104.20645316106, 6140.969295153495, 6142.262928448615, 6211.9689401552705, 5797.6375551745305, 5797.94173068563, 6107.755689772448, 6296.811095667137, 6397.808065758035, 4906.994066216345, 5053.418856831511, 5289.788408463618, 5404.703001224542, 6031.487323577545, 5422.6985523473295, 5550.5282051026115, 5721.8569535761935, 5951.91072133927, 5956.344802071682, 4956.3804524434445, 5485.845638757651, 5681.778417640227, 5817.981853175762, 6074.7266373012435, 3312.4431517186886, 3413.4709120086427, 3462.099854037918, 4059.91880162401, 4068.7355321903983, 4506.752128632957, 5738.598298119092, 5750.884982300414, 5814.622049566765, 6025.644230048204, 5506.559475242051, 5519.724013799214, 5823.223916705276, 5856.4143585641095, 5910.408959104056, 4982.800687972585, 5435.701036443033, 5672.801451949162, 5973.790917318047, 5987.491063259497, 5169.741512924414, 5851.507865494272, 5867.559933005127, 5874.412558744091, 5909.674967876808, 4707.105649926503, 5268.0, 5273.920891186559, 5633.549316054624, 5687.971560142173, 5798.594098413239, 5813.447722466359, 5827.601375669724, 5847.0, 5901.852453688693], "value": 4212.729641836068, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.1299021688644, 765.2882818978355, 799.1528979281961, 802.4583406200813, 804.6901942752039, 15994.040357578539, 16625.168741562902, 16631.750523742125, 16633.085180315076, 16681.74977375339, 14868.776968345483, 14988.550343489685, 14991.92504037481, 14997.0, 15000.624984375396, 717.7954283029337, 749.2058418076829, 875.0, 882.9293656507496, 905.8595917632745, 849.4945507423073, 877.2893955895745, 878.4729162502512, 879.5909901895617, 882.74400423877, 894.0523045571682, 895.5925054100369, 954.374884450686, 958.4345236310576, 959.932804703671, 909.8180363927241, 948.2224575847807, 949.0082863407755, 949.6533765175731, 953.2278854128178, 659.2649196146263, 692.197051420355, 698.3854208296717, 700.8843540815759, 707.4552594502256, 14730.484433044792, 14825.258737063212, 15307.387704491806, 15357.078575285519, 15359.308831102515, 15120.924395378062, 15336.769948450783, 15368.30842612074, 15476.922615386964, 15479.14864682442, 11519.884801151966, 11601.013913817336, 11875.049996000385, 12161.148719589632, 12673.556425525063, 4690.179218636725, 4715.740634265114, 4761.928571071437, 4780.37855078841, 4830.541098595628, 98628.0, 101828.98171018269, 103150.0, 118686.40656796747, 118971.0, 11630.592929247436, 11767.470463829148, 11775.52897884092, 11816.940915295541, 11831.940840295743, 18446.90776546109, 22331.66502502464, 22560.323190304316, 22760.20339288117, 22768.886155569115, 6702.564333318416, 8392.244697977212, 8396.824444577764, 8532.53071081084, 8577.699780507777, 3960.168364643457, 4541.613962813131, 4571.314302854532, 4661.067786442725, 4690.319903613957, 3689.5019172411917, 3792.981035094807, 3842.1355195080882, 3847.3459511883048, 3848.365019771706, 694.624902552626, 696.2028477393357, 702.3889216381679, 703.6165289917008, 711.4486273138256, 630.2279707358541, 630.6846576711645, 690.2028157478121, 690.4821383962028, 690.6167077272162, 9405.0, 10504.789904201873, 10531.947340263403, 10589.364638121737, 10878.891211087788, 637.1653134393958, 653.2911790707136, 677.617146312332, 702.2626242445514, 715.588536591462, 4639.582437580634, 4746.691465054761, 4820.975895120502, 4842.443119041355, 4843.321934929113, 101329.0, 130790.0, 156413.2179339119, 159707.40292596925, 160768.0, 112150.0, 129018.0, 138012.0, 142702.572974271, 143961.0, 76867.8469822953, 109806.45096774625, 112639.0, 114294.42852785849, 115736.0, 8959.910400895908, 9527.38072025316, 9801.43557388012, 9917.404955702392, 10024.398536087858, 62119.6894015527, 66991.66504167448, 67611.32388676248, 68572.657136714, 69316.30683693099, 90140.0, 97340.0, 101822.4908875451, 104343.4782826081, 105154.47422762837, 13529.255890926093, 13576.981726370364, 13700.314984250947, 14001.369938352595, 14087.929560352133, 15243.466478673194, 15492.380304787683, 15584.92207538955, 15859.841401585836, 15865.96871203368, 14575.489857854924, 14601.050931689406, 14723.730755817021, 14844.109353438827, 14881.404743810126, 13575.660608484866, 14069.718605628035, 14468.493602723855, 14578.489752858599, 14749.631259218606, 11677.591284305008, 12703.237805731686, 13260.80108798388, 14297.28513574338, 14386.280685965869, 11105.500252488819, 11346.716332091433, 11411.486483108447, 11554.942225289156, 12071.698207544881, 10756.677299681021, 11121.332720036824, 11179.441027948733, 11216.0, 11238.213325067494], "value": 8162.429324600496, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 170.0, 95.0, 171.0, 172.0, 172.0, 115.0, 114.0, 116.0, 117.0], "value": 138.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 107.0, 105.0, 155.0, 96.0, 113.0, 114.0, 99.0, 116.0, 128.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [247.0, 278.0, 206.0, 199.0, 195.0, 202.0, 196.0, 202.0, 226.0, 180.0], "value": 213.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 58.0, 89.0, 71.0, 52.0, 83.0, 81.0, 66.0, 74.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 75.0, 92.0, 57.0, 67.0, 105.0, 98.0, 102.0, 71.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 89.0, 90.0, 127.0, 96.0, 96.0, 130.0, 89.0, 90.0], "value": 107.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 151.0, 107.0, 155.0, 152.0, 103.0, 152.0, 153.0, 107.0, 152.0], "value": 132.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 81.0, 79.0, 137.0, 150.0, 148.0, 94.0, 93.0, 92.0, 96.0], "value": 106.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 54.0, 57.0, 65.0, 53.0, 58.0, 68.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 66.0, 75.0, 70.0, 72.0, 66.0, 67.0, 68.0, 68.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 87.0, 88.0, 85.0, 88.0, 89.0, 96.0, 74.0, 71.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 150.0, 145.0, 152.0, 146.0, 139.0, 138.0, 165.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 165.0, 161.0, 165.0, 165.0, 162.0, 168.0, 163.0, 165.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 68.0, 66.0, 64.0, 65.0, 76.0, 85.0], "value": 69.2, "unit": "score"}]}]} 19:31:31 INFO - Return code: 0 19:31:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:31 ERROR - # TBPL SUCCESS # 19:31:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:31:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:31:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:31:31 INFO - 2016-11-29 19:31:31.553 screenresolution[7097:134526] starting screenresolution argv=screenresolution get 19:31:31 INFO - 2016-11-29 19:31:31.556 screenresolution[7097:134526] Display 0: 1600x1200x32@60 19:31:31 INFO - 2016-11-29 19:31:31.562 screenresolution[7098:134529] starting screenresolution argv=screenresolution list 19:31:31 INFO - Available Modes on Display 0 19:31:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:31:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:31:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:31:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:31:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:31:31 INFO - Intel Iris: 19:31:31 INFO - Chipset Model: Intel Iris 19:31:31 INFO - Type: GPU 19:31:31 INFO - Bus: Built-In 19:31:31 INFO - VRAM (Dynamic, Max): 1536 MB 19:31:31 INFO - Vendor: Intel (0x8086) 19:31:31 INFO - Device ID: 0x0a2e 19:31:31 INFO - Revision ID: 0x0009 19:31:31 INFO - Displays: 19:31:31 INFO - Display: 19:31:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:31:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:31:31 INFO - Display Serial Number: 1600x1200 60 19:31:31 INFO - Main Display: Yes 19:31:31 INFO - Mirror: Off 19:31:31 INFO - Online: Yes 19:31:31 INFO - Rotation: Supported 19:31:31 INFO - Return code: 0 19:31:31 INFO - Running post-action listener: _resource_record_post_action 19:31:31 INFO - [mozharness: 2016-11-30 03:31:31.796484Z] Finished run-tests step (success) 19:31:31 INFO - Running post-run listener: _resource_record_post_run 19:31:31 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 0; Write bytes: 495924224; Read time: 0; Write time: 1532 19:31:31 INFO - TinderboxPrint: CPU usage
54.3% 19:31:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:31:31 INFO - TinderboxPrint: I/O write bytes / time
495,924,224 / 1,532 19:31:31 INFO - TinderboxPrint: CPU idle
2,187.1 (45.7%) 19:31:31 INFO - TinderboxPrint: CPU system
975.4 (20.4%) 19:31:31 INFO - TinderboxPrint: CPU user
1,619.3 (33.9%) 19:31:31 INFO - TinderboxPrint: Swap in / out
194,519,040 / 0 19:31:31 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 190054912; Write bytes: 187463680; Read time: 17699; Write time: 381 19:31:31 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 0; Write bytes: 297409536; Read time: 0; Write time: 1111 19:31:32 INFO - Running post-run listener: _upload_blobber_files 19:31:32 INFO - Blob upload gear active. 19:31:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:32 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 19:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:31:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:33 INFO - (blobuploader) - INFO - Done attempting. 19:31:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:31:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:31:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:34 INFO - (blobuploader) - INFO - Done attempting. 19:31:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:37 INFO - (blobuploader) - INFO - Done attempting. 19:31:37 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:37 INFO - Return code: 0 19:31:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e34b2c71883c26aa0311bdf74931f185a643bae71c3ba88cacf38a1292d4c6a3ab83f8afe8a2e8ee912910f85f8c4389b2be25ec08972c7083cb67939b5122e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11fd55c8b10b73c82ea99d7787caaf17257cdeac7e5dc208f3b47927a85eb0bd6fbf15623fda6c1b2acf667a029b58eb2a2ede14b945da385874856a1cdcc0f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a86dd5bc4261b99ef32e2abe4f30c1903f3b5bb7f0879e7afc0d83b6eafd04297e8cc4d2c79ef25f8f364c082d6e8b9c5b31f663ce90fdfce9fd0048d6c5135"} 19:31:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:37 INFO - Contents: 19:31:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e34b2c71883c26aa0311bdf74931f185a643bae71c3ba88cacf38a1292d4c6a3ab83f8afe8a2e8ee912910f85f8c4389b2be25ec08972c7083cb67939b5122e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11fd55c8b10b73c82ea99d7787caaf17257cdeac7e5dc208f3b47927a85eb0bd6fbf15623fda6c1b2acf667a029b58eb2a2ede14b945da385874856a1cdcc0f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a86dd5bc4261b99ef32e2abe4f30c1903f3b5bb7f0879e7afc0d83b6eafd04297e8cc4d2c79ef25f8f364c082d6e8b9c5b31f663ce90fdfce9fd0048d6c5135"} 19:31:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:37 INFO - Copying logs to upload dir... 19:31:37 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.997487 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-29 19:31:37.347229) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 19:31:37.350879) ========= 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.F7y3o4AK0a/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.MSSq5lS8au/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e34b2c71883c26aa0311bdf74931f185a643bae71c3ba88cacf38a1292d4c6a3ab83f8afe8a2e8ee912910f85f8c4389b2be25ec08972c7083cb67939b5122e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11fd55c8b10b73c82ea99d7787caaf17257cdeac7e5dc208f3b47927a85eb0bd6fbf15623fda6c1b2acf667a029b58eb2a2ede14b945da385874856a1cdcc0f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a86dd5bc4261b99ef32e2abe4f30c1903f3b5bb7f0879e7afc0d83b6eafd04297e8cc4d2c79ef25f8f364c082d6e8b9c5b31f663ce90fdfce9fd0048d6c5135"} build_url:https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011583 build_url: 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e34b2c71883c26aa0311bdf74931f185a643bae71c3ba88cacf38a1292d4c6a3ab83f8afe8a2e8ee912910f85f8c4389b2be25ec08972c7083cb67939b5122e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11fd55c8b10b73c82ea99d7787caaf17257cdeac7e5dc208f3b47927a85eb0bd6fbf15623fda6c1b2acf667a029b58eb2a2ede14b945da385874856a1cdcc0f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a86dd5bc4261b99ef32e2abe4f30c1903f3b5bb7f0879e7afc0d83b6eafd04297e8cc4d2c79ef25f8f364c082d6e8b9c5b31f663ce90fdfce9fd0048d6c5135"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 19:31:37.384846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:31:37.385203) ========= 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.F7y3o4AK0a/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.MSSq5lS8au/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005383 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:31:37.434438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 19:31:37.434748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 19:31:37.435076) ========= ========= Total master_lag: 0.26 =========