builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0229 starttime: 1487938012.29 results: success (0) buildid: 20170224024759 builduid: 87a96bc3487e4fcdb17d396f95f18395 revision: be661bae6cb9a53935c5b87744bf68879d9ebcc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.293105) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.293548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.293835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.317940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.318319) ========= 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.vABMHrwrWT/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.C2z6I98P8O/Listeners TMPDIR=/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/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 --2017-02-24 04:06:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.61M=0.002s 2017-02-24 04:06:52 (7.61 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.468633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.468944) ========= 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.vABMHrwrWT/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.C2z6I98P8O/Listeners TMPDIR=/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/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.021485 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:52.517533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-24 04:06:52.517920) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be661bae6cb9a53935c5b87744bf68879d9ebcc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev be661bae6cb9a53935c5b87744bf68879d9ebcc5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vABMHrwrWT/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.C2z6I98P8O/Listeners TMPDIR=/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/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 2017-02-24 04:06:52,609 truncating revision to first 12 chars 2017-02-24 04:06:52,609 Setting DEBUG logging. 2017-02-24 04:06:52,609 attempt 1/10 2017-02-24 04:06:52,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be661bae6cb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 04:06:54,640 unpacking tar archive at: mozilla-central-be661bae6cb9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.283647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-24 04:06:54.825342) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:54.826055) ========= script_repo_revision: be661bae6cb9a53935c5b87744bf68879d9ebcc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:54.826934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:54.827385) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 04:06:54.848093) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-02-24 04:06:54.848659) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vABMHrwrWT/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.C2z6I98P8O/Listeners TMPDIR=/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:06:55 INFO - MultiFileLogger online at 20170224 04:06:55 in /builds/slave/test 04:06:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:06:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:55 INFO - {'append_to_log': False, 04:06:55 INFO - 'base_work_dir': '/builds/slave/test', 04:06:55 INFO - 'blob_upload_branch': 'Firefox', 04:06:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:55 INFO - 'branch': 'Firefox', 04:06:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:55 INFO - 'config_files': ('talos/mac_config.py',), 04:06:55 INFO - 'default_actions': ('clobber', 04:06:55 INFO - 'read-buildbot-config', 04:06:55 INFO - 'download-and-extract', 04:06:55 INFO - 'populate-webroot', 04:06:55 INFO - 'create-virtualenv', 04:06:55 INFO - 'install', 04:06:55 INFO - 'run-tests'), 04:06:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:55 INFO - 'download_minidump_stackwalk': True, 04:06:55 INFO - 'download_symbols': 'ondemand', 04:06:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:55 INFO - 'gecko_profile': False, 04:06:55 INFO - 'gecko_profile_interval': 0, 04:06:55 INFO - 'installer_path': 'installer.exe', 04:06:55 INFO - 'log_level': 'info', 04:06:55 INFO - 'log_name': 'talos', 04:06:55 INFO - 'log_to_console': True, 04:06:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:06:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:06:55 INFO - 'opt_config_files': (), 04:06:55 INFO - 'pip_index': False, 04:06:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:55 INFO - 'cmd': ('bash', 04:06:55 INFO - '-c', 04:06:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:55 INFO - 'enabled': True, 04:06:55 INFO - 'halt_on_failure': False, 04:06:55 INFO - 'name': 'check_screen_resolution'},), 04:06:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:55 INFO - 'cmd': ('bash', 04:06:55 INFO - '-c', 04:06:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:55 INFO - 'enabled': True, 04:06:55 INFO - 'halt_on_failure': False, 04:06:55 INFO - 'name': 'check_screen_resolution'},), 04:06:55 INFO - 'run_cmd_checks_enabled': True, 04:06:55 INFO - 'suite': 'dromaeojs', 04:06:55 INFO - 'system_bits': '32', 04:06:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:55 INFO - 'title': 't-yosemite-r7-0229', 04:06:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:55 INFO - 'use_talos_json': True, 04:06:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:55 INFO - 'work_dir': 'build'} 04:06:55 INFO - [mozharness: 2017-02-24 12:06:55.060683Z] Running clobber step. 04:06:55 INFO - Running pre-action listener: _resource_record_pre_action 04:06:55 INFO - Running main action method: clobber 04:06:55 INFO - rmtree: /builds/slave/test/build 04:06:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:57 INFO - Running post-action listener: _resource_record_post_action 04:06:57 INFO - [mozharness: 2017-02-24 12:06:57.127450Z] Finished clobber step (success) 04:06:57 INFO - [mozharness: 2017-02-24 12:06:57.127616Z] Running read-buildbot-config step. 04:06:57 INFO - Running pre-action listener: _resource_record_pre_action 04:06:57 INFO - Running main action method: read_buildbot_config 04:06:57 INFO - Using buildbot properties: 04:06:57 INFO - { 04:06:57 INFO - "project": "", 04:06:57 INFO - "product": "firefox", 04:06:57 INFO - "script_repo_revision": "production", 04:06:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:06:57 INFO - "repository": "", 04:06:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:06:57 INFO - "buildid": "20170224024759", 04:06:57 INFO - "pgo_build": "False", 04:06:57 INFO - "basedir": "/builds/slave/test", 04:06:57 INFO - "buildnumber": 145, 04:06:57 INFO - "slavename": "t-yosemite-r7-0229", 04:06:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:06:57 INFO - "platform": "yosemite_r7", 04:06:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:06:57 INFO - "branch": "mozilla-central", 04:06:57 INFO - "repo_path": "mozilla-central", 04:06:57 INFO - "revision": "be661bae6cb9a53935c5b87744bf68879d9ebcc5", 04:06:57 INFO - "stage_platform": "macosx64", 04:06:57 INFO - "builduid": "87a96bc3487e4fcdb17d396f95f18395", 04:06:57 INFO - "slavebuilddir": "test" 04:06:57 INFO - } 04:06:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:06:57 INFO - Running post-action listener: _resource_record_post_action 04:06:57 INFO - [mozharness: 2017-02-24 12:06:57.130944Z] Finished read-buildbot-config step (success) 04:06:57 INFO - [mozharness: 2017-02-24 12:06:57.131067Z] Running download-and-extract step. 04:06:57 INFO - Running pre-action listener: _resource_record_pre_action 04:06:57 INFO - Running main action method: download_and_extract 04:06:57 INFO - mkdir: /builds/slave/test/build/tests 04:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:57 INFO - trying https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:06:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:06:58 INFO - Downloaded 1199 bytes. 04:06:58 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:06:58 INFO - Using the following test package requirements: 04:06:58 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:06:58 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:06:58 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:06:58 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'jsshell-mac.zip'], 04:06:58 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:06:58 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:06:58 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:06:58 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:06:58 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:06:58 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:06:58 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:06:58 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:06:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:06:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:06:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:07:00 INFO - Expected file size: 51454689 04:07:00 INFO - Obtained file size: 51454689 04:07:16 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:07:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:07:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:07:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:07:17 INFO - Expected file size: 51454689 04:07:17 INFO - Obtained file size: 51454689 04:07:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:07:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:07:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:07:34 INFO - Expected file size: 14404306 04:07:34 INFO - Obtained file size: 14404306 04:07: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')]} 04:07:34 INFO - trying https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:07:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:07:36 INFO - Downloaded 74942897 bytes. 04:07:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:07:36 INFO - mkdir: /builds/slave/test/properties 04:07:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:07:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:07:36 INFO - Contents: 04:07:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:07:37 INFO - Running post-action listener: _resource_record_post_action 04:07:37 INFO - Running post-action listener: set_extra_try_arguments 04:07:37 INFO - [mozharness: 2017-02-24 12:07:37.306624Z] Finished download-and-extract step (success) 04:07:37 INFO - [mozharness: 2017-02-24 12:07:37.306743Z] Running populate-webroot step. 04:07:37 INFO - Running pre-action listener: _resource_record_pre_action 04:07:37 INFO - Running main action method: populate_webroot 04:07:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:37 INFO - '--tppagecycles', 04:07:37 INFO - '7'], 04:07:37 INFO - 'tests': ['tsvgm']}}, 04:07:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:07:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:07:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:07:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:07:37 INFO - 'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:07:37 INFO - 'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['damp', 'tps']}, 04:07:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:07:37 INFO - 'tests': ['damp', 'tps']}, 04:07:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['dromaeo_dom']}, 04:07:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['basic_compositor_video']}, 04:07:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:07:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['a11yr', 04:07:37 INFO - 'ts_paint', 04:07:37 INFO - 'tpaint', 04:07:37 INFO - 'sessionrestore', 04:07:37 INFO - 'sessionrestore_no_auto_restore', 04:07:37 INFO - 'tabpaint']}, 04:07:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:07:37 INFO - 'ts_paint', 04:07:37 INFO - 'tpaint', 04:07:37 INFO - 'sessionrestore', 04:07:37 INFO - 'sessionrestore_no_auto_restore', 04:07:37 INFO - 'tabpaint']}, 04:07:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:07:37 INFO - 'ts_paint', 04:07:37 INFO - 'tpaint', 04:07:37 INFO - 'sessionrestore', 04:07:37 INFO - 'sessionrestore_no_auto_restore', 04:07:37 INFO - 'tabpaint']}, 04:07:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:07:37 INFO - 'ts_paint', 04:07:37 INFO - 'tpaint', 04:07:37 INFO - 'sessionrestore', 04:07:37 INFO - 'sessionrestore_no_auto_restore', 04:07:37 INFO - 'tabpaint']}, 04:07:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['a11yr', 04:07:37 INFO - 'ts_paint', 04:07:37 INFO - 'tpaint', 04:07:37 INFO - 'sessionrestore', 04:07:37 INFO - 'sessionrestore_no_auto_restore', 04:07:37 INFO - 'tabpaint']}, 04:07:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['a11yr', 04:07:37 INFO - 'ts_paint', 04:07:37 INFO - 'tpaint', 04:07:37 INFO - 'sessionrestore', 04:07:37 INFO - 'sessionrestore_no_auto_restore', 04:07:37 INFO - 'tabpaint']}, 04:07:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['tsvgx', 04:07:37 INFO - 'tsvgr_opacity', 04:07:37 INFO - 'tart', 04:07:37 INFO - 'tscrollx', 04:07:37 INFO - 'cart', 04:07:37 INFO - 'tsvg_static']}, 04:07:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:07:37 INFO - 'tsvgr_opacity', 04:07:37 INFO - 'tart', 04:07:37 INFO - 'tscrollx', 04:07:37 INFO - 'cart', 04:07:37 INFO - 'tsvg_static']}, 04:07:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:07:37 INFO - 'talos_options': ['--disable-e10s'], 04:07:37 INFO - 'tests': ['tp5o']}, 04:07:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:07:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:07:37 INFO - 'talos_options': ['--disable-e10s', 04:07:37 INFO - '--xperf_path', 04:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:37 INFO - 'tests': ['tp5n']}, 04:07:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:07:37 INFO - 'talos_options': ['--xperf_path', 04:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:37 INFO - 'tests': ['tp5n']}}, 04:07:37 INFO - 'talos.zip': {'path': '', 04:07:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:37 INFO - Running post-action listener: _resource_record_post_action 04:07:37 INFO - [mozharness: 2017-02-24 12:07:37.324868Z] Finished populate-webroot step (success) 04:07:37 INFO - [mozharness: 2017-02-24 12:07:37.324997Z] Running create-virtualenv step. 04:07:37 INFO - Running pre-action listener: _resource_record_pre_action 04:07:37 INFO - Running main action method: create_virtualenv 04:07:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:07:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:07:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:37 INFO - Using real prefix '/tools/python27' 04:07:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:41 INFO - Installing pip.................done. 04:07:41 INFO - Return code: 0 04:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:07:41 INFO - Reading from file tmpfile_stdout 04:07:41 INFO - Output received: 04:07:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:07:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:41 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:41 INFO - 'HOME': '/Users/cltbld', 04:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:41 INFO - 'LOGNAME': 'cltbld', 04:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:41 INFO - 'MOZ_NO_REMOTE': '1', 04:07:41 INFO - 'NO_EM_RESTART': '1', 04:07:41 INFO - 'PAGER': '/bin/cat', 04:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:41 INFO - 'PWD': '/builds/slave/test', 04:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:41 INFO - 'SHELL': '/bin/bash', 04:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:07:41 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:41 INFO - 'USER': 'cltbld', 04:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:41 INFO - 'XPC_FLAGS': '0x0', 04:07:41 INFO - 'XPC_SERVICE_NAME': '0', 04:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:07:41 INFO - Cleaning up... 04:07:41 INFO - Return code: 0 04:07:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:41 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:41 INFO - 'HOME': '/Users/cltbld', 04:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:41 INFO - 'LOGNAME': 'cltbld', 04:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:41 INFO - 'MOZ_NO_REMOTE': '1', 04:07:41 INFO - 'NO_EM_RESTART': '1', 04:07:41 INFO - 'PAGER': '/bin/cat', 04:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:41 INFO - 'PWD': '/builds/slave/test', 04:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:41 INFO - 'SHELL': '/bin/bash', 04:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:07:41 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:41 INFO - 'USER': 'cltbld', 04:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:41 INFO - 'XPC_FLAGS': '0x0', 04:07:41 INFO - 'XPC_SERVICE_NAME': '0', 04:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:41 INFO - Downloading/unpacking psutil>=3.1.1 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:45 INFO - Installing collected packages: psutil 04:07:45 INFO - Running setup.py install for psutil 04:07:45 INFO - building 'psutil._psutil_osx' extension 04:07:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:07:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:07:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:07:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:07:45 INFO - building 'psutil._psutil_posix' extension 04:07:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:07:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:07:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:07:45 INFO - ^ 04:07:46 INFO - 1 warning generated. 04:07:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:46 INFO - Successfully installed psutil 04:07:46 INFO - Cleaning up... 04:07:46 INFO - Return code: 0 04:07:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:07:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:07:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:46 INFO - 'HOME': '/Users/cltbld', 04:07:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:46 INFO - 'LOGNAME': 'cltbld', 04:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:46 INFO - 'MOZ_NO_REMOTE': '1', 04:07:46 INFO - 'NO_EM_RESTART': '1', 04:07:46 INFO - 'PAGER': '/bin/cat', 04:07:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:46 INFO - 'PWD': '/builds/slave/test', 04:07:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:46 INFO - 'SHELL': '/bin/bash', 04:07:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:07:46 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:07:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:46 INFO - 'USER': 'cltbld', 04:07:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:46 INFO - 'XPC_FLAGS': '0x0', 04:07:46 INFO - 'XPC_SERVICE_NAME': '0', 04:07:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:07:49 INFO - Installing collected packages: mozsystemmonitor 04:07:49 INFO - Running setup.py install for mozsystemmonitor 04:07:49 INFO - Successfully installed mozsystemmonitor 04:07:49 INFO - Cleaning up... 04:07:49 INFO - Return code: 0 04:07:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:50 INFO - 'HOME': '/Users/cltbld', 04:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:50 INFO - 'LOGNAME': 'cltbld', 04:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:50 INFO - 'MOZ_NO_REMOTE': '1', 04:07:50 INFO - 'NO_EM_RESTART': '1', 04:07:50 INFO - 'PAGER': '/bin/cat', 04:07:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:50 INFO - 'PWD': '/builds/slave/test', 04:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:50 INFO - 'SHELL': '/bin/bash', 04:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:07:50 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:50 INFO - 'USER': 'cltbld', 04:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:50 INFO - 'XPC_FLAGS': '0x0', 04:07:50 INFO - 'XPC_SERVICE_NAME': '0', 04:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:53 INFO - warning: no files found matching '*.txt' 04:07:53 INFO - no previously-included directories found matching 'build' 04:07:53 INFO - no previously-included directories found matching 'dist' 04:07:53 INFO - no previously-included directories found matching '.git*' 04:07:53 INFO - Installing collected packages: jsonschema, functools32 04:07:53 INFO - Running setup.py install for functools32 04:07:53 INFO - warning: no files found matching '*.txt' 04:07:53 INFO - no previously-included directories found matching 'build' 04:07:53 INFO - no previously-included directories found matching 'dist' 04:07:53 INFO - no previously-included directories found matching '.git*' 04:07:53 INFO - Successfully installed jsonschema functools32 04:07:53 INFO - Cleaning up... 04:07:53 INFO - Return code: 0 04:07:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:53 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:07:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:07:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:53 INFO - 'HOME': '/Users/cltbld', 04:07:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:53 INFO - 'LOGNAME': 'cltbld', 04:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:53 INFO - 'MOZ_NO_REMOTE': '1', 04:07:53 INFO - 'NO_EM_RESTART': '1', 04:07:53 INFO - 'PAGER': '/bin/cat', 04:07:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:53 INFO - 'PWD': '/builds/slave/test', 04:07:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:53 INFO - 'SHELL': '/bin/bash', 04:07:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:07:53 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:07:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:53 INFO - 'USER': 'cltbld', 04:07:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:53 INFO - 'XPC_FLAGS': '0x0', 04:07:53 INFO - 'XPC_SERVICE_NAME': '0', 04:07:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:07:54 INFO - Cleaning up... 04:07:54 INFO - Return code: 0 04:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:54 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:54 INFO - 'HOME': '/Users/cltbld', 04:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:54 INFO - 'LOGNAME': 'cltbld', 04:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:54 INFO - 'MOZ_NO_REMOTE': '1', 04:07:54 INFO - 'NO_EM_RESTART': '1', 04:07:54 INFO - 'PAGER': '/bin/cat', 04:07:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:54 INFO - 'PWD': '/builds/slave/test', 04:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:54 INFO - 'SHELL': '/bin/bash', 04:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:07:54 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:54 INFO - 'USER': 'cltbld', 04:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:54 INFO - 'XPC_FLAGS': '0x0', 04:07:54 INFO - 'XPC_SERVICE_NAME': '0', 04:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:58 INFO - Downloading docopt-0.6.1.tar.gz 04:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:58 INFO - Running setup.py install for blobuploader 04:07:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:58 INFO - Running setup.py install for requests 04:07:59 INFO - Running setup.py install for docopt 04:07:59 INFO - Successfully installed blobuploader requests docopt 04:07:59 INFO - Cleaning up... 04:07:59 INFO - Return code: 0 04:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:59 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:59 INFO - 'HOME': '/Users/cltbld', 04:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:59 INFO - 'LOGNAME': 'cltbld', 04:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:59 INFO - 'MOZ_NO_REMOTE': '1', 04:07:59 INFO - 'NO_EM_RESTART': '1', 04:07:59 INFO - 'PAGER': '/bin/cat', 04:07:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:59 INFO - 'PWD': '/builds/slave/test', 04:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:59 INFO - 'SHELL': '/bin/bash', 04:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:07:59 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:59 INFO - 'USER': 'cltbld', 04:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:59 INFO - 'XPC_FLAGS': '0x0', 04:07:59 INFO - 'XPC_SERVICE_NAME': '0', 04:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:59 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-OJe2w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:59 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-2dRujA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:59 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-mYDLX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:59 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-831Cgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:59 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-6t8bjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-PCAF8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-Cg1C5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-QidNXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-bGegiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-Se0p_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-ot_xWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-GfAP2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-xrP4C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:00 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-4B8pDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:01 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-S8y_eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:01 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-SSJ1lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:01 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-qkZ7F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:01 INFO - Running setup.py install for manifestparser 04:08:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:01 INFO - Running setup.py install for mozcrash 04:08:01 INFO - Running setup.py install for mozdebug 04:08:01 INFO - Running setup.py install for mozdevice 04:08:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:01 INFO - Running setup.py install for mozfile 04:08:02 INFO - Running setup.py install for mozhttpd 04:08:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Running setup.py install for mozinfo 04:08:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Running setup.py install for mozInstall 04:08:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Running setup.py install for mozleak 04:08:02 INFO - Running setup.py install for mozlog 04:08:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Running setup.py install for moznetwork 04:08:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:02 INFO - Running setup.py install for mozprocess 04:08:03 INFO - Running setup.py install for mozprofile 04:08:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:03 INFO - Running setup.py install for mozrunner 04:08:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:03 INFO - Running setup.py install for mozscreenshot 04:08:03 INFO - Running setup.py install for moztest 04:08:03 INFO - Running setup.py install for mozversion 04:08:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:03 INFO - Cleaning up... 04:08:03 INFO - Return code: 0 04:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:03 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:03 INFO - 'HOME': '/Users/cltbld', 04:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:03 INFO - 'LOGNAME': 'cltbld', 04:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:03 INFO - 'MOZ_NO_REMOTE': '1', 04:08:03 INFO - 'NO_EM_RESTART': '1', 04:08:03 INFO - 'PAGER': '/bin/cat', 04:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:03 INFO - 'PWD': '/builds/slave/test', 04:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:03 INFO - 'SHELL': '/bin/bash', 04:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:08:03 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:03 INFO - 'USER': 'cltbld', 04:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:03 INFO - 'XPC_FLAGS': '0x0', 04:08:03 INFO - 'XPC_SERVICE_NAME': '0', 04:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-GYVrBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-pO6Evo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-sjxw2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-ZiAiy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-pTjERq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-h3y4zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-SA9Mmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:04 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-7vEdmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-LuLwS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-xrjDa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:05 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)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-f9zzEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-fe2zuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-WxKknI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-tdsOmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-NMnumH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-fN7mY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:05 INFO - Running setup.py (path:/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/pip-epCpsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:06 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:06 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:08 INFO - Downloading blessings-1.6.tar.gz 04:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:08 INFO - Installing collected packages: blessings 04:08:08 INFO - Running setup.py install for blessings 04:08:08 INFO - Successfully installed blessings 04:08:08 INFO - Cleaning up... 04:08:09 INFO - Return code: 0 04:08:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:09 INFO - Reading from file tmpfile_stdout 04:08:09 INFO - Current package versions: 04:08:09 INFO - blessings == 1.6 04:08:09 INFO - blobuploader == 1.2.4 04:08:09 INFO - docopt == 0.6.1 04:08:09 INFO - functools32 == 3.2.3-2 04:08:09 INFO - jsonschema == 2.5.1 04:08:09 INFO - manifestparser == 1.1 04:08:09 INFO - mozInstall == 1.12 04:08:09 INFO - mozcrash == 1.0 04:08:09 INFO - mozdebug == 0.1 04:08:09 INFO - mozdevice == 0.49 04:08:09 INFO - mozfile == 1.2 04:08:09 INFO - mozhttpd == 0.7 04:08:09 INFO - mozinfo == 0.9 04:08:09 INFO - mozleak == 0.1 04:08:09 INFO - mozlog == 3.4 04:08:09 INFO - moznetwork == 0.27 04:08:09 INFO - mozprocess == 0.25 04:08:09 INFO - mozprofile == 0.28 04:08:09 INFO - mozrunner == 6.13 04:08:09 INFO - mozscreenshot == 0.1 04:08:09 INFO - mozsystemmonitor == 0.3 04:08:09 INFO - moztest == 0.8 04:08:09 INFO - mozversion == 1.4 04:08:09 INFO - psutil == 3.1.1 04:08:09 INFO - requests == 1.2.3 04:08:09 INFO - wsgiref == 0.1.2 04:08:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:09 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:08:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:09 INFO - 'HOME': '/Users/cltbld', 04:08:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:09 INFO - 'LOGNAME': 'cltbld', 04:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:09 INFO - 'MOZ_NO_REMOTE': '1', 04:08:09 INFO - 'NO_EM_RESTART': '1', 04:08:09 INFO - 'PAGER': '/bin/cat', 04:08:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:09 INFO - 'PWD': '/builds/slave/test', 04:08:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:09 INFO - 'SHELL': '/bin/bash', 04:08:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:08:09 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:08:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:09 INFO - 'USER': 'cltbld', 04:08:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:09 INFO - 'XPC_FLAGS': '0x0', 04:08:09 INFO - 'XPC_SERVICE_NAME': '0', 04:08:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:08:09 INFO - Cleaning up... 04:08:09 INFO - Return code: 0 04:08:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:09 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 0x1102abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8c78a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, '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.vABMHrwrWT/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.C2z6I98P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:08:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:08:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:09 INFO - 'HOME': '/Users/cltbld', 04:08:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:09 INFO - 'LOGNAME': 'cltbld', 04:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:09 INFO - 'MOZ_NO_REMOTE': '1', 04:08:09 INFO - 'NO_EM_RESTART': '1', 04:08:09 INFO - 'PAGER': '/bin/cat', 04:08:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:09 INFO - 'PWD': '/builds/slave/test', 04:08:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:09 INFO - 'SHELL': '/bin/bash', 04:08:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:08:09 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:08:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:09 INFO - 'USER': 'cltbld', 04:08:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:09 INFO - 'XPC_FLAGS': '0x0', 04:08:09 INFO - 'XPC_SERVICE_NAME': '0', 04:08:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:08:09 INFO - Cleaning up... 04:08:09 INFO - Return code: 0 04:08:09 INFO - Running post-action listener: _resource_record_post_action 04:08:09 INFO - Running post-action listener: _start_resource_monitoring 04:08:09 INFO - Starting resource monitoring. 04:08:09 INFO - [mozharness: 2017-02-24 12:08:09.846788Z] Finished create-virtualenv step (success) 04:08:09 INFO - [mozharness: 2017-02-24 12:08:09.847831Z] Running install step. 04:08:09 INFO - Running pre-action listener: _resource_record_pre_action 04:08:09 INFO - Running main action method: install 04:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:10 INFO - Reading from file tmpfile_stdout 04:08:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:10 INFO - Reading from file tmpfile_stdout 04:08:10 INFO - Output received: 04:08:10 INFO - Usage: mozinstall [options] installer 04:08:10 INFO - Options: 04:08:10 INFO - -h, --help show this help message and exit 04:08:10 INFO - -d DEST, --destination=DEST 04:08:10 INFO - Directory to install application into. [default: 04:08:10 INFO - "/builds/slave/test"] 04:08:10 INFO - --app=APP Application being installed. [default: firefox] 04:08:10 INFO - mkdir: /builds/slave/test/build/application 04:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:08:30 INFO - Reading from file tmpfile_stdout 04:08:30 INFO - Output received: 04:08:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:08:30 INFO - Running post-action listener: _resource_record_post_action 04:08:30 INFO - [mozharness: 2017-02-24 12:08:30.486470Z] Finished install step (success) 04:08:30 INFO - [mozharness: 2017-02-24 12:08:30.486605Z] Running run-tests step. 04:08:30 INFO - Running pre-action listener: _resource_record_pre_action 04:08:30 INFO - Running main action method: run_tests 04:08:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:08:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:08:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:08:30 INFO - 2017-02-24 04:08:30.501 screenresolution[2192:20126] starting screenresolution argv=screenresolution get 04:08:30 INFO - 2017-02-24 04:08:30.503 screenresolution[2192:20126] Display 0: 1600x1200x32@60 04:08:30 INFO - 2017-02-24 04:08:30.510 screenresolution[2193:20128] starting screenresolution argv=screenresolution list 04:08:30 INFO - Available Modes on Display 0 04:08:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:08:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:08:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:08:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:08:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:08:30 INFO - Intel Iris: 04:08:30 INFO - Chipset Model: Intel Iris 04:08:30 INFO - Type: GPU 04:08:30 INFO - Bus: Built-In 04:08:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:08:30 INFO - Vendor: Intel (0x8086) 04:08:30 INFO - Device ID: 0x0a2e 04:08:30 INFO - Revision ID: 0x0009 04:08:30 INFO - Displays: 04:08:30 INFO - Display: 04:08:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:08:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:08:30 INFO - Display Serial Number: 1600x1200 60 04:08:30 INFO - Main Display: Yes 04:08:30 INFO - Mirror: Off 04:08:30 INFO - Online: Yes 04:08:30 INFO - Rotation: Supported 04:08:30 INFO - Return code: 0 04:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:08:30 INFO - Python 2.7.3 04:08:30 INFO - Return code: 0 04:08:30 INFO - grabbing minidump binary from tooltool 04:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:30 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 0x110089d30>, '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 0x10ffb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:08:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:08:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:08:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:08:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:08:30 INFO - Return code: 0 04:08:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:08:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:08:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:08:30 INFO - ENV: RUST_BACKTRACE is now 1 04:08:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:08:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0229', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0229 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vABMHrwrWT/Render', 04:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:30 INFO - 'HOME': '/Users/cltbld', 04:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:30 INFO - 'LOGNAME': 'cltbld', 04:08:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:08:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:30 INFO - 'MOZ_NO_REMOTE': '1', 04:08:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:08:30 INFO - 'NO_EM_RESTART': '1', 04:08:30 INFO - 'PAGER': '/bin/cat', 04:08:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:30 INFO - 'PWD': '/builds/slave/test', 04:08:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:30 INFO - 'RUST_BACKTRACE': '1', 04:08:30 INFO - 'SHELL': '/bin/bash', 04:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2z6I98P8O/Listeners', 04:08:30 INFO - 'TMPDIR': '/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/', 04:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:30 INFO - 'USER': 'cltbld', 04:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:30 INFO - 'XPC_FLAGS': '0x0', 04:08:30 INFO - 'XPC_SERVICE_NAME': '0', 04:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0229', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:08:31 INFO - mozversion application_buildid: 20170224024759 04:08:31 INFO - mozversion application_changeset: be661bae6cb9a53935c5b87744bf68879d9ebcc5 04:08:31 INFO - mozversion application_display_name: Nightly 04:08:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:08:31 INFO - mozversion application_name: Firefox 04:08:31 INFO - mozversion application_remotingname: firefox 04:08:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:08:31 INFO - mozversion application_vendor: Mozilla 04:08:31 INFO - mozversion application_version: 54.0a1 04:08:31 INFO - mozversion platform_buildid: 20170224024759 04:08:31 INFO - mozversion platform_changeset: be661bae6cb9a53935c5b87744bf68879d9ebcc5 04:08:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:08:31 INFO - mozversion platform_version: 54.0a1 04:08:31 INFO - using testdate: 1487938111 04:08:31 INFO - actual date: 1487938111 04:08:31 INFO - starting webserver on 'localhost:52919' 04:08:31 INFO - SUITE-START | Running 2 tests 04:08:31 INFO - TEST-START | dromaeo_css 04:08:31 INFO - operating with platform_type : mac_ 04:08:31 INFO - Initialising browser for dromaeo_css test... 04:08:31 INFO - TEST-INFO | started process 2203 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/tmptU4LBU/profile http://localhost:52919/getInfo.html) 04:08:33 INFO - PROCESS | 2203 | __metrics Screen width/height:1600/1200 04:08:33 INFO - PROCESS | 2203 | colorDepth:24 04:08:33 INFO - PROCESS | 2203 | Browser inner width/height: 1024/689 04:08:33 INFO - PROCESS | 2203 | __metrics 04:08:33 INFO - PROCESS | 2203 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:08:33 INFO - PROCESS | 2203 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:34 INFO - TEST-INFO | 2203: exit 0 04:08:34 INFO - Browser initialized. 04:08:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:34 INFO - TEST-INFO | started process 2205 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/tmptU4LBU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:46 INFO - PROCESS | 2205 | RSS: Main: 232116224 04:08:46 INFO - PROCESS | 2205 | 04:11:48 INFO - PROCESS | 2205 | Cycle 1(1): loaded http://localhost:52919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52919/tests/dromaeo/cssquery-ext.html) 04:11:52 INFO - PROCESS | 2205 | RSS: Main: 533929984 04:11:52 INFO - PROCESS | 2205 | 04:13:36 INFO - PROCESS | 2205 | ************************* 04:13:36 INFO - PROCESS | 2205 | A coding exception was thrown and uncaught in a Task. 04:13:36 INFO - PROCESS | 2205 | 04:13:36 ERROR - PROCESS | 2205 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:13:36 INFO - PROCESS | 2205 | Full stack: 04:13:36 INFO - PROCESS | 2205 | ************************* 04:14:55 INFO - PROCESS | 2205 | Cycle 1(1): loaded http://localhost:52919/tests/dromaeo/cssquery-ext.html (next: http://localhost:52919/tests/dromaeo/cssquery-jquery.html) 04:14:56 INFO - PROCESS | 2205 | RSS: Main: 375578624 04:14:56 INFO - PROCESS | 2205 | 04:17:58 INFO - PROCESS | 2205 | Cycle 1(1): loaded http://localhost:52919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52919/tests/dromaeo/cssquery-mootools.html) 04:17:59 INFO - PROCESS | 2205 | RSS: Main: 349270016 04:17:59 INFO - PROCESS | 2205 | 04:21:02 INFO - PROCESS | 2205 | Cycle 1(1): loaded http://localhost:52919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52919/tests/dromaeo/cssquery-prototype.html) 04:21:02 INFO - PROCESS | 2205 | RSS: Main: 349188096 04:21:02 INFO - PROCESS | 2205 | 04:24:06 INFO - PROCESS | 2205 | Cycle 1(1): loaded http://localhost:52919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52919/tests/dromaeo/cssquery-yui.html) 04:24:07 INFO - PROCESS | 2205 | RSS: Main: 342822912 04:24:07 INFO - PROCESS | 2205 | 04:27:10 INFO - PROCESS | 2205 | Cycle 1(1): loaded http://localhost:52919/tests/dromaeo/cssquery-yui.html (next: http://localhost:52919/tests/dromaeo/cssquery-dojo.html) 04:27:11 INFO - PROCESS | 2205 | RSS: Main: 386355200 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | __start_tp_report 04:27:11 INFO - PROCESS | 2205 | _x_x_mozilla_page_load 04:27:11 INFO - PROCESS | 2205 | _x_x_mozilla_page_load_details 04:27:11 INFO - PROCESS | 2205 | |i|pagename|runs| 04:27:11 INFO - PROCESS | 2205 | |0;dojo.html;3243.1567792373985;3246.594175728034;3249.155219642892;3266.4120458317525;3294.8682052717877;5300.92048619271;5369.597280203986;5372.516473517383;5397.406285308618;5441.945580544193;5346;5350.5987050971235;5378.273933019042;5404.270423492827;5406.54044406225;4859.441164266119;4872.926906096412;4923.335349727777;5030.673006254582;5077.035363280965;4989.775460104304;5022.748862556876;5075.695458272497;5090;5141.922871156936;4027.4965629296194;4920.704757714549;4921.089598424303;4934.728589927553;4989.476105008976;4939.234418665113;4959.876003099916;4962.826301079481;5020.046191223692;5032.043911656773;4855.247436647325;4910;4932.334134891779;4957.479464656231;4978.079055374731;5177.171652535576;5215.269862219255;5230.215467679878;5366.624336296461;5395.352557693062;5705.971470142665;5707.429257074301;5718.513926316268;5729.570282228808;5731.971340143315;4510.323451482271;5697.145428185805;5762.769489220426;5766.884662306772;5771.278590176228;5397.568194544467;5398.91901621476;5404.594655400861;5412.891742165174;5413.539849112791;4943.975280123648;5932.080527518242;5978.551608629283;5987.401259874065;6000.819975400745;5761.135829625589;5788.102844059177;5792.536597072224;5799.33307669615;5801.361850196475;5980;5992.34084250732;6046.09308603713;6065.2418447694035;6067.635941843503;5981.7607295707685;5993.850153746104;5998.610090344114;5998.850028749229;6007.339192688801;5742.942570574324;5823.417658234227;5960.8807823844145;5966.522678185735;5987.940120598825;4787.880302992453;4794.808207671724;4795.088933102699;4796.160671882407;4807.062622788522;4206.894827629272;4212.599803018708;4265.658747300208;4334.631556317685;4337.7180483268485;5397.703126328011;5492.505674489315;5524.558035357162;5526.557875369961;5527.668339899619;4256.36154576816;5992.34084250732;6016.278046634345;6052.303985041688;6081.331053584102;5562.415946325658;5563.332400111932;5566.721663916788;5569.554435645138;5584.972075139598;5066.847994560169;5251.133562962068;5266.315379000705;5270.8155214567305;5318.388385335658;6123.648682309428;6137.693115344304;6138.940218748386;6148.9692551536955;6151.323354431099;5823.301203855564;5824.534037276923;5825.184474173534;5828.242328497268;5843.590948633555;5608.971955140361;5859.619124756877;6104.572679912541;6133.028644416937;6226.346233645583;5970.343262241063;5976.910346344721;5977.013792724152;5995.46040856325;6014.36849130835;6061.333253342041;6066.423689749467;6070.817875463743;6073.908891366721;6084.178635884099;4753.263244197155;5333.893322133458;5621.437856214346;5660.094384898396;5799.130130480462;5710.8572285691525;5711.314642242957;5717.113847353667;5722.113072473773;5724.885502290014;5505.889882202414;5587.74855131512;5591.552675786009;5600.747966341443;5609.775608975595;5724.169995350568;5725.770969161187;5730.71346432685;5738.885222295447;5739;5533.253010843485;5533.446655334435;5587.3015873015875;5598.188262701967;5599.60802743804 04:27:11 INFO - PROCESS | 2205 | |1;ext.html;437.5121739260724;451.3680846814459;476.9308450274708;485.63577317012243;488.48708855701506;24809;28873;38833.22333553331;40812.59187408125;41247;35022.04625213714;41287.55493557719;41671.58328416715;42225.78887105568;42269;9171;9401.952990235073;9409.012053734363;9420.858687119664;9434.339596228267;6682.766103186389;7401.592912389817;7653.846923061536;7740.187280335568;7750.108737495204;11183.384913829736;11511.539538418496;11531.962123408892;11582.768344633145;11659.183857130005;11344.92223238791;11409.20135590509;11410.600628977945;11434.942825285903;11438.885611143949;11196.496157672924;11246.943765281203;11264.774704505946;11271.380074095921;11299.887001129966;24105.638415423782;28580.428391432262;28994.565081523793;29084.70915290841;29109.41781164386;3340;3651.707863370924;3716.9814150929074;3750.5311836020496;3824.9808750956345;28439.28901777472;29033;29277.414451710847;30190.396192076256;30267.848660756776;2944.3522425066453;3039.60485136933;3091.8144911305394;3137.090243829287;3139.717425431699;452658;452693;453239;453407.7329613364;464251.67874160415;57157.714211428676;57386.7130664344;57387.426125739046;57510.56223594444;57538.7123064382;64070.35929640644;64086;64213.35786642074;64262.67868660627;64300;15069.849301507064;15614.76577851333;15621.765673514907;15624.140672262907;15672.138032408098;11917.344546049877;11998.520059197708;12002.879971200351;12013.699657508632;12022.699432514082;17197.226124824414;17887.88578626923;17914.820851791577;17934;17938.55153621144;6608.372204640552;6621.404073633396;6637.042072588598;6703.597784132968;6718.697658605374;820.5281962871372;861.6854847980442;863.700663465568;866.882970798934;889.4174315823146;28772.70522826478;29223.56164657532;29312;29447.26381840471;29732.86644318389;1022.7596514819012;1023.8873723890366;1055.757175849559;1056.3028401255135;1186.9525218991143;14032.929835350758;14464.638384040272;14675.674464684851;14825.77761333581;14931.402743890123;545447;591344.0432797895;591908;592008;592435;52190.73904630452;52466.475335246156;52487.73756131195;52510;52601.210981835306;1317.7496275707585;1361.1900918953206;1371.2869307960004;1379.8689124533153;1380.703148823008;26898.865505672347;26993.325166870985;27807.304817378918;28425.857870710515;28442;44855;45613.315800263685;45673.54326456693;45680.543194568956;45687;500647;503776;504510.8910297063;504810;505389;24062.714042165968;24383.02467901264;24598.754012460362;24772.25683229506;24779.76101194969;41055.38416923808;41185.79407103065;41295.96760081022;41691.58308416877;42324;32072.81729559927;33184.66815331912;33475;34279.97160085201;34833.9549813506;33515;33615.327693445506;33636.831815840764;34793.9561813146;34952.82523587366;33606.66393336035;34275.31449371049;34281.82859085689;34439;34473.827630861684;28027.299317517227;30047.248818779706;30110;30293;30303.69696303097;18474.81525184731;22773.31680049601;23297;23562.764372356058;23652.29043128709 04:27:11 INFO - PROCESS | 2205 | |2;jquery.html;343.9363717712222;346.9236767911059;381.72515788632177;389.1322351156921;424.6751235304992;12327.260364378144;12562.623121306364;14806;15710;19775.011249437506;20368.130055289486;20615.27846525372;21137.837418941952;21177.894110529425;21368.89315553424;5593.272874526316;6080.452759251666;6155.415235552616;6176.598521096137;6188.443040126388;3566.982165089171;3772.8304225689985;3836.9424458633143;6021.638701677914;6125.693715314239;4090.5295890972475;4110.013596736777;5707.200991861143;6773.45812335012;6773.864522709543;6481.09264702942;6662.86674266512;6746.19045714515;6750.257471678112;6753;5914.083317085859;5926.585139040269;5935;5936.9406305937255;5951.018082016505;24598;25363.23910282676;25373.74626253751;25382.746172538224;25677.48645027089;2660.308319836837;2702.2028501592076;2725.0734750184834;2727.495413348517;2744.794140439455;10108.64619738313;15332.233388330538;15333.923330383277;15476.380944762195;16320.428784992468;1810.8279713427203;1814.482872381365;1828.743975843383;1839.4481655503296;1861.6183682345222;107728;112225;113043;113864.43067784607;115076.42461787722;9162.496062716615;10306.896931030744;11225.382603956697;11322.547098116147;11544.689442856212;12419.130660853654;13409.128406653535;14019.22894240806;14052.85947140536;14430.134191948517;8250.711225107092;8371.204735550113;8430.915690843012;8560.48637081777;8621.180987806149;8255.587220638945;8267.173282671685;8301.792455188668;8442.493450392996;8451.154884511623;6942.132233470817;7078.752243671447;7084.752033678797;7088.645567721594;7090.468214883905;1914.0812410043256;1953.8827670339824;1954.218312674913;1964.666006778851;1965.9115339809744;1030.860833787429;1035.4874337203132;1036.8444733290066;1042.74452759073;1095.5782023920688;21962.89018554897;22206.333809985725;22258.777412225994;22288.77711222867;22299;882.6601758322963;996.1433167475965;1047.544318221576;1087.456271864068;1088.5264909764278;10143.49282535885;11055.858782973975;11475.88524114765;11603.709907252218;11702.180847340604;711560;725025;725651;746178.0764384682;746378;107226;116052.36978789224;116146.41926790313;117758;119606;885.4952676974192;1033.844923261517;1042.6819819954987;1049.7638031443016;1050.9369437833755;18579.699421040397;18830.623387531898;19037.95291258994;19074;19126;42693.35959960541;49544.256836146764;50375.74812125916;50444.74777626088;50542;69057.65471172612;69710.95433568602;69945;70151;70257.64871175612;6593.604383736991;7815.179406162271;8021.4786038909615;8100.473469224482;8100.756977290691;10618.67266591676;10698.518566664363;12785.296808675612;12883.291418972047;13220.942324613816;11075.335479871233;11324;11400.206949297475;11406.885931140583;11455.656330310105;11027.0075693188;11082.833757493805;11146.944265278622;11354.545818167511;11372.601958931398;10903.29128606638;11469.541218351173;11701.648950531498;11712.355820429959;11816.645500634995;7497.962510187414;8107.594620269081;8121.431499795194;8141.51150930946;8351.665933362841;10950.726231844268;11118.27731197502;11398.886011139783;11422.029127523921;11457.484413201593 04:27:11 INFO - PROCESS | 2205 | |3;mootools.html;1446.1323206076356;1452.9927350363246;1467.8825693944486;1471.8896082793785;1478.6894752102057;7858.528488290699;8266.173382661731;8277.83444331113;8283.75148745537;8305.50166989981;7852.842943141148;8155.91844081559;8156.632951517181;8286.95856520718;8307.252347288742;2231.7545070042283;2271.8409711320214;2272.6363781794917;2274.647429648407;2276.590213761522;2248.213125406103;2273.761255068219;2275.8065564427043;2276.7495575486682;2280.9885950570224;2224.5995720770256;2239.9347224709963;2248.55028994201;2258.141906075697;2259.243153543565;1991.7410736604222;2126.0114046968156;2212.8782916939563;2241.5628952354296;2249.4151520604596;2165.083900747834;2228.9969513718893;2231.8549294295817;2238.764929682376;2240.260713964388;8185.631646575918;8275.668973241063;8291.626876790559;8297.294729947962;8303.4602750821;4938.580220681247;5086.41506226785;5090.236464530313;5093.0577843099145;5098.158803797369;3131.671174526665;3199.63204231514;3350.480675495302;3413.2661477782394;3420.8973730788116;1193.8806119388078;1194.5162209305158;1238.7708273969345;1255.253124390986;1255.7865162922326;7868.488548244403;9944.154746846527;9962.452065136415;10467.947660261727;10471.005254500811;3997.320455522568;4104.958950410458;4118.464599602033;4151.709380343407;4214.810333534998;8469.534175620276;8590.098039705741;8625.568721563897;8628.827423451496;8651.95674021626;4966.279889416014;4980.77586508608;4985.177445721415;4995.850124496271;4998.425181104147;4465.933011004838;4633.443986721615;4656.208444564432;4686.906261874743;4698.459677137173;3448.3448144852396;3517.103138699615;3563.073600863794;3600.297941901304;3600.6399360063783;1114.4427786106946;1115.9776804463866;1116.7152376144031;1128.0468004536153;1130.8756036835941;749.8350362920149;753.276854219955;761.6877080397011;772.220057741685;808.8139727862624;4700.694454860423;5678.346990096192;5796.768129274866;5809.854753631109;5856.707164641751;951.3007939164709;971.3540495570508;972.1833659725864;992.389680346596;998.3361064891766;3699.648533389324;3710.461983012448;3747.7189210809297;3840.5967373425947;3846.9038274043373;9392.906070939203;9759.072888075621;9761.316707830525;9762.36544624597;9766.951165244129;9708.611655533841;9720.027997200223;9721.125098741148;9728.124468797841;9729.56216970238;7584.127825300051;7737.458377913605;7740.612969351398;7746.225377462321;7813.648385822652;5126.718030508208;5325.976129070928;5465.590080744039;5473.480019398151;5513.724313784375;8615.138486151334;8806.735797926072;8992.28061755071;9093.181613654539;9103.135202155785;8547.61535730906;8612.052674205706;8882.555872206492;9240.95379523098;9252.861207081765;6966.7213311469;7114.430845532448;7115.146182458138;7120.1099862517185;7120.679569419285;6917.377436030782;7403.444741644291;7415.406767458699;7852.528848269122;7859.960700196462;6836.282190370139;6898.620575868375;6902.896456553055;6987.475939304471;7095.858082838417;6833.214180369122;6849.1780986281965;6859;6888.207856096613;6941.965290173517;6032.90950635732;6254.655993920196;6329.240491141092;6335.303116657072;6342.841428964128;4744.8849520362;4831.299461578122;4861.1979023460735;4900.411950565813;5049.192129259301;4665.2302370108555;4923.433805112458;4943.085529177114;4998.575121114601;5079.949200508096 04:27:11 INFO - PROCESS | 2205 | |4;prototype.html;324.16204112369553;355.24155927095643;361.5137639874369;368.6460997442454;372.5566575774828;4498.5501449854955;4828.444728856182;4857.611391088713;4947.1342515059905;4969.652124351297;4489.062031765065;4697.835575754849;5030.2957585938;5114.718690472032;5172.689638621685;3632.164602141509;3709.7757739945755;3921.2549615573093;3941.5664276929515;4064.370022646487;3179.9665108839604;3977.7613343199355;3978.4231286463446;3997.6002399759936;4012.418199361091;3719.5164628598245;3843.903902402434;3851.5763266040713;3874.321993651114;3917.275304068742;3254.7233485153793;3763.7579598732354;3833.7540299402667;3884.2425726983392;3904.3362628353248;3279.475283954556;3412.215190506173;3412.84642191102;3438.398280300937;3448.9310213795584;4596.988662494246;4602.148602508513;5029.170186919154;5031.823886163967;5072.568831649314;4083.3058380075163;4466.82132714691;4476.657002899117;4512.571305725951;4522.1685217486975;4843.39457567804;5316.9202461963105;5399.4341640924085;5402.91895621566;5429.619926605139;3207.470767323389;3266.70599646033;3344.2976974835315;3767.566729826078;3774.301754175486;4290.592393722592;4944.777485013183;5378.300820893298;5425.643589102724;5638.774449022034;3743.745845141908;3803;3807.6573108420375;3809.9809500952874;3836.1176929306416;3887.688984881203;3892.4745159403683;3893.552241492208;3909.2963266611714;3926.312895243321;3618.9372057927253;4180.435641188462;4190.245755763992;4558.521355257716;4564.1556312082375;5535.225068490334;5538.421549858271;5543.417941116125;5548.334199896039;5553.639013464192;1079.7624522605015;1117.932924024545;1222.7982382906898;1255.7944373401454;1263.8041103628952;793.2305663506389;811.5374236685151;846.4963346808639;857.8155696525278;862.7670528957146;4326.4159338489535;4440.245158323093;4641.257398816173;4744.596709279681;4800.615950723934;4732.574068333866;5172.172452407597;5263.763130659129;5305.973470132702;5335;4142.08874047709;4407.691461597721;4926.96533727914;4982.9252561211615;5004.899902001939;2404.8316617836936;2503.632614133987;2562.551553478134;2653.6550248467574;2768.4463107378606;4922.433920099163;4999.3000979862845;5509.338879334506;5670.489655930986;5702.265016414255;4515.661325400542;4801.4958429365115;5393;5576.776928922879;5827.155062515912;4801.591864691401;5455.236266922634;5627.324721033502;5919.644821310649;5920.460680223173;5198.298229738937;5323.326904435927;5680.15992003998;5708.544321198068;5711.514521265739;4600.585947264628;5196.714180720097;5224.294720212874;5598.1322894951345;5619.719014049363;5928.4960778334325;5947.613405128653;5967.671778052249;5979.282486101695;5990.700464976647;3616.1502047018403;3680.3743363628782;3773.58490566032;3814.5994670559194;3845.807709614564;4699.3420921071765;4881.560659540658;4964.875878102932;5080.34888661194;5623.8875222496135;4719.3156992235245;5374.704391258362;5377.919331209957;5392.568594512351;5419.160030195326;4837.467878533288;5301.257823904733;5395;5523.106210121774;5546.450271826116;5133.820316288912;5261.552768014762;5356.973215133899;5360.597955153301;5432.266644003009;4723.598494128038;5194.870078287846;5512.779488820403;5514.503694667499;5517.834464966058;4240.321548552217;4769.952300476951;5176.559992400688;5182.559482444034;5346.572274218131 04:27:11 INFO - PROCESS | 2205 | |5;yui.html;695.6139342664819;715.6254794344281;776.3788968824939;786.9556145109847;810.4043528006915;14117.011809173362;14830.48093316734;14837.777433338495;16925.407610733626;17803.198856051476;15517.456889008887;15695.37218511261;16016.679666406664;16285.51143465695;16321;908.4867050116679;926.4441335198894;931.3154831199063;932.645594674023;934.5794392523358;889.2174886100223;917.9036201198878;918.0773322810566;922.5202894494859;926.1063074133493;960.3949511807551;969.3602222533129;974.5370948799299;976.9413835169912;980.6763767956593;968.3899143539595;969.0648524174135;969.6703120938879;971.1114330387687;971.3006635222629;720.4272603280405;721.0806222066907;721.2715157690718;721.3471808013755;721.8953251778463;13026.739465210738;15232.923835380752;15368.154751488664;15392.769108463383;15406.768898466533;13687.31563421825;13690.863091369058;13984.650383740387;14065.507707230197;14342.49801256951;11224.818175967059;11416.60041898538;11469.348811322216;11635.30188188703;12002.159848810586;3602.3505685176733;3618.8733394331334;3674.595794462607;3709.350863598859;3717;105108;107195.39206911824;107862.46068769685;107870.38194427089;108341.45829270882;10390.792184156275;10532.420716860493;10681.392269058806;10882.95179260562;11030.50362733679;22018.44953876166;22129.66805497919;22309.776902231093;22416.66375004376;22477.21329753451;7414.14737305206;7459.142198647117;7492.887606685795;7554.962225188949;7707.537547747041;4213.0310028693575;4265.4881414230495;4313.956860431418;4323.329883868006;4402.141582391403;3499.160201551609;3587.2466781976077;3596.3166998270767;3598.136447252693;3599.1541987632886;664.9202095748541;670.5138774388529;681.6012632609879;687.3950923187663;687.7317846040048;632.2476253258608;663.6880666086931;669.625009994395;698.8742026435189;733.9339459448676;7563.508371955805;8781.473111613324;9862.112409883002;9864.408135511892;10463.581456741646;540.929679141717;552.6242155334331;617.7436363909018;632.4659231722429;682.494953734243;4399.62603178727;4626.902919890193;4694.155052090657;4848.806047758121;4907.852764417074;79222.60388698135;84242;84838.5758071218;91973;95444.52277738706;50581;58030.129548056815;59136;80485;83908;53120;56172;71651;73378;75885.9999999989;9195.16128227014;10346.689599312032;10398.948005259925;10502.159827213958;10519;43788;45033.64899053034;45045.774771125936;45445.77277113593;48885;59789.402105978384;62138;62737.37262627315;63656;65119.674401627686;12192.011477647453;12336.3215023171;12369;12512.499500019898;12851.678708032374;13534.184920268839;13829.446822127002;14037.859621403655;14043.50847720325;14450.783238251224;12798.488060477848;12830.524489683807;12937.382827146606;12940.352982350656;13127.868721312665;12934.482620695067;13069.281189534286;13102;13291.800622990857;13502.392392342565;11292.209545332076;12409.689757756129;12452.937735311265;12493.921741805847;12859.871401285867;9954.185135732096;10001.599936002478;10074.044625552908;10200.38797672142;10313.535890884777;8518.488890666333;9195;9741.366811157252;9749.317547771872;9850.408975461496 04:27:11 INFO - PROCESS | 2205 | __end_tp_report 04:27:11 INFO - PROCESS | 2205 | __start_cc_report 04:27:11 INFO - PROCESS | 2205 | _x_x_mozilla_cycle_collect,3763 04:27:11 INFO - PROCESS | 2205 | __end_cc_report 04:27:11 INFO - PROCESS | 2205 | __startTimestamp1487939231110__endTimestamp 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | ------- Summary: start ------- 04:27:11 INFO - PROCESS | 2205 | Number of tests: 6 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | [#0] dojo.html Cycles:165 Average:5429.46 Median:5584.97 stddev:612.64 (11.0%) stddev-sans-first:590.03 04:27:11 INFO - PROCESS | 2205 | Values: 3243.2 3246.6 3249.2 3266.4 3294.9 5300.9 5369.6 5372.5 5397.4 5441.9 5346.0 5350.6 5378.3 5404.3 5406.5 4859.4 4872.9 4923.3 5030.7 5077.0 4989.8 5022.7 5075.7 5090.0 5141.9 4027.5 4920.7 4921.1 4934.7 4989.5 4939.2 4959.9 4962.8 5020.0 5032.0 4855.2 4910.0 4932.3 4957.5 4978.1 5177.2 5215.3 5230.2 5366.6 5395.4 5706.0 5707.4 5718.5 5729.6 5732.0 4510.3 5697.1 5762.8 5766.9 5771.3 5397.6 5398.9 5404.6 5412.9 5413.5 4944.0 5932.1 5978.6 5987.4 6000.8 5761.1 5788.1 5792.5 5799.3 5801.4 5980.0 5992.3 6046.1 6065.2 6067.6 5981.8 5993.9 5998.6 5998.9 6007.3 5742.9 5823.4 5960.9 5966.5 5987.9 4787.9 4794.8 4795.1 4796.2 4807.1 4206.9 4212.6 4265.7 4334.6 4337.7 5397.7 5492.5 5524.6 5526.6 5527.7 4256.4 5992.3 6016.3 6052.3 6081.3 5562.4 5563.3 5566.7 5569.6 5585.0 5066.8 5251.1 5266.3 5270.8 5318.4 6123.6 6137.7 6138.9 6149.0 6151.3 5823.3 5824.5 5825.2 5828.2 5843.6 5609.0 5859.6 6104.6 6133.0 6226.3 5970.3 5976.9 5977.0 5995.5 6014.4 6061.3 6066.4 6070.8 6073.9 6084.2 4753.3 5333.9 5621.4 5660.1 5799.1 5710.9 5711.3 5717.1 5722.1 5724.9 5505.9 5587.7 5591.6 5600.7 5609.8 5724.2 5725.8 5730.7 5738.9 5739.0 5533.3 5533.4 5587.3 5598.2 5599.6 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | [#1] ext.html Cycles:180 Average:63863.66 Median:33495.00 stddev:137943.01 (411.8%) stddev-sans-first:138247.77 04:27:11 INFO - PROCESS | 2205 | Values: 437.5 451.4 476.9 485.6 488.5 24809.0 28873.0 38833.2 40812.6 41247.0 35022.0 41287.6 41671.6 42225.8 42269.0 9171.0 9402.0 9409.0 9420.9 9434.3 6682.8 7401.6 7653.8 7740.2 7750.1 11183.4 11511.5 11532.0 11582.8 11659.2 11344.9 11409.2 11410.6 11434.9 11438.9 11196.5 11246.9 11264.8 11271.4 11299.9 24105.6 28580.4 28994.6 29084.7 29109.4 3340.0 3651.7 3717.0 3750.5 3825.0 28439.3 29033.0 29277.4 30190.4 30267.8 2944.4 3039.6 3091.8 3137.1 3139.7 452658.0 452693.0 453239.0 453407.7 464251.7 57157.7 57386.7 57387.4 57510.6 57538.7 64070.4 64086.0 64213.4 64262.7 64300.0 15069.8 15614.8 15621.8 15624.1 15672.1 11917.3 11998.5 12002.9 12013.7 12022.7 17197.2 17887.9 17914.8 17934.0 17938.6 6608.4 6621.4 6637.0 6703.6 6718.7 820.5 861.7 863.7 866.9 889.4 28772.7 29223.6 29312.0 29447.3 29732.9 1022.8 1023.9 1055.8 1056.3 1187.0 14032.9 14464.6 14675.7 14825.8 14931.4 545447.0 591344.0 591908.0 592008.0 592435.0 52190.7 52466.5 52487.7 52510.0 52601.2 1317.7 1361.2 1371.3 1379.9 1380.7 26898.9 26993.3 27807.3 28425.9 28442.0 44855.0 45613.3 45673.5 45680.5 45687.0 500647.0 503776.0 504510.9 504810.0 505389.0 24062.7 24383.0 24598.8 24772.3 24779.8 41055.4 41185.8 41296.0 41691.6 42324.0 32072.8 33184.7 33475.0 34280.0 34834.0 33515.0 33615.3 33636.8 34794.0 34952.8 33606.7 34275.3 34281.8 34439.0 34473.8 28027.3 30047.2 30110.0 30293.0 30303.7 18474.8 22773.3 23297.0 23562.8 23652.3 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | [#2] jquery.html Cycles:180 Average:37929.32 Median:21665.89 stddev:120506.78 (556.2%) stddev-sans-first:120811.78 04:27:11 INFO - PROCESS | 2205 | Values: 343.9 346.9 381.7 389.1 424.7 12327.3 12562.6 14806.0 15710.0 19775.0 20368.1 20615.3 21137.8 21177.9 21368.9 5593.3 6080.5 6155.4 6176.6 6188.4 3567.0 3772.8 3836.9 6021.6 6125.7 4090.5 4110.0 5707.2 6773.5 6773.9 6481.1 6662.9 6746.2 6750.3 6753.0 5914.1 5926.6 5935.0 5936.9 5951.0 24598.0 25363.2 25373.7 25382.7 25677.5 2660.3 2702.2 2725.1 2727.5 2744.8 10108.6 15332.2 15333.9 15476.4 16320.4 1810.8 1814.5 1828.7 1839.4 1861.6 107728.0 112225.0 113043.0 113864.4 115076.4 9162.5 10306.9 11225.4 11322.5 11544.7 12419.1 13409.1 14019.2 14052.9 14430.1 8250.7 8371.2 8430.9 8560.5 8621.2 8255.6 8267.2 8301.8 8442.5 8451.2 6942.1 7078.8 7084.8 7088.6 7090.5 1914.1 1953.9 1954.2 1964.7 1965.9 1030.9 1035.5 1036.8 1042.7 1095.6 21962.9 22206.3 22258.8 22288.8 22299.0 882.7 996.1 1047.5 1087.5 1088.5 10143.5 11055.9 11475.9 11603.7 11702.2 711560.0 725025.0 725651.0 746178.1 746378.0 107226.0 116052.4 116146.4 117758.0 119606.0 885.5 1033.8 1042.7 1049.8 1050.9 18579.7 18830.6 19038.0 19074.0 19126.0 42693.4 49544.3 50375.7 50444.7 50542.0 69057.7 69711.0 69945.0 70151.0 70257.6 6593.6 7815.2 8021.5 8100.5 8100.8 10618.7 10698.5 12785.3 12883.3 13220.9 11075.3 11324.0 11400.2 11406.9 11455.7 11027.0 11082.8 11146.9 11354.5 11372.6 10903.3 11469.5 11701.6 11712.4 11816.6 7498.0 8107.6 8121.4 8141.5 8351.7 10950.7 11118.3 11398.9 11422.0 11457.5 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | [#3] mootools.html Cycles:180 Average:5262.82 Median:5469.54 stddev:2842.24 (52.0%) stddev-sans-first:2835.74 04:27:11 INFO - PROCESS | 2205 | Values: 1446.1 1453.0 1467.9 1471.9 1478.7 7858.5 8266.2 8277.8 8283.8 8305.5 7852.8 8155.9 8156.6 8287.0 8307.3 2231.8 2271.8 2272.6 2274.6 2276.6 2248.2 2273.8 2275.8 2276.7 2281.0 2224.6 2239.9 2248.6 2258.1 2259.2 1991.7 2126.0 2212.9 2241.6 2249.4 2165.1 2229.0 2231.9 2238.8 2240.3 8185.6 8275.7 8291.6 8297.3 8303.5 4938.6 5086.4 5090.2 5093.1 5098.2 3131.7 3199.6 3350.5 3413.3 3420.9 1193.9 1194.5 1238.8 1255.3 1255.8 7868.5 9944.2 9962.5 10467.9 10471.0 3997.3 4105.0 4118.5 4151.7 4214.8 8469.5 8590.1 8625.6 8628.8 8652.0 4966.3 4980.8 4985.2 4995.9 4998.4 4465.9 4633.4 4656.2 4686.9 4698.5 3448.3 3517.1 3563.1 3600.3 3600.6 1114.4 1116.0 1116.7 1128.0 1130.9 749.8 753.3 761.7 772.2 808.8 4700.7 5678.3 5796.8 5809.9 5856.7 951.3 971.4 972.2 992.4 998.3 3699.6 3710.5 3747.7 3840.6 3846.9 9392.9 9759.1 9761.3 9762.4 9767.0 9708.6 9720.0 9721.1 9728.1 9729.6 7584.1 7737.5 7740.6 7746.2 7813.6 5126.7 5326.0 5465.6 5473.5 5513.7 8615.1 8806.7 8992.3 9093.2 9103.1 8547.6 8612.1 8882.6 9241.0 9252.9 6966.7 7114.4 7115.1 7120.1 7120.7 6917.4 7403.4 7415.4 7852.5 7860.0 6836.3 6898.6 6902.9 6987.5 7095.9 6833.2 6849.2 6859.0 6888.2 6942.0 6032.9 6254.7 6329.2 6335.3 6342.8 4744.9 4831.3 4861.2 4900.4 5049.2 4665.2 4923.4 4943.1 4998.6 5079.9 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | [#4] prototype.html Cycles:180 Average:4338.61 Median:4801.06 stddev:1341.06 (27.9%) stddev-sans-first:1310.54 04:27:11 INFO - PROCESS | 2205 | Values: 324.2 355.2 361.5 368.6 372.6 4498.6 4828.4 4857.6 4947.1 4969.7 4489.1 4697.8 5030.3 5114.7 5172.7 3632.2 3709.8 3921.3 3941.6 4064.4 3180.0 3977.8 3978.4 3997.6 4012.4 3719.5 3843.9 3851.6 3874.3 3917.3 3254.7 3763.8 3833.8 3884.2 3904.3 3279.5 3412.2 3412.8 3438.4 3448.9 4597.0 4602.1 5029.2 5031.8 5072.6 4083.3 4466.8 4476.7 4512.6 4522.2 4843.4 5316.9 5399.4 5402.9 5429.6 3207.5 3266.7 3344.3 3767.6 3774.3 4290.6 4944.8 5378.3 5425.6 5638.8 3743.7 3803.0 3807.7 3810.0 3836.1 3887.7 3892.5 3893.6 3909.3 3926.3 3618.9 4180.4 4190.2 4558.5 4564.2 5535.2 5538.4 5543.4 5548.3 5553.6 1079.8 1117.9 1222.8 1255.8 1263.8 793.2 811.5 846.5 857.8 862.8 4326.4 4440.2 4641.3 4744.6 4800.6 4732.6 5172.2 5263.8 5306.0 5335.0 4142.1 4407.7 4927.0 4982.9 5004.9 2404.8 2503.6 2562.6 2653.7 2768.4 4922.4 4999.3 5509.3 5670.5 5702.3 4515.7 4801.5 5393.0 5576.8 5827.2 4801.6 5455.2 5627.3 5919.6 5920.5 5198.3 5323.3 5680.2 5708.5 5711.5 4600.6 5196.7 5224.3 5598.1 5619.7 5928.5 5947.6 5967.7 5979.3 5990.7 3616.2 3680.4 3773.6 3814.6 3845.8 4699.3 4881.6 4964.9 5080.3 5623.9 4719.3 5374.7 5377.9 5392.6 5419.2 4837.5 5301.3 5395.0 5523.1 5546.5 5133.8 5261.6 5357.0 5360.6 5432.3 4723.6 5194.9 5512.8 5514.5 5517.8 4240.3 4770.0 5176.6 5182.6 5346.6 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - PROCESS | 2205 | [#5] yui.html Cycles:180 Average:18752.77 Median:24717.90 stddev:26189.78 (106.0%) stddev-sans-first:26228.15 04:27:11 INFO - PROCESS | 2205 | Values: 695.6 715.6 776.4 787.0 810.4 14117.0 14830.5 14837.8 16925.4 17803.2 15517.5 15695.4 16016.7 16285.5 16321.0 908.5 926.4 931.3 932.6 934.6 889.2 917.9 918.1 922.5 926.1 960.4 969.4 974.5 976.9 980.7 968.4 969.1 969.7 971.1 971.3 720.4 721.1 721.3 721.3 721.9 13026.7 15232.9 15368.2 15392.8 15406.8 13687.3 13690.9 13984.7 14065.5 14342.5 11224.8 11416.6 11469.3 11635.3 12002.2 3602.4 3618.9 3674.6 3709.4 3717.0 105108.0 107195.4 107862.5 107870.4 108341.5 10390.8 10532.4 10681.4 10883.0 11030.5 22018.4 22129.7 22309.8 22416.7 22477.2 7414.1 7459.1 7492.9 7555.0 7707.5 4213.0 4265.5 4314.0 4323.3 4402.1 3499.2 3587.2 3596.3 3598.1 3599.2 664.9 670.5 681.6 687.4 687.7 632.2 663.7 669.6 698.9 733.9 7563.5 8781.5 9862.1 9864.4 10463.6 540.9 552.6 617.7 632.5 682.5 4399.6 4626.9 4694.2 4848.8 4907.9 79222.6 84242.0 84838.6 91973.0 95444.5 50581.0 58030.1 59136.0 80485.0 83908.0 53120.0 56172.0 71651.0 73378.0 75886.0 9195.2 10346.7 10398.9 10502.2 10519.0 43788.0 45033.6 45045.8 45445.8 48885.0 59789.4 62138.0 62737.4 63656.0 65119.7 12192.0 12336.3 12369.0 12512.5 12851.7 13534.2 13829.4 14037.9 14043.5 14450.8 12798.5 12830.5 12937.4 12940.4 13127.9 12934.5 13069.3 13102.0 13291.8 13502.4 11292.2 12409.7 12452.9 12493.9 12859.9 9954.2 10001.6 10074.0 10200.4 10313.5 8518.5 9195.0 9741.4 9749.3 9850.4 04:27:11 INFO - PROCESS | 2205 | -------- Summary: end -------- 04:27:11 INFO - PROCESS | 2205 | 04:27:11 INFO - TEST-INFO | 2205: exit 0 04:27:11 INFO - TEST-OK | dromaeo_css | took 1120721ms 04:27:11 INFO - TEST-START | kraken 04:27:11 INFO - operating with platform_type : mac_ 04:27:11 INFO - Initialising browser for kraken test... 04:27:11 INFO - TEST-INFO | started process 2207 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/tmpVhtMMN/profile http://localhost:52919/getInfo.html) 04:27:14 INFO - PROCESS | 2207 | __metrics Screen width/height:1600/1200 04:27:14 INFO - PROCESS | 2207 | colorDepth:24 04:27:14 INFO - PROCESS | 2207 | Browser inner width/height: 1024/689 04:27:14 INFO - PROCESS | 2207 | __metrics 04:27:14 INFO - PROCESS | 2207 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:27:14 INFO - PROCESS | 2207 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:27:15 INFO - TEST-INFO | 2207: exit 0 04:27:15 INFO - Browser initialized. 04:27:15 INFO - Running cycle 1/1 for kraken test... 04:27:15 INFO - TEST-INFO | started process 2208 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/tmpVhtMMN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:27 INFO - PROCESS | 2208 | RSS: Main: 231403520 04:27:27 INFO - PROCESS | 2208 | 04:27:30 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52919/tests/kraken/driver.html?testName=audio-beat-detection) 04:27:31 INFO - PROCESS | 2208 | RSS: Main: 283738112 04:27:31 INFO - PROCESS | 2208 | 04:27:33 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52919/tests/kraken/driver.html?testName=audio-dft) 04:27:34 INFO - PROCESS | 2208 | RSS: Main: 286830592 04:27:34 INFO - PROCESS | 2208 | 04:27:37 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52919/tests/kraken/driver.html?testName=audio-fft) 04:27:38 INFO - PROCESS | 2208 | RSS: Main: 379310080 04:27:38 INFO - PROCESS | 2208 | 04:27:40 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52919/tests/kraken/driver.html?testName=audio-oscillator) 04:27:41 INFO - PROCESS | 2208 | RSS: Main: 279453696 04:27:41 INFO - PROCESS | 2208 | 04:27:43 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:27:43 INFO - PROCESS | 2208 | RSS: Main: 284131328 04:27:43 INFO - PROCESS | 2208 | 04:27:46 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52919/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:47 INFO - PROCESS | 2208 | RSS: Main: 326098944 04:27:47 INFO - PROCESS | 2208 | 04:27:50 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52919/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:50 INFO - PROCESS | 2208 | RSS: Main: 327282688 04:27:50 INFO - PROCESS | 2208 | 04:27:53 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52919/tests/kraken/driver.html?testName=json-parse-financial) 04:27:54 INFO - PROCESS | 2208 | RSS: Main: 326283264 04:27:54 INFO - PROCESS | 2208 | 04:27:56 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:56 INFO - PROCESS | 2208 | RSS: Main: 300658688 04:27:56 INFO - PROCESS | 2208 | 04:27:58 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:59 INFO - PROCESS | 2208 | RSS: Main: 304730112 04:27:59 INFO - PROCESS | 2208 | 04:28:01 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:02 INFO - PROCESS | 2208 | RSS: Main: 306720768 04:28:02 INFO - PROCESS | 2208 | 04:28:05 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:06 INFO - PROCESS | 2208 | RSS: Main: 321888256 04:28:06 INFO - PROCESS | 2208 | 04:28:08 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:09 INFO - PROCESS | 2208 | RSS: Main: 315949056 04:28:09 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:52919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52919/tests/kraken/driver.html?testName=ai-astar) 04:28:11 INFO - PROCESS | 2208 | RSS: Main: 360869888 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | __start_tp_report 04:28:11 INFO - PROCESS | 2208 | _x_x_mozilla_page_load 04:28:11 INFO - PROCESS | 2208 | _x_x_mozilla_page_load_details 04:28:11 INFO - PROCESS | 2208 | |i|pagename|runs| 04:28:11 INFO - PROCESS | 2208 | |0;ai-astar;116;115;115;114;112;115;113;113;112;114 04:28:11 INFO - PROCESS | 2208 | |1;audio-beat-detection;176;141;113;151;114;114;113;112;135;112 04:28:11 INFO - PROCESS | 2208 | |2;audio-dft;186;187;185;188;188;188;184;187;184;197 04:28:11 INFO - PROCESS | 2208 | |3;audio-fft;82;62;60;93;64;61;59;60;76;61 04:28:11 INFO - PROCESS | 2208 | |4;audio-oscillator;88;71;87;68;62;57;87;97;98;115 04:28:11 INFO - PROCESS | 2208 | |5;imaging-gaussian-blur;88;87;89;88;89;91;89;88;87;87 04:28:11 INFO - PROCESS | 2208 | |6;imaging-darkroom;95;96;96;96;95;95;94;95;94;95 04:28:11 INFO - PROCESS | 2208 | |7;imaging-desaturate;87;86;101;138;135;88;85;87;88;87 04:28:11 INFO - PROCESS | 2208 | |8;json-parse-financial;65;63;63;63;63;65;61;62;60;61 04:28:11 INFO - PROCESS | 2208 | |9;json-stringify-tinderbox;64;71;69;76;74;68;68;68;69;69 04:28:11 INFO - PROCESS | 2208 | |10;stanford-crypto-aes;89;90;88;94;105;85;86;89;89;87 04:28:11 INFO - PROCESS | 2208 | |11;stanford-crypto-ccm;138;147;143;137;148;146;143;130;183;141 04:28:11 INFO - PROCESS | 2208 | |12;stanford-crypto-pbkdf2;173;170;173;173;177;174;175;212;172;171 04:28:11 INFO - PROCESS | 2208 | |13;stanford-crypto-sha256-iterative;68;81;84;85;86;74;66;67;63;65 04:28:11 INFO - PROCESS | 2208 | __end_tp_report 04:28:11 INFO - PROCESS | 2208 | __start_cc_report 04:28:11 INFO - PROCESS | 2208 | _x_x_mozilla_cycle_collect,2135 04:28:11 INFO - PROCESS | 2208 | __end_cc_report 04:28:11 INFO - PROCESS | 2208 | __startTimestamp1487939291735__endTimestamp 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | ------- Summary: start ------- 04:28:11 INFO - PROCESS | 2208 | Number of tests: 14 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.37 (1.2%) stddev-sans-first:1.22 04:28:11 INFO - PROCESS | 2208 | Values: 116.0 115.0 115.0 114.0 112.0 115.0 113.0 113.0 112.0 114.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:124.50 stddev:22.12 (17.8%) stddev-sans-first:15.23 04:28:11 INFO - PROCESS | 2208 | Values: 176.0 141.0 113.0 151.0 114.0 114.0 113.0 112.0 135.0 112.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#2] audio-dft Cycles:10 Average:187.40 Median:187.50 stddev:3.72 (2.0%) stddev-sans-first:3.91 04:28:11 INFO - PROCESS | 2208 | Values: 186.0 187.0 185.0 188.0 188.0 188.0 184.0 187.0 184.0 197.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#3] audio-fft Cycles:10 Average:67.80 Median:63.00 stddev:11.75 (18.7%) stddev-sans-first:11.29 04:28:11 INFO - PROCESS | 2208 | Values: 82.0 62.0 60.0 93.0 64.0 61.0 59.0 60.0 76.0 61.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:87.00 stddev:18.22 (20.9%) stddev-sans-first:19.24 04:28:11 INFO - PROCESS | 2208 | Values: 88.0 71.0 87.0 68.0 62.0 57.0 87.0 97.0 98.0 115.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 04:28:11 INFO - PROCESS | 2208 | Values: 88.0 87.0 89.0 88.0 89.0 91.0 89.0 88.0 87.0 87.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 04:28:11 INFO - PROCESS | 2208 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 94.0 95.0 94.0 95.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#7] imaging-desaturate Cycles:10 Average:98.20 Median:87.00 stddev:20.69 (23.8%) stddev-sans-first:21.55 04:28:11 INFO - PROCESS | 2208 | Values: 87.0 86.0 101.0 138.0 135.0 88.0 85.0 87.0 88.0 87.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.50 04:28:11 INFO - PROCESS | 2208 | Values: 65.0 63.0 63.0 63.0 63.0 65.0 61.0 62.0 60.0 61.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:3.37 (4.9%) stddev-sans-first:2.91 04:28:11 INFO - PROCESS | 2208 | Values: 64.0 71.0 69.0 76.0 74.0 68.0 68.0 68.0 69.0 69.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:89.00 stddev:5.75 (6.5%) stddev-sans-first:6.08 04:28:11 INFO - PROCESS | 2208 | Values: 89.0 90.0 88.0 94.0 105.0 85.0 86.0 89.0 89.0 87.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:144.50 stddev:14.21 (9.8%) stddev-sans-first:14.80 04:28:11 INFO - PROCESS | 2208 | Values: 138.0 147.0 143.0 137.0 148.0 146.0 143.0 130.0 183.0 141.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:173.50 stddev:12.45 (7.2%) stddev-sans-first:13.13 04:28:11 INFO - PROCESS | 2208 | Values: 173.0 170.0 173.0 173.0 177.0 174.0 175.0 212.0 172.0 171.0 04:28:11 INFO - PROCESS | 2208 | 04:28:11 INFO - PROCESS | 2208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:77.50 stddev:9.22 (11.9%) stddev-sans-first:9.53 04:28:11 INFO - PROCESS | 2208 | Values: 68.0 81.0 84.0 85.0 86.0 74.0 66.0 67.0 63.0 65.0 04:28:11 INFO - PROCESS | 2208 | -------- Summary: end -------- 04:28:11 INFO - PROCESS | 2208 | 04:28:12 INFO - TEST-INFO | 2208: exit 0 04:28:12 INFO - TEST-OK | kraken | took 60879ms 04:28:12 INFO - SUITE-END | took 1181s 04:28:12 INFO - Completed test suite (00:19:41) 04:28:12 INFO - javascript benchmark 04:28:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7033.570495930532, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3243.1567792373985, 3246.594175728034, 3249.155219642892, 3266.4120458317525, 3294.8682052717877, 5300.92048619271, 5369.597280203986, 5372.516473517383, 5397.406285308618, 5441.945580544193, 5346.0, 5350.5987050971235, 5378.273933019042, 5404.270423492827, 5406.54044406225, 4859.441164266119, 4872.926906096412, 4923.335349727777, 5030.673006254582, 5077.035363280965, 4989.775460104304, 5022.748862556876, 5075.695458272497, 5090.0, 5141.922871156936, 4027.4965629296194, 4920.704757714549, 4921.089598424303, 4934.728589927553, 4989.476105008976, 4939.234418665113, 4959.876003099916, 4962.826301079481, 5020.046191223692, 5032.043911656773, 4855.247436647325, 4910.0, 4932.334134891779, 4957.479464656231, 4978.079055374731, 5177.171652535576, 5215.269862219255, 5230.215467679878, 5366.624336296461, 5395.352557693062, 5705.971470142665, 5707.429257074301, 5718.513926316268, 5729.570282228808, 5731.971340143315, 4510.323451482271, 5697.145428185805, 5762.769489220426, 5766.884662306772, 5771.278590176228, 5397.568194544467, 5398.91901621476, 5404.594655400861, 5412.891742165174, 5413.539849112791, 4943.975280123648, 5932.080527518242, 5978.551608629283, 5987.401259874065, 6000.819975400745, 5761.135829625589, 5788.102844059177, 5792.536597072224, 5799.33307669615, 5801.361850196475, 5980.0, 5992.34084250732, 6046.09308603713, 6065.2418447694035, 6067.635941843503, 5981.7607295707685, 5993.850153746104, 5998.610090344114, 5998.850028749229, 6007.339192688801, 5742.942570574324, 5823.417658234227, 5960.8807823844145, 5966.522678185735, 5987.940120598825, 4787.880302992453, 4794.808207671724, 4795.088933102699, 4796.160671882407, 4807.062622788522, 4206.894827629272, 4212.599803018708, 4265.658747300208, 4334.631556317685, 4337.7180483268485, 5397.703126328011, 5492.505674489315, 5524.558035357162, 5526.557875369961, 5527.668339899619, 4256.36154576816, 5992.34084250732, 6016.278046634345, 6052.303985041688, 6081.331053584102, 5562.415946325658, 5563.332400111932, 5566.721663916788, 5569.554435645138, 5584.972075139598, 5066.847994560169, 5251.133562962068, 5266.315379000705, 5270.8155214567305, 5318.388385335658, 6123.648682309428, 6137.693115344304, 6138.940218748386, 6148.9692551536955, 6151.323354431099, 5823.301203855564, 5824.534037276923, 5825.184474173534, 5828.242328497268, 5843.590948633555, 5608.971955140361, 5859.619124756877, 6104.572679912541, 6133.028644416937, 6226.346233645583, 5970.343262241063, 5976.910346344721, 5977.013792724152, 5995.46040856325, 6014.36849130835, 6061.333253342041, 6066.423689749467, 6070.817875463743, 6073.908891366721, 6084.178635884099, 4753.263244197155, 5333.893322133458, 5621.437856214346, 5660.094384898396, 5799.130130480462, 5710.8572285691525, 5711.314642242957, 5717.113847353667, 5722.113072473773, 5724.885502290014, 5505.889882202414, 5587.74855131512, 5591.552675786009, 5600.747966341443, 5609.775608975595, 5724.169995350568, 5725.770969161187, 5730.71346432685, 5738.885222295447, 5739.0, 5533.253010843485, 5533.446655334435, 5587.3015873015875, 5598.188262701967, 5599.60802743804], "value": 5393.366404870748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.5121739260724, 451.3680846814459, 476.9308450274708, 485.63577317012243, 488.48708855701506, 24809.0, 28873.0, 38833.22333553331, 40812.59187408125, 41247.0, 35022.04625213714, 41287.55493557719, 41671.58328416715, 42225.78887105568, 42269.0, 9171.0, 9401.952990235073, 9409.012053734363, 9420.858687119664, 9434.339596228267, 6682.766103186389, 7401.592912389817, 7653.846923061536, 7740.187280335568, 7750.108737495204, 11183.384913829736, 11511.539538418496, 11531.962123408892, 11582.768344633145, 11659.183857130005, 11344.92223238791, 11409.20135590509, 11410.600628977945, 11434.942825285903, 11438.885611143949, 11196.496157672924, 11246.943765281203, 11264.774704505946, 11271.380074095921, 11299.887001129966, 24105.638415423782, 28580.428391432262, 28994.565081523793, 29084.70915290841, 29109.41781164386, 3340.0, 3651.707863370924, 3716.9814150929074, 3750.5311836020496, 3824.9808750956345, 28439.28901777472, 29033.0, 29277.414451710847, 30190.396192076256, 30267.848660756776, 2944.3522425066453, 3039.60485136933, 3091.8144911305394, 3137.090243829287, 3139.717425431699, 452658.0, 452693.0, 453239.0, 453407.7329613364, 464251.67874160415, 57157.714211428676, 57386.7130664344, 57387.426125739046, 57510.56223594444, 57538.7123064382, 64070.35929640644, 64086.0, 64213.35786642074, 64262.67868660627, 64300.0, 15069.849301507064, 15614.76577851333, 15621.765673514907, 15624.140672262907, 15672.138032408098, 11917.344546049877, 11998.520059197708, 12002.879971200351, 12013.699657508632, 12022.699432514082, 17197.226124824414, 17887.88578626923, 17914.820851791577, 17934.0, 17938.55153621144, 6608.372204640552, 6621.404073633396, 6637.042072588598, 6703.597784132968, 6718.697658605374, 820.5281962871372, 861.6854847980442, 863.700663465568, 866.882970798934, 889.4174315823146, 28772.70522826478, 29223.56164657532, 29312.0, 29447.26381840471, 29732.86644318389, 1022.7596514819012, 1023.8873723890366, 1055.757175849559, 1056.3028401255135, 1186.9525218991143, 14032.929835350758, 14464.638384040272, 14675.674464684851, 14825.77761333581, 14931.402743890123, 545447.0, 591344.0432797895, 591908.0, 592008.0, 592435.0, 52190.73904630452, 52466.475335246156, 52487.73756131195, 52510.0, 52601.210981835306, 1317.7496275707585, 1361.1900918953206, 1371.2869307960004, 1379.8689124533153, 1380.703148823008, 26898.865505672347, 26993.325166870985, 27807.304817378918, 28425.857870710515, 28442.0, 44855.0, 45613.315800263685, 45673.54326456693, 45680.543194568956, 45687.0, 500647.0, 503776.0, 504510.8910297063, 504810.0, 505389.0, 24062.714042165968, 24383.02467901264, 24598.754012460362, 24772.25683229506, 24779.76101194969, 41055.38416923808, 41185.79407103065, 41295.96760081022, 41691.58308416877, 42324.0, 32072.81729559927, 33184.66815331912, 33475.0, 34279.97160085201, 34833.9549813506, 33515.0, 33615.327693445506, 33636.831815840764, 34793.9561813146, 34952.82523587366, 33606.66393336035, 34275.31449371049, 34281.82859085689, 34439.0, 34473.827630861684, 28027.299317517227, 30047.248818779706, 30110.0, 30293.0, 30303.69696303097, 18474.81525184731, 22773.31680049601, 23297.0, 23562.764372356058, 23652.29043128709], "value": 18727.595937327325, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9363717712222, 346.9236767911059, 381.72515788632177, 389.1322351156921, 424.6751235304992, 12327.260364378144, 12562.623121306364, 14806.0, 15710.0, 19775.011249437506, 20368.130055289486, 20615.27846525372, 21137.837418941952, 21177.894110529425, 21368.89315553424, 5593.272874526316, 6080.452759251666, 6155.415235552616, 6176.598521096137, 6188.443040126388, 3566.982165089171, 3772.8304225689985, 3836.9424458633143, 6021.638701677914, 6125.693715314239, 4090.5295890972475, 4110.013596736777, 5707.200991861143, 6773.45812335012, 6773.864522709543, 6481.09264702942, 6662.86674266512, 6746.19045714515, 6750.257471678112, 6753.0, 5914.083317085859, 5926.585139040269, 5935.0, 5936.9406305937255, 5951.018082016505, 24598.0, 25363.23910282676, 25373.74626253751, 25382.746172538224, 25677.48645027089, 2660.308319836837, 2702.2028501592076, 2725.0734750184834, 2727.495413348517, 2744.794140439455, 10108.64619738313, 15332.233388330538, 15333.923330383277, 15476.380944762195, 16320.428784992468, 1810.8279713427203, 1814.482872381365, 1828.743975843383, 1839.4481655503296, 1861.6183682345222, 107728.0, 112225.0, 113043.0, 113864.43067784607, 115076.42461787722, 9162.496062716615, 10306.896931030744, 11225.382603956697, 11322.547098116147, 11544.689442856212, 12419.130660853654, 13409.128406653535, 14019.22894240806, 14052.85947140536, 14430.134191948517, 8250.711225107092, 8371.204735550113, 8430.915690843012, 8560.48637081777, 8621.180987806149, 8255.587220638945, 8267.173282671685, 8301.792455188668, 8442.493450392996, 8451.154884511623, 6942.132233470817, 7078.752243671447, 7084.752033678797, 7088.645567721594, 7090.468214883905, 1914.0812410043256, 1953.8827670339824, 1954.218312674913, 1964.666006778851, 1965.9115339809744, 1030.860833787429, 1035.4874337203132, 1036.8444733290066, 1042.74452759073, 1095.5782023920688, 21962.89018554897, 22206.333809985725, 22258.777412225994, 22288.77711222867, 22299.0, 882.6601758322963, 996.1433167475965, 1047.544318221576, 1087.456271864068, 1088.5264909764278, 10143.49282535885, 11055.858782973975, 11475.88524114765, 11603.709907252218, 11702.180847340604, 711560.0, 725025.0, 725651.0, 746178.0764384682, 746378.0, 107226.0, 116052.36978789224, 116146.41926790313, 117758.0, 119606.0, 885.4952676974192, 1033.844923261517, 1042.6819819954987, 1049.7638031443016, 1050.9369437833755, 18579.699421040397, 18830.623387531898, 19037.95291258994, 19074.0, 19126.0, 42693.35959960541, 49544.256836146764, 50375.74812125916, 50444.74777626088, 50542.0, 69057.65471172612, 69710.95433568602, 69945.0, 70151.0, 70257.64871175612, 6593.604383736991, 7815.179406162271, 8021.4786038909615, 8100.473469224482, 8100.756977290691, 10618.67266591676, 10698.518566664363, 12785.296808675612, 12883.291418972047, 13220.942324613816, 11075.335479871233, 11324.0, 11400.206949297475, 11406.885931140583, 11455.656330310105, 11027.0075693188, 11082.833757493805, 11146.944265278622, 11354.545818167511, 11372.601958931398, 10903.29128606638, 11469.541218351173, 11701.648950531498, 11712.355820429959, 11816.645500634995, 7497.962510187414, 8107.594620269081, 8121.431499795194, 8141.51150930946, 8351.665933362841, 10950.726231844268, 11118.27731197502, 11398.886011139783, 11422.029127523921, 11457.484413201593], "value": 9737.492716186096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.1323206076356, 1452.9927350363246, 1467.8825693944486, 1471.8896082793785, 1478.6894752102057, 7858.528488290699, 8266.173382661731, 8277.83444331113, 8283.75148745537, 8305.50166989981, 7852.842943141148, 8155.91844081559, 8156.632951517181, 8286.95856520718, 8307.252347288742, 2231.7545070042283, 2271.8409711320214, 2272.6363781794917, 2274.647429648407, 2276.590213761522, 2248.213125406103, 2273.761255068219, 2275.8065564427043, 2276.7495575486682, 2280.9885950570224, 2224.5995720770256, 2239.9347224709963, 2248.55028994201, 2258.141906075697, 2259.243153543565, 1991.7410736604222, 2126.0114046968156, 2212.8782916939563, 2241.5628952354296, 2249.4151520604596, 2165.083900747834, 2228.9969513718893, 2231.8549294295817, 2238.764929682376, 2240.260713964388, 8185.631646575918, 8275.668973241063, 8291.626876790559, 8297.294729947962, 8303.4602750821, 4938.580220681247, 5086.41506226785, 5090.236464530313, 5093.0577843099145, 5098.158803797369, 3131.671174526665, 3199.63204231514, 3350.480675495302, 3413.2661477782394, 3420.8973730788116, 1193.8806119388078, 1194.5162209305158, 1238.7708273969345, 1255.253124390986, 1255.7865162922326, 7868.488548244403, 9944.154746846527, 9962.452065136415, 10467.947660261727, 10471.005254500811, 3997.320455522568, 4104.958950410458, 4118.464599602033, 4151.709380343407, 4214.810333534998, 8469.534175620276, 8590.098039705741, 8625.568721563897, 8628.827423451496, 8651.95674021626, 4966.279889416014, 4980.77586508608, 4985.177445721415, 4995.850124496271, 4998.425181104147, 4465.933011004838, 4633.443986721615, 4656.208444564432, 4686.906261874743, 4698.459677137173, 3448.3448144852396, 3517.103138699615, 3563.073600863794, 3600.297941901304, 3600.6399360063783, 1114.4427786106946, 1115.9776804463866, 1116.7152376144031, 1128.0468004536153, 1130.8756036835941, 749.8350362920149, 753.276854219955, 761.6877080397011, 772.220057741685, 808.8139727862624, 4700.694454860423, 5678.346990096192, 5796.768129274866, 5809.854753631109, 5856.707164641751, 951.3007939164709, 971.3540495570508, 972.1833659725864, 992.389680346596, 998.3361064891766, 3699.648533389324, 3710.461983012448, 3747.7189210809297, 3840.5967373425947, 3846.9038274043373, 9392.906070939203, 9759.072888075621, 9761.316707830525, 9762.36544624597, 9766.951165244129, 9708.611655533841, 9720.027997200223, 9721.125098741148, 9728.124468797841, 9729.56216970238, 7584.127825300051, 7737.458377913605, 7740.612969351398, 7746.225377462321, 7813.648385822652, 5126.718030508208, 5325.976129070928, 5465.590080744039, 5473.480019398151, 5513.724313784375, 8615.138486151334, 8806.735797926072, 8992.28061755071, 9093.181613654539, 9103.135202155785, 8547.61535730906, 8612.052674205706, 8882.555872206492, 9240.95379523098, 9252.861207081765, 6966.7213311469, 7114.430845532448, 7115.146182458138, 7120.1099862517185, 7120.679569419285, 6917.377436030782, 7403.444741644291, 7415.406767458699, 7852.528848269122, 7859.960700196462, 6836.282190370139, 6898.620575868375, 6902.896456553055, 6987.475939304471, 7095.858082838417, 6833.214180369122, 6849.1780986281965, 6859.0, 6888.207856096613, 6941.965290173517, 6032.90950635732, 6254.655993920196, 6329.240491141092, 6335.303116657072, 6342.841428964128, 4744.8849520362, 4831.299461578122, 4861.1979023460735, 4900.411950565813, 5049.192129259301, 4665.2302370108555, 4923.433805112458, 4943.085529177114, 4998.575121114601, 5079.949200508096], "value": 4281.553135930654, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.16204112369553, 355.24155927095643, 361.5137639874369, 368.6460997442454, 372.5566575774828, 4498.5501449854955, 4828.444728856182, 4857.611391088713, 4947.1342515059905, 4969.652124351297, 4489.062031765065, 4697.835575754849, 5030.2957585938, 5114.718690472032, 5172.689638621685, 3632.164602141509, 3709.7757739945755, 3921.2549615573093, 3941.5664276929515, 4064.370022646487, 3179.9665108839604, 3977.7613343199355, 3978.4231286463446, 3997.6002399759936, 4012.418199361091, 3719.5164628598245, 3843.903902402434, 3851.5763266040713, 3874.321993651114, 3917.275304068742, 3254.7233485153793, 3763.7579598732354, 3833.7540299402667, 3884.2425726983392, 3904.3362628353248, 3279.475283954556, 3412.215190506173, 3412.84642191102, 3438.398280300937, 3448.9310213795584, 4596.988662494246, 4602.148602508513, 5029.170186919154, 5031.823886163967, 5072.568831649314, 4083.3058380075163, 4466.82132714691, 4476.657002899117, 4512.571305725951, 4522.1685217486975, 4843.39457567804, 5316.9202461963105, 5399.4341640924085, 5402.91895621566, 5429.619926605139, 3207.470767323389, 3266.70599646033, 3344.2976974835315, 3767.566729826078, 3774.301754175486, 4290.592393722592, 4944.777485013183, 5378.300820893298, 5425.643589102724, 5638.774449022034, 3743.745845141908, 3803.0, 3807.6573108420375, 3809.9809500952874, 3836.1176929306416, 3887.688984881203, 3892.4745159403683, 3893.552241492208, 3909.2963266611714, 3926.312895243321, 3618.9372057927253, 4180.435641188462, 4190.245755763992, 4558.521355257716, 4564.1556312082375, 5535.225068490334, 5538.421549858271, 5543.417941116125, 5548.334199896039, 5553.639013464192, 1079.7624522605015, 1117.932924024545, 1222.7982382906898, 1255.7944373401454, 1263.8041103628952, 793.2305663506389, 811.5374236685151, 846.4963346808639, 857.8155696525278, 862.7670528957146, 4326.4159338489535, 4440.245158323093, 4641.257398816173, 4744.596709279681, 4800.615950723934, 4732.574068333866, 5172.172452407597, 5263.763130659129, 5305.973470132702, 5335.0, 4142.08874047709, 4407.691461597721, 4926.96533727914, 4982.9252561211615, 5004.899902001939, 2404.8316617836936, 2503.632614133987, 2562.551553478134, 2653.6550248467574, 2768.4463107378606, 4922.433920099163, 4999.3000979862845, 5509.338879334506, 5670.489655930986, 5702.265016414255, 4515.661325400542, 4801.4958429365115, 5393.0, 5576.776928922879, 5827.155062515912, 4801.591864691401, 5455.236266922634, 5627.324721033502, 5919.644821310649, 5920.460680223173, 5198.298229738937, 5323.326904435927, 5680.15992003998, 5708.544321198068, 5711.514521265739, 4600.585947264628, 5196.714180720097, 5224.294720212874, 5598.1322894951345, 5619.719014049363, 5928.4960778334325, 5947.613405128653, 5967.671778052249, 5979.282486101695, 5990.700464976647, 3616.1502047018403, 3680.3743363628782, 3773.58490566032, 3814.5994670559194, 3845.807709614564, 4699.3420921071765, 4881.560659540658, 4964.875878102932, 5080.34888661194, 5623.8875222496135, 4719.3156992235245, 5374.704391258362, 5377.919331209957, 5392.568594512351, 5419.160030195326, 4837.467878533288, 5301.257823904733, 5395.0, 5523.106210121774, 5546.450271826116, 5133.820316288912, 5261.552768014762, 5356.973215133899, 5360.597955153301, 5432.266644003009, 4723.598494128038, 5194.870078287846, 5512.779488820403, 5514.503694667499, 5517.834464966058, 4240.321548552217, 4769.952300476951, 5176.559992400688, 5182.559482444034, 5346.572274218131], "value": 3924.8342959231527, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.6139342664819, 715.6254794344281, 776.3788968824939, 786.9556145109847, 810.4043528006915, 14117.011809173362, 14830.48093316734, 14837.777433338495, 16925.407610733626, 17803.198856051476, 15517.456889008887, 15695.37218511261, 16016.679666406664, 16285.51143465695, 16321.0, 908.4867050116679, 926.4441335198894, 931.3154831199063, 932.645594674023, 934.5794392523358, 889.2174886100223, 917.9036201198878, 918.0773322810566, 922.5202894494859, 926.1063074133493, 960.3949511807551, 969.3602222533129, 974.5370948799299, 976.9413835169912, 980.6763767956593, 968.3899143539595, 969.0648524174135, 969.6703120938879, 971.1114330387687, 971.3006635222629, 720.4272603280405, 721.0806222066907, 721.2715157690718, 721.3471808013755, 721.8953251778463, 13026.739465210738, 15232.923835380752, 15368.154751488664, 15392.769108463383, 15406.768898466533, 13687.31563421825, 13690.863091369058, 13984.650383740387, 14065.507707230197, 14342.49801256951, 11224.818175967059, 11416.60041898538, 11469.348811322216, 11635.30188188703, 12002.159848810586, 3602.3505685176733, 3618.8733394331334, 3674.595794462607, 3709.350863598859, 3717.0, 105108.0, 107195.39206911824, 107862.46068769685, 107870.38194427089, 108341.45829270882, 10390.792184156275, 10532.420716860493, 10681.392269058806, 10882.95179260562, 11030.50362733679, 22018.44953876166, 22129.66805497919, 22309.776902231093, 22416.66375004376, 22477.21329753451, 7414.14737305206, 7459.142198647117, 7492.887606685795, 7554.962225188949, 7707.537547747041, 4213.0310028693575, 4265.4881414230495, 4313.956860431418, 4323.329883868006, 4402.141582391403, 3499.160201551609, 3587.2466781976077, 3596.3166998270767, 3598.136447252693, 3599.1541987632886, 664.9202095748541, 670.5138774388529, 681.6012632609879, 687.3950923187663, 687.7317846040048, 632.2476253258608, 663.6880666086931, 669.625009994395, 698.8742026435189, 733.9339459448676, 7563.508371955805, 8781.473111613324, 9862.112409883002, 9864.408135511892, 10463.581456741646, 540.929679141717, 552.6242155334331, 617.7436363909018, 632.4659231722429, 682.494953734243, 4399.62603178727, 4626.902919890193, 4694.155052090657, 4848.806047758121, 4907.852764417074, 79222.60388698135, 84242.0, 84838.5758071218, 91973.0, 95444.52277738706, 50581.0, 58030.129548056815, 59136.0, 80485.0, 83908.0, 53120.0, 56172.0, 71651.0, 73378.0, 75885.9999999989, 9195.16128227014, 10346.689599312032, 10398.948005259925, 10502.159827213958, 10519.0, 43788.0, 45033.64899053034, 45045.774771125936, 45445.77277113593, 48885.0, 59789.402105978384, 62138.0, 62737.37262627315, 63656.0, 65119.674401627686, 12192.011477647453, 12336.3215023171, 12369.0, 12512.499500019898, 12851.678708032374, 13534.184920268839, 13829.446822127002, 14037.859621403655, 14043.50847720325, 14450.783238251224, 12798.488060477848, 12830.524489683807, 12937.382827146606, 12940.352982350656, 13127.868721312665, 12934.482620695067, 13069.281189534286, 13102.0, 13291.800622990857, 13502.392392342565, 11292.209545332076, 12409.689757756129, 12452.937735311265, 12493.921741805847, 12859.871401285867, 9954.185135732096, 10001.599936002478, 10074.044625552908, 10200.38797672142, 10313.535890884777, 8518.488890666333, 9195.0, 9741.366811157252, 9749.317547771872, 9850.408975461496], "value": 7324.771808987975, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1480.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 112.0, 115.0, 113.0, 113.0, 112.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 141.0, 113.0, 151.0, 114.0, 114.0, 113.0, 112.0, 135.0, 112.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 185.0, 188.0, 188.0, 188.0, 184.0, 187.0, 184.0, 197.0], "value": 187.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 60.0, 93.0, 64.0, 61.0, 59.0, 60.0, 76.0, 61.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 87.0, 68.0, 62.0, 57.0, 87.0, 97.0, 98.0, 115.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 88.0, 89.0, 91.0, 89.0, 88.0, 87.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 101.0, 138.0, 135.0, 88.0, 85.0, 87.0, 88.0, 87.0], "value": 98.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 63.0, 65.0, 61.0, 62.0, 60.0, 61.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 69.0, 76.0, 74.0, 68.0, 68.0, 68.0, 69.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 88.0, 94.0, 105.0, 85.0, 86.0, 89.0, 89.0, 87.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 147.0, 143.0, 137.0, 148.0, 146.0, 143.0, 130.0, 183.0, 141.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 173.0, 173.0, 177.0, 174.0, 175.0, 212.0, 172.0, 171.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 81.0, 84.0, 85.0, 86.0, 74.0, 66.0, 67.0, 63.0, 65.0], "value": 73.9, "unit": "score"}]}]} 04:28:13 INFO - Return code: 0 04:28:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:28:13 ERROR - # TBPL SUCCESS # 04:28:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:13 INFO - 2017-02-24 04:28:13.089 screenresolution[2212:22479] starting screenresolution argv=screenresolution get 04:28:13 INFO - 2017-02-24 04:28:13.092 screenresolution[2212:22479] Display 0: 1600x1200x32@60 04:28:13 INFO - 2017-02-24 04:28:13.098 screenresolution[2213:22482] starting screenresolution argv=screenresolution list 04:28:13 INFO - Available Modes on Display 0 04:28:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:13 INFO - Intel Iris: 04:28:13 INFO - Chipset Model: Intel Iris 04:28:13 INFO - Type: GPU 04:28:13 INFO - Bus: Built-In 04:28:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:13 INFO - Vendor: Intel (0x8086) 04:28:13 INFO - Device ID: 0x0a2e 04:28:13 INFO - Revision ID: 0x0009 04:28:13 INFO - Displays: 04:28:13 INFO - Display: 04:28:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:13 INFO - Display Serial Number: 1600x1200 60 04:28:13 INFO - Main Display: Yes 04:28:13 INFO - Mirror: Off 04:28:13 INFO - Online: Yes 04:28:13 INFO - Rotation: Supported 04:28:13 INFO - Return code: 0 04:28:13 INFO - Running post-action listener: _resource_record_post_action 04:28:13 INFO - [mozharness: 2017-02-24 12:28:13.337463Z] Finished run-tests step (success) 04:28:13 INFO - Running post-run listener: _resource_record_post_run 04:28:13 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 491520; Write bytes: 510788096; Read time: 2; Write time: 1619 04:28:13 INFO - TinderboxPrint: CPU usage
53.9% 04:28:13 INFO - TinderboxPrint: I/O read bytes / time
491,520 / 2 04:28:13 INFO - TinderboxPrint: I/O write bytes / time
510,788,096 / 1,619 04:28:13 INFO - TinderboxPrint: CPU idle
2,219.0 (46.1%) 04:28:13 INFO - TinderboxPrint: CPU system
965.6 (20.1%) 04:28:13 INFO - TinderboxPrint: CPU user
1,629.1 (33.8%) 04:28:13 INFO - TinderboxPrint: Swap in / out
210,415,616 / 0 04:28:13 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203864576; Write bytes: 201670656; Read time: 15874; Write time: 450 04:28:13 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 491520; Write bytes: 298435072; Read time: 2; Write time: 1134 04:28:13 INFO - Running post-run listener: _upload_blobber_files 04:28:13 INFO - Blob upload gear active. 04:28:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:28:15 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:17 INFO - (blobuploader) - INFO - Done attempting. 04:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:19 INFO - (blobuploader) - INFO - Done attempting. 04:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:28:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:22 INFO - (blobuploader) - INFO - Done attempting. 04:28:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:28:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:27 INFO - (blobuploader) - INFO - Done attempting. 04:28:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:27 INFO - Return code: 0 04:28:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59c134771f307ecc0ab631e2783de16365c16f0711191e2e9d50cec14e802c0329257a58aec0317b0b19be52a4c8a02bf72cfb0fdb34ea15806cd99d2d56e821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8a2952bf0f534e013ff5156e3d6bf181cb43af377bf3cd50240d8c1b9746bf2725d3ab986531a5b7c5b6aa638c74369201fa86f83d8e8e64ba6d8fc0a1e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2130f9b987543b8f41beafd60aa42ff1207bbe57420630c545b5fd136be4842016e74a15756eb516ab3af6b6c8981207253870f20001a545d956b357cf424947", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8fba5eb728f9cc188d02e6fd6d09a94e7d43ee21c342c0ddd592da208db5f632699d3abfb4c83df8c41181a6c3b7a3caab125e6e7fafdc2eeac85c026c46201"} 04:28:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:27 INFO - Contents: 04:28:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59c134771f307ecc0ab631e2783de16365c16f0711191e2e9d50cec14e802c0329257a58aec0317b0b19be52a4c8a02bf72cfb0fdb34ea15806cd99d2d56e821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8a2952bf0f534e013ff5156e3d6bf181cb43af377bf3cd50240d8c1b9746bf2725d3ab986531a5b7c5b6aa638c74369201fa86f83d8e8e64ba6d8fc0a1e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2130f9b987543b8f41beafd60aa42ff1207bbe57420630c545b5fd136be4842016e74a15756eb516ab3af6b6c8981207253870f20001a545d956b357cf424947", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8fba5eb728f9cc188d02e6fd6d09a94e7d43ee21c342c0ddd592da208db5f632699d3abfb4c83df8c41181a6c3b7a3caab125e6e7fafdc2eeac85c026c46201"} 04:28:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:27 INFO - Copying logs to upload dir... 04:28:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.788968 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-02-24 04:28:28.201754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 04:28:28.204972) ========= 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.vABMHrwrWT/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.C2z6I98P8O/Listeners TMPDIR=/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59c134771f307ecc0ab631e2783de16365c16f0711191e2e9d50cec14e802c0329257a58aec0317b0b19be52a4c8a02bf72cfb0fdb34ea15806cd99d2d56e821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8a2952bf0f534e013ff5156e3d6bf181cb43af377bf3cd50240d8c1b9746bf2725d3ab986531a5b7c5b6aa638c74369201fa86f83d8e8e64ba6d8fc0a1e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2130f9b987543b8f41beafd60aa42ff1207bbe57420630c545b5fd136be4842016e74a15756eb516ab3af6b6c8981207253870f20001a545d956b357cf424947", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8fba5eb728f9cc188d02e6fd6d09a94e7d43ee21c342c0ddd592da208db5f632699d3abfb4c83df8c41181a6c3b7a3caab125e6e7fafdc2eeac85c026c46201"} build_url:https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/Rg0HVnHNSa-T9UmeLbJhvw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59c134771f307ecc0ab631e2783de16365c16f0711191e2e9d50cec14e802c0329257a58aec0317b0b19be52a4c8a02bf72cfb0fdb34ea15806cd99d2d56e821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8a2952bf0f534e013ff5156e3d6bf181cb43af377bf3cd50240d8c1b9746bf2725d3ab986531a5b7c5b6aa638c74369201fa86f83d8e8e64ba6d8fc0a1e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2130f9b987543b8f41beafd60aa42ff1207bbe57420630c545b5fd136be4842016e74a15756eb516ab3af6b6c8981207253870f20001a545d956b357cf424947", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8fba5eb728f9cc188d02e6fd6d09a94e7d43ee21c342c0ddd592da208db5f632699d3abfb4c83df8c41181a6c3b7a3caab125e6e7fafdc2eeac85c026c46201"}' ========= master_lag: 0.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 04:28:28.834743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 04:28:28.835062) ========= 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.vABMHrwrWT/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.C2z6I98P8O/Listeners TMPDIR=/var/folders/4z/g2dtsn9d40n5qvzk37q47mnc00000w/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.004867 ========= master_lag: 0.42 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 04:28:29.255696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 04:28:29.256018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 04:28:29.256423) ========= ========= Total master_lag: 1.67 =========