builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0153 starttime: 1486602502.33 results: success (0) buildid: 20170208154822 builduid: aca3930e4184426fa445d5cd9b194885 revision: 438b18daff7aa9a760f2435c1d89f188c7c4c13e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.329585) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.330119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.330429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.353285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.353595) ========= 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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-08 17:08:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 211M=0s 2017-02-08 17:08:22 (211 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.497095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.497409) ========= 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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.020254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:22.547003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-08 17:08:22.547458) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 438b18daff7aa9a760f2435c1d89f188c7c4c13e --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 438b18daff7aa9a760f2435c1d89f188c7c4c13e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LhD8pGbIgI/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.9eQDyqLuqf/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-08 17:08:22,633 truncating revision to first 12 chars 2017-02-08 17:08:22,634 Setting DEBUG logging. 2017-02-08 17:08:22,634 attempt 1/10 2017-02-08 17:08:22,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/438b18daff7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 17:08:24,609 unpacking tar archive at: mozilla-central-438b18daff7a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.236202 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-08 17:08:24.808792) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:24.809174) ========= script_repo_revision: 438b18daff7aa9a760f2435c1d89f188c7c4c13e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:24.809831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:24.810147) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 17:08:24.830244) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-08 17:08:24.830593) ========= /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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:08:25 INFO - MultiFileLogger online at 20170208 17:08:25 in /builds/slave/test 17:08:25 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 17:08:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:25 INFO - {'append_to_log': False, 17:08:25 INFO - 'base_work_dir': '/builds/slave/test', 17:08:25 INFO - 'blob_upload_branch': 'Firefox', 17:08:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:25 INFO - 'branch': 'Firefox', 17:08:25 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:25 INFO - 'config_files': ('talos/mac_config.py',), 17:08:25 INFO - 'default_actions': ('clobber', 17:08:25 INFO - 'read-buildbot-config', 17:08:25 INFO - 'download-and-extract', 17:08:25 INFO - 'populate-webroot', 17:08:25 INFO - 'create-virtualenv', 17:08:25 INFO - 'install', 17:08:25 INFO - 'run-tests'), 17:08:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:25 INFO - 'download_minidump_stackwalk': True, 17:08:25 INFO - 'download_symbols': 'ondemand', 17:08:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:25 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:25 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:25 INFO - 'installer_path': 'installer.exe', 17:08:25 INFO - 'log_level': 'info', 17:08:25 INFO - 'log_name': 'talos', 17:08:25 INFO - 'log_to_console': True, 17:08:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:08:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:08:25 INFO - 'opt_config_files': (), 17:08:25 INFO - 'pip_index': False, 17:08:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:25 INFO - 'cmd': ('bash', 17:08:25 INFO - '-c', 17:08:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:25 INFO - 'enabled': True, 17:08:25 INFO - 'halt_on_failure': False, 17:08:25 INFO - 'name': 'check_screen_resolution'},), 17:08:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:25 INFO - 'cmd': ('bash', 17:08:25 INFO - '-c', 17:08:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:25 INFO - 'enabled': True, 17:08:25 INFO - 'halt_on_failure': False, 17:08:25 INFO - 'name': 'check_screen_resolution'},), 17:08:25 INFO - 'run_cmd_checks_enabled': True, 17:08:25 INFO - 'sps_profile': False, 17:08:25 INFO - 'sps_profile_interval': 0, 17:08:25 INFO - 'suite': 'dromaeojs', 17:08:25 INFO - 'system_bits': '32', 17:08:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:25 INFO - 'title': 't-yosemite-r7-0153', 17:08:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:25 INFO - 'use_talos_json': True, 17:08:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:25 INFO - 'work_dir': 'build'} 17:08:25 INFO - [mozharness: 2017-02-09 01:08:25.045734Z] Running clobber step. 17:08:25 INFO - Running pre-action listener: _resource_record_pre_action 17:08:25 INFO - Running main action method: clobber 17:08:25 INFO - rmtree: /builds/slave/test/build 17:08:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:25 INFO - Running post-action listener: _resource_record_post_action 17:08:25 INFO - [mozharness: 2017-02-09 01:08:25.715802Z] Finished clobber step (success) 17:08:25 INFO - [mozharness: 2017-02-09 01:08:25.715939Z] Running read-buildbot-config step. 17:08:25 INFO - Running pre-action listener: _resource_record_pre_action 17:08:25 INFO - Running main action method: read_buildbot_config 17:08:25 INFO - Using buildbot properties: 17:08:25 INFO - { 17:08:25 INFO - "project": "", 17:08:25 INFO - "product": "firefox", 17:08:25 INFO - "script_repo_revision": "production", 17:08:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:08:25 INFO - "repository": "", 17:08:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:08:25 INFO - "buildid": "20170208154822", 17:08:25 INFO - "pgo_build": "False", 17:08:25 INFO - "basedir": "/builds/slave/test", 17:08:25 INFO - "buildnumber": 129, 17:08:25 INFO - "slavename": "t-yosemite-r7-0153", 17:08:25 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:08:25 INFO - "platform": "yosemite_r7", 17:08:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:08:25 INFO - "branch": "mozilla-central", 17:08:25 INFO - "repo_path": "mozilla-central", 17:08:25 INFO - "revision": "438b18daff7aa9a760f2435c1d89f188c7c4c13e", 17:08:25 INFO - "stage_platform": "macosx64", 17:08:25 INFO - "builduid": "aca3930e4184426fa445d5cd9b194885", 17:08:25 INFO - "slavebuilddir": "test" 17:08:25 INFO - } 17:08:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 17:08:25 INFO - Running post-action listener: _resource_record_post_action 17:08:25 INFO - [mozharness: 2017-02-09 01:08:25.719373Z] Finished read-buildbot-config step (success) 17:08:25 INFO - [mozharness: 2017-02-09 01:08:25.719499Z] Running download-and-extract step. 17:08:25 INFO - Running pre-action listener: _resource_record_pre_action 17:08:25 INFO - Running main action method: download_and_extract 17:08:25 INFO - mkdir: /builds/slave/test/build/tests 17:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:25 INFO - trying https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 17:08:25 INFO - Downloading https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/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 17:08:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/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 17:08:27 INFO - Downloaded 1199 bytes. 17:08:27 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:08:27 INFO - Using the following test package requirements: 17:08:27 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:08:27 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 17:08:27 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 17:08:27 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'jsshell-mac.zip'], 17:08:27 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 17:08:27 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:08:27 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 17:08:27 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 17:08:27 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 17:08:27 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:08:27 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 17:08:27 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:08:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:08:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:08:27 INFO - Fetch https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:08:28 INFO - Expected file size: 34939103 17:08:28 INFO - Obtained file size: 34939103 17:08:35 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 17:08:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:08:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:08:35 INFO - Fetch https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:08:36 INFO - Expected file size: 34939103 17:08:36 INFO - Obtained file size: 34939103 17:08:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 17:08:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:08:43 INFO - Fetch https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 17:08:45 INFO - Expected file size: 14403454 17:08:45 INFO - Obtained file size: 14403454 17:08:45 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')]} 17:08:45 INFO - trying https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:08:45 INFO - Downloading https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 17:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/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 17:08:47 INFO - Downloaded 70364462 bytes. 17:08:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:08:47 INFO - mkdir: /builds/slave/test/properties 17:08:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:47 INFO - Contents: 17:08:47 INFO - build_url:https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:08:48 INFO - Running post-action listener: _resource_record_post_action 17:08:48 INFO - Running post-action listener: set_extra_try_arguments 17:08:48 INFO - [mozharness: 2017-02-09 01:08:48.229411Z] Finished download-and-extract step (success) 17:08:48 INFO - [mozharness: 2017-02-09 01:08:48.229544Z] Running populate-webroot step. 17:08:48 INFO - Running pre-action listener: _resource_record_pre_action 17:08:48 INFO - Running main action method: populate_webroot 17:08:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:48 INFO - '--tppagecycles', 17:08:48 INFO - '7'], 17:08:48 INFO - 'tests': ['tsvgm']}}, 17:08:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:08:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:08:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:08:48 INFO - 'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:08:48 INFO - 'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['damp', 'tps']}, 17:08:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:08:48 INFO - 'tests': ['damp', 'tps']}, 17:08:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['dromaeo_dom']}, 17:08:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['basic_compositor_video']}, 17:08:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:08:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['a11yr', 17:08:48 INFO - 'ts_paint', 17:08:48 INFO - 'tpaint', 17:08:48 INFO - 'sessionrestore', 17:08:48 INFO - 'sessionrestore_no_auto_restore', 17:08:48 INFO - 'tabpaint']}, 17:08:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:08:48 INFO - 'ts_paint', 17:08:48 INFO - 'tpaint', 17:08:48 INFO - 'sessionrestore', 17:08:48 INFO - 'sessionrestore_no_auto_restore', 17:08:48 INFO - 'tabpaint']}, 17:08:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:08:48 INFO - 'ts_paint', 17:08:48 INFO - 'tpaint', 17:08:48 INFO - 'sessionrestore', 17:08:48 INFO - 'sessionrestore_no_auto_restore', 17:08:48 INFO - 'tabpaint']}, 17:08:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:08:48 INFO - 'ts_paint', 17:08:48 INFO - 'tpaint', 17:08:48 INFO - 'sessionrestore', 17:08:48 INFO - 'sessionrestore_no_auto_restore', 17:08:48 INFO - 'tabpaint']}, 17:08:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['a11yr', 17:08:48 INFO - 'ts_paint', 17:08:48 INFO - 'tpaint', 17:08:48 INFO - 'sessionrestore', 17:08:48 INFO - 'sessionrestore_no_auto_restore', 17:08:48 INFO - 'tabpaint']}, 17:08:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['a11yr', 17:08:48 INFO - 'ts_paint', 17:08:48 INFO - 'tpaint', 17:08:48 INFO - 'sessionrestore', 17:08:48 INFO - 'sessionrestore_no_auto_restore', 17:08:48 INFO - 'tabpaint']}, 17:08:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['tsvgx', 17:08:48 INFO - 'tsvgr_opacity', 17:08:48 INFO - 'tart', 17:08:48 INFO - 'tscrollx', 17:08:48 INFO - 'cart', 17:08:48 INFO - 'tsvg_static']}, 17:08:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:08:48 INFO - 'tsvgr_opacity', 17:08:48 INFO - 'tart', 17:08:48 INFO - 'tscrollx', 17:08:48 INFO - 'cart', 17:08:48 INFO - 'tsvg_static']}, 17:08:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:08:48 INFO - 'talos_options': ['--disable-e10s'], 17:08:48 INFO - 'tests': ['tp5o']}, 17:08:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:08:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:08:48 INFO - 'talos_options': ['--disable-e10s', 17:08:48 INFO - '--xperf_path', 17:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:48 INFO - 'tests': ['tp5n']}, 17:08:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:08:48 INFO - 'talos_options': ['--xperf_path', 17:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:48 INFO - 'tests': ['tp5n']}}, 17:08:48 INFO - 'talos.zip': {'path': '', 17:08:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:48 INFO - Running post-action listener: _resource_record_post_action 17:08:48 INFO - [mozharness: 2017-02-09 01:08:48.248323Z] Finished populate-webroot step (success) 17:08:48 INFO - [mozharness: 2017-02-09 01:08:48.248434Z] Running create-virtualenv step. 17:08:48 INFO - Running pre-action listener: _resource_record_pre_action 17:08:48 INFO - Running main action method: create_virtualenv 17:08:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:48 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 17:08:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:48 INFO - Using real prefix '/tools/python27' 17:08:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:52 INFO - Installing pip.................done. 17:08:52 INFO - Return code: 0 17:08:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:08:52 INFO - Reading from file tmpfile_stdout 17:08:52 INFO - Output received: 17:08:52 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) 17:08:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:52 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')]} 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:52 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')]} 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:52 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:08:52 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 17:08:52 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 17:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:52 INFO - 'HOME': '/Users/cltbld', 17:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:52 INFO - 'LOGNAME': 'cltbld', 17:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:52 INFO - 'MOZ_NO_REMOTE': '1', 17:08:52 INFO - 'NO_EM_RESTART': '1', 17:08:52 INFO - 'PAGER': '/bin/cat', 17:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:52 INFO - 'PWD': '/builds/slave/test', 17:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:52 INFO - 'SHELL': '/bin/bash', 17:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:08:52 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:52 INFO - 'USER': 'cltbld', 17:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:52 INFO - 'XPC_FLAGS': '0x0', 17:08:52 INFO - 'XPC_SERVICE_NAME': '0', 17:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:52 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 17:08:52 INFO - Cleaning up... 17:08:52 INFO - Return code: 0 17:08:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:08:52 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')]} 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:52 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')]} 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:52 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:08:52 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 17:08:52 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 17:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:52 INFO - 'HOME': '/Users/cltbld', 17:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:52 INFO - 'LOGNAME': 'cltbld', 17:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:52 INFO - 'MOZ_NO_REMOTE': '1', 17:08:52 INFO - 'NO_EM_RESTART': '1', 17:08:52 INFO - 'PAGER': '/bin/cat', 17:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:52 INFO - 'PWD': '/builds/slave/test', 17:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:52 INFO - 'SHELL': '/bin/bash', 17:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:08:52 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:52 INFO - 'USER': 'cltbld', 17:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:52 INFO - 'XPC_FLAGS': '0x0', 17:08:52 INFO - 'XPC_SERVICE_NAME': '0', 17:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:52 INFO - Downloading/unpacking psutil>=3.1.1 17:08:52 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 17:08:52 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 17:08:52 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 17:08:52 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 17:08:52 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 17:08:52 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 17:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:56 INFO - Installing collected packages: psutil 17:08:56 INFO - Running setup.py install for psutil 17:08:56 INFO - building 'psutil._psutil_osx' extension 17:08:56 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 17:08:56 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 17:08:56 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 17:08:56 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 17:08:56 INFO - building 'psutil._psutil_posix' extension 17:08:56 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 17:08:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:08:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:08:57 INFO - ^ 17:08:57 INFO - 1 warning generated. 17:08:57 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 17:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:57 INFO - Successfully installed psutil 17:08:57 INFO - Cleaning up... 17:08:57 INFO - Return code: 0 17:08:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:57 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:08:57 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 17:08:57 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 17:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:57 INFO - 'HOME': '/Users/cltbld', 17:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:57 INFO - 'LOGNAME': 'cltbld', 17:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:57 INFO - 'MOZ_NO_REMOTE': '1', 17:08:57 INFO - 'NO_EM_RESTART': '1', 17:08:57 INFO - 'PAGER': '/bin/cat', 17:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:57 INFO - 'PWD': '/builds/slave/test', 17:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:57 INFO - 'SHELL': '/bin/bash', 17:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:08:57 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:57 INFO - 'USER': 'cltbld', 17:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:57 INFO - 'XPC_FLAGS': '0x0', 17:08:57 INFO - 'XPC_SERVICE_NAME': '0', 17:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:09:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:09:00 INFO - Installing collected packages: mozsystemmonitor 17:09:00 INFO - Running setup.py install for mozsystemmonitor 17:09:00 INFO - Successfully installed mozsystemmonitor 17:09:00 INFO - Cleaning up... 17:09:00 INFO - Return code: 0 17:09:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:00 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:09:00 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 17:09:00 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 17:09:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:00 INFO - 'HOME': '/Users/cltbld', 17:09:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:00 INFO - 'LOGNAME': 'cltbld', 17:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:00 INFO - 'MOZ_NO_REMOTE': '1', 17:09:00 INFO - 'NO_EM_RESTART': '1', 17:09:00 INFO - 'PAGER': '/bin/cat', 17:09:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:00 INFO - 'PWD': '/builds/slave/test', 17:09:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:00 INFO - 'SHELL': '/bin/bash', 17:09:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:00 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:00 INFO - 'USER': 'cltbld', 17:09:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:00 INFO - 'XPC_FLAGS': '0x0', 17:09:00 INFO - 'XPC_SERVICE_NAME': '0', 17:09:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:00 INFO - Downloading/unpacking jsonschema==2.5.1 17:09:00 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 17:09:00 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 17:09:00 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 17:09:00 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 17:09:00 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 17:09:00 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 17:09:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09:03 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 17:09:03 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 17:09:03 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 17:09:03 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 17:09:03 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 17:09:03 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 17:09:03 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:03 INFO - warning: no files found matching '*.txt' 17:09:03 INFO - no previously-included directories found matching 'build' 17:09:03 INFO - no previously-included directories found matching 'dist' 17:09:03 INFO - no previously-included directories found matching '.git*' 17:09:03 INFO - Installing collected packages: jsonschema, functools32 17:09:03 INFO - Running setup.py install for functools32 17:09:04 INFO - warning: no files found matching '*.txt' 17:09:04 INFO - no previously-included directories found matching 'build' 17:09:04 INFO - no previously-included directories found matching 'dist' 17:09:04 INFO - no previously-included directories found matching '.git*' 17:09:04 INFO - Successfully installed jsonschema functools32 17:09:04 INFO - Cleaning up... 17:09:04 INFO - Return code: 0 17:09:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:09:04 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')]} 17:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 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')]} 17:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:09:04 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 17:09:04 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 17:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:04 INFO - 'HOME': '/Users/cltbld', 17:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:04 INFO - 'LOGNAME': 'cltbld', 17:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:04 INFO - 'MOZ_NO_REMOTE': '1', 17:09:04 INFO - 'NO_EM_RESTART': '1', 17:09:04 INFO - 'PAGER': '/bin/cat', 17:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:04 INFO - 'PWD': '/builds/slave/test', 17:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:04 INFO - 'SHELL': '/bin/bash', 17:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:04 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:04 INFO - 'USER': 'cltbld', 17:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:04 INFO - 'XPC_FLAGS': '0x0', 17:09:04 INFO - 'XPC_SERVICE_NAME': '0', 17:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:09:04 INFO - Cleaning up... 17:09:04 INFO - Return code: 0 17:09:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:04 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')]} 17:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 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')]} 17:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:09:04 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 17:09:04 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 17:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:04 INFO - 'HOME': '/Users/cltbld', 17:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:04 INFO - 'LOGNAME': 'cltbld', 17:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:04 INFO - 'MOZ_NO_REMOTE': '1', 17:09:04 INFO - 'NO_EM_RESTART': '1', 17:09:04 INFO - 'PAGER': '/bin/cat', 17:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:04 INFO - 'PWD': '/builds/slave/test', 17:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:04 INFO - 'SHELL': '/bin/bash', 17:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:04 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:04 INFO - 'USER': 'cltbld', 17:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:04 INFO - 'XPC_FLAGS': '0x0', 17:09:04 INFO - 'XPC_SERVICE_NAME': '0', 17:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:04 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 17:09:04 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 17:09:04 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 17:09:04 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 17:09:04 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 17:09:04 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 17:09:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:08 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 17:09:08 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 17:09:08 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 17:09:08 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 17:09:08 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 17:09:08 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 17:09:08 INFO - Downloading docopt-0.6.1.tar.gz 17:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:08 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:08 INFO - Running setup.py install for blobuploader 17:09:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:08 INFO - Running setup.py install for requests 17:09:09 INFO - Running setup.py install for docopt 17:09:09 INFO - Successfully installed blobuploader requests docopt 17:09:09 INFO - Cleaning up... 17:09:09 INFO - Return code: 0 17:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:09 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:09:09 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 17:09:09 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 17:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:09 INFO - 'HOME': '/Users/cltbld', 17:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:09 INFO - 'LOGNAME': 'cltbld', 17:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:09 INFO - 'MOZ_NO_REMOTE': '1', 17:09:09 INFO - 'NO_EM_RESTART': '1', 17:09:09 INFO - 'PAGER': '/bin/cat', 17:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:09 INFO - 'PWD': '/builds/slave/test', 17:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:09 INFO - 'SHELL': '/bin/bash', 17:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:09 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:09 INFO - 'USER': 'cltbld', 17:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:09 INFO - 'XPC_FLAGS': '0x0', 17:09:09 INFO - 'XPC_SERVICE_NAME': '0', 17:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:09 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ZPnJRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:09 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_KCbK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-SUz0J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-15IPx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-1TRnKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-xGgCkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-u_nA8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-hdN78L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-4FFC6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-x6zc6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:10 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-p2pK29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Z5hwII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VKTfPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-D5laH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-PsJL0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-H_3a8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-YOV9RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:11 INFO - Running setup.py install for manifestparser 17:09:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:11 INFO - Running setup.py install for mozcrash 17:09:11 INFO - Running setup.py install for mozdebug 17:09:12 INFO - Running setup.py install for mozdevice 17:09:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Running setup.py install for mozfile 17:09:12 INFO - Running setup.py install for mozhttpd 17:09:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Running setup.py install for mozinfo 17:09:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Running setup.py install for mozInstall 17:09:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:12 INFO - Running setup.py install for mozleak 17:09:12 INFO - Running setup.py install for mozlog 17:09:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:13 INFO - Running setup.py install for moznetwork 17:09:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:13 INFO - Running setup.py install for mozprocess 17:09:13 INFO - Running setup.py install for mozprofile 17:09:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:13 INFO - Running setup.py install for mozrunner 17:09:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:13 INFO - Running setup.py install for mozscreenshot 17:09:13 INFO - Running setup.py install for moztest 17:09:14 INFO - Running setup.py install for mozversion 17:09:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:14 INFO - Cleaning up... 17:09:14 INFO - Return code: 0 17:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:09:14 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 17:09:14 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 17:09:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:14 INFO - 'HOME': '/Users/cltbld', 17:09:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:14 INFO - 'LOGNAME': 'cltbld', 17:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:14 INFO - 'MOZ_NO_REMOTE': '1', 17:09:14 INFO - 'NO_EM_RESTART': '1', 17:09:14 INFO - 'PAGER': '/bin/cat', 17:09:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:14 INFO - 'PWD': '/builds/slave/test', 17:09:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:14 INFO - 'SHELL': '/bin/bash', 17:09:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:14 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:14 INFO - 'USER': 'cltbld', 17:09:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:14 INFO - 'XPC_FLAGS': '0x0', 17:09:14 INFO - 'XPC_SERVICE_NAME': '0', 17:09:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VuyvBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:14 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)) 17:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-P2YBff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:14 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)) 17:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_XyLYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:14 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)) 17:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-fhX0Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:14 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)) 17:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-rSyvef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-DHttKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-6bYpUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-OwEoZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-bEO_lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vsxTHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-io5eYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ZTjhpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7_WQ7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-bhVtt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:15 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)) 17:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-k_sMDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:16 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)) 17:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-nEFGTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:16 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)) 17:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-RqV0P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:16 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)) 17:09:16 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)) 17:09:16 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)) 17:09:16 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)) 17:09:16 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)) 17:09:16 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)) 17:09:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:16 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 17:09:16 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 17:09:16 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 17:09:16 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 17:09:16 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 17:09:16 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 17:09:19 INFO - Downloading blessings-1.6.tar.gz 17:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:19 INFO - Installing collected packages: blessings 17:09:19 INFO - Running setup.py install for blessings 17:09:20 INFO - Successfully installed blessings 17:09:20 INFO - Cleaning up... 17:09:20 INFO - Return code: 0 17:09:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:20 INFO - Reading from file tmpfile_stdout 17:09:20 INFO - Current package versions: 17:09:20 INFO - blessings == 1.6 17:09:20 INFO - blobuploader == 1.2.4 17:09:20 INFO - docopt == 0.6.1 17:09:20 INFO - functools32 == 3.2.3-2 17:09:20 INFO - jsonschema == 2.5.1 17:09:20 INFO - manifestparser == 1.1 17:09:20 INFO - mozInstall == 1.12 17:09:20 INFO - mozcrash == 1.0 17:09:20 INFO - mozdebug == 0.1 17:09:20 INFO - mozdevice == 0.49 17:09:20 INFO - mozfile == 1.2 17:09:20 INFO - mozhttpd == 0.7 17:09:20 INFO - mozinfo == 0.9 17:09:20 INFO - mozleak == 0.1 17:09:20 INFO - mozlog == 3.4 17:09:20 INFO - moznetwork == 0.27 17:09:20 INFO - mozprocess == 0.24 17:09:20 INFO - mozprofile == 0.28 17:09:20 INFO - mozrunner == 6.13 17:09:20 INFO - mozscreenshot == 0.1 17:09:20 INFO - mozsystemmonitor == 0.3 17:09:20 INFO - moztest == 0.8 17:09:20 INFO - mozversion == 1.4 17:09:20 INFO - psutil == 3.1.1 17:09:20 INFO - requests == 1.2.3 17:09:20 INFO - wsgiref == 0.1.2 17:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:20 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')]} 17:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:20 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')]} 17:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:21 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:09:21 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 17:09:21 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 17:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:21 INFO - 'HOME': '/Users/cltbld', 17:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:21 INFO - 'LOGNAME': 'cltbld', 17:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:21 INFO - 'MOZ_NO_REMOTE': '1', 17:09:21 INFO - 'NO_EM_RESTART': '1', 17:09:21 INFO - 'PAGER': '/bin/cat', 17:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:21 INFO - 'PWD': '/builds/slave/test', 17:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:21 INFO - 'SHELL': '/bin/bash', 17:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:21 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:21 INFO - 'USER': 'cltbld', 17:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:21 INFO - 'XPC_FLAGS': '0x0', 17:09:21 INFO - 'XPC_SERVICE_NAME': '0', 17:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 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)) 17:09:21 INFO - Cleaning up... 17:09:21 INFO - Return code: 0 17:09:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09:21 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')]} 17:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:21 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')]} 17:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:21 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 0x1045c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff050c7f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, '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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 17:09:21 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 17:09:21 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 17:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:21 INFO - 'HOME': '/Users/cltbld', 17:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:21 INFO - 'LOGNAME': 'cltbld', 17:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:21 INFO - 'MOZ_NO_REMOTE': '1', 17:09:21 INFO - 'NO_EM_RESTART': '1', 17:09:21 INFO - 'PAGER': '/bin/cat', 17:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:21 INFO - 'PWD': '/builds/slave/test', 17:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:21 INFO - 'SHELL': '/bin/bash', 17:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:21 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:21 INFO - 'USER': 'cltbld', 17:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:21 INFO - 'XPC_FLAGS': '0x0', 17:09:21 INFO - 'XPC_SERVICE_NAME': '0', 17:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:09:21 INFO - Cleaning up... 17:09:21 INFO - Return code: 0 17:09:21 INFO - Running post-action listener: _resource_record_post_action 17:09:21 INFO - Running post-action listener: _start_resource_monitoring 17:09:21 INFO - Starting resource monitoring. 17:09:21 INFO - [mozharness: 2017-02-09 01:09:21.917805Z] Finished create-virtualenv step (success) 17:09:21 INFO - [mozharness: 2017-02-09 01:09:21.918758Z] Running install step. 17:09:21 INFO - Running pre-action listener: _resource_record_pre_action 17:09:21 INFO - Running main action method: install 17:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:22 INFO - Reading from file tmpfile_stdout 17:09:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:22 INFO - Reading from file tmpfile_stdout 17:09:22 INFO - Output received: 17:09:22 INFO - Usage: mozinstall [options] installer 17:09:22 INFO - Options: 17:09:22 INFO - -h, --help show this help message and exit 17:09:22 INFO - -d DEST, --destination=DEST 17:09:22 INFO - Directory to install application into. [default: 17:09:22 INFO - "/builds/slave/test"] 17:09:22 INFO - --app=APP Application being installed. [default: firefox] 17:09:22 INFO - mkdir: /builds/slave/test/build/application 17:09:22 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'] 17:09:22 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 17:09:44 INFO - Reading from file tmpfile_stdout 17:09:44 INFO - Output received: 17:09:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:09:44 INFO - Running post-action listener: _resource_record_post_action 17:09:44 INFO - [mozharness: 2017-02-09 01:09:44.667570Z] Finished install step (success) 17:09:44 INFO - [mozharness: 2017-02-09 01:09:44.667706Z] Running run-tests step. 17:09:44 INFO - Running pre-action listener: _resource_record_pre_action 17:09:44 INFO - Running main action method: run_tests 17:09:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:09:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:09:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:09:44 INFO - 2017-02-08 17:09:44.683 screenresolution[6544:117113] starting screenresolution argv=screenresolution get 17:09:44 INFO - 2017-02-08 17:09:44.685 screenresolution[6544:117113] Display 0: 1600x1200x32@60 17:09:44 INFO - 2017-02-08 17:09:44.691 screenresolution[6545:117116] starting screenresolution argv=screenresolution list 17:09:44 INFO - Available Modes on Display 0 17:09:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:09:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:09:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:09:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:09:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:09:44 INFO - Intel Iris: 17:09:44 INFO - Chipset Model: Intel Iris 17:09:44 INFO - Type: GPU 17:09:44 INFO - Bus: Built-In 17:09:44 INFO - VRAM (Dynamic, Max): 1536 MB 17:09:44 INFO - Vendor: Intel (0x8086) 17:09:44 INFO - Device ID: 0x0a2e 17:09:44 INFO - Revision ID: 0x0009 17:09:44 INFO - Displays: 17:09:44 INFO - Display: 17:09:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:09:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:09:44 INFO - Display Serial Number: 1600x1200 60 17:09:44 INFO - Main Display: Yes 17:09:44 INFO - Mirror: Off 17:09:44 INFO - Online: Yes 17:09:44 INFO - Rotation: Supported 17:09:44 INFO - Return code: 0 17:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:44 INFO - Python 2.7.3 17:09:44 INFO - Return code: 0 17:09:44 INFO - grabbing minidump binary from tooltool 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:44 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 0x1043a3d30>, '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 0x1042cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104398be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:44 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 17:09:44 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 17:09:44 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 17:09:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:45 INFO - Return code: 0 17:09:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:09:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:45 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/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 17:09:45 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/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --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 17:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LhD8pGbIgI/Render', 17:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:45 INFO - 'HOME': '/Users/cltbld', 17:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:45 INFO - 'LOGNAME': 'cltbld', 17:09:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:45 INFO - 'MOZ_NO_REMOTE': '1', 17:09:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:45 INFO - 'NO_EM_RESTART': '1', 17:09:45 INFO - 'PAGER': '/bin/cat', 17:09:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:45 INFO - 'PWD': '/builds/slave/test', 17:09:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:45 INFO - 'SHELL': '/bin/bash', 17:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9eQDyqLuqf/Listeners', 17:09:45 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 17:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:45 INFO - 'USER': 'cltbld', 17:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:45 INFO - 'XPC_FLAGS': '0x0', 17:09:45 INFO - 'XPC_SERVICE_NAME': '0', 17:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:45 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/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 17:09:45 INFO - mozversion application_buildid: 20170208154822 17:09:45 INFO - mozversion application_changeset: 438b18daff7aa9a760f2435c1d89f188c7c4c13e 17:09:45 INFO - mozversion application_display_name: Nightly 17:09:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:45 INFO - mozversion application_name: Firefox 17:09:45 INFO - mozversion application_remotingname: firefox 17:09:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:09:45 INFO - mozversion application_vendor: Mozilla 17:09:45 INFO - mozversion application_version: 54.0a1 17:09:45 INFO - mozversion platform_buildid: 20170208154822 17:09:45 INFO - mozversion platform_changeset: 438b18daff7aa9a760f2435c1d89f188c7c4c13e 17:09:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:09:45 INFO - mozversion platform_version: 54.0a1 17:09:45 INFO - using testdate: 1486602585 17:09:45 INFO - actual date: 1486602585 17:09:45 INFO - starting webserver on 'localhost:57085' 17:09:45 INFO - SUITE-START | Running 2 tests 17:09:45 INFO - TEST-START | dromaeo_css 17:09:45 INFO - operating with platform_type : mac_ 17:09:45 INFO - Initialising browser for dromaeo_css test... 17:09:45 INFO - TEST-INFO | started process 6555 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpOaDHrh/profile http://localhost:57085/getInfo.html) 17:09:47 INFO - PROCESS | 6555 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:09:47 INFO - PROCESS | 6555 | __metrics Screen width/height:1600/1200 17:09:47 INFO - PROCESS | 6555 | colorDepth:24 17:09:47 INFO - PROCESS | 6555 | Browser inner width/height: 1024/689 17:09:47 INFO - PROCESS | 6555 | __metrics 17:09:47 INFO - PROCESS | 6555 | 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" 17:09:47 INFO - PROCESS | 6555 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:09:48 INFO - TEST-INFO | 6555: exit 0 17:09:48 INFO - Browser initialized. 17:09:48 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:48 INFO - TEST-INFO | started process 6558 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpOaDHrh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:00 INFO - PROCESS | 6558 | RSS: Main: 236146688 17:10:00 INFO - PROCESS | 6558 | 17:13:03 INFO - PROCESS | 6558 | Cycle 1(1): loaded http://localhost:57085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57085/tests/dromaeo/cssquery-ext.html) 17:13:05 INFO - PROCESS | 6558 | RSS: Main: 350879744 17:13:05 INFO - PROCESS | 6558 | 17:14:50 INFO - PROCESS | 6558 | ************************* 17:14:50 INFO - PROCESS | 6558 | A coding exception was thrown and uncaught in a Task. 17:14:50 INFO - PROCESS | 6558 | 17:14:50 ERROR - PROCESS | 6558 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:14:50 INFO - PROCESS | 6558 | Full stack: 17:14:50 INFO - PROCESS | 6558 | ************************* 17:16:08 INFO - PROCESS | 6558 | Cycle 1(1): loaded http://localhost:57085/tests/dromaeo/cssquery-ext.html (next: http://localhost:57085/tests/dromaeo/cssquery-jquery.html) 17:16:09 INFO - PROCESS | 6558 | RSS: Main: 372162560 17:16:09 INFO - PROCESS | 6558 | 17:19:11 INFO - PROCESS | 6558 | Cycle 1(1): loaded http://localhost:57085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57085/tests/dromaeo/cssquery-mootools.html) 17:19:11 INFO - PROCESS | 6558 | RSS: Main: 342302720 17:19:11 INFO - PROCESS | 6558 | 17:22:14 INFO - PROCESS | 6558 | Cycle 1(1): loaded http://localhost:57085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57085/tests/dromaeo/cssquery-prototype.html) 17:22:14 INFO - PROCESS | 6558 | RSS: Main: 345034752 17:22:14 INFO - PROCESS | 6558 | 17:25:18 INFO - PROCESS | 6558 | Cycle 1(1): loaded http://localhost:57085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57085/tests/dromaeo/cssquery-yui.html) 17:25:19 INFO - PROCESS | 6558 | RSS: Main: 333234176 17:25:19 INFO - PROCESS | 6558 | 17:28:22 INFO - PROCESS | 6558 | Cycle 1(1): loaded http://localhost:57085/tests/dromaeo/cssquery-yui.html (next: http://localhost:57085/tests/dromaeo/cssquery-dojo.html) 17:28:23 INFO - PROCESS | 6558 | RSS: Main: 479027200 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | __start_tp_report 17:28:23 INFO - PROCESS | 6558 | _x_x_mozilla_page_load 17:28:23 INFO - PROCESS | 6558 | _x_x_mozilla_page_load_details 17:28:23 INFO - PROCESS | 6558 | |i|pagename|runs| 17:28:23 INFO - PROCESS | 6558 | |0;dojo.html;2693.6498255226816;3289.753268504862;3294.6705329467054;3299.538064670945;3355.7986520808754;5328.5470734987575;5427.43011983741;5507.5593952483805;5551.944480555198;5588.273524441822;5454.509094181523;5478.534324582405;5533.335999680034;5537.390887002426;5543.196236545708;4949.331840201572;4983.053219888227;5026.396832380119;5036.395632524102;5077.466865979074;5115.53960143587;5125.743712814363;5130.640855140142;5164.354455693038;5179.482051794828;4955.231939049453;4990.076835785391;4990.700557966534;5006.274090256892;5146.2023386374985;4993.800247990076;5041.319421878036;5058.038972595232;5116.590672746172;5120.718360490171;4984.750762461898;4989.750512474398;4997.875053123701;5037.269595908573;5062.215356619729;4946.530079642428;5042.974785126051;5358.196270559409;5472.753726082336;5495.945040549624;5875.9118613220835;5910.7931222407005;5942.554308426886;5957.821265362046;6015.639061656315;6023;6087.6956152192215;6090.994985827333;6109.480694141003;6128.846778830565;5589.105743081088;5589.720513974285;5592.217089607459;5596.4403559644525;5597.63615365;6024.638521688625;6031.306399764083;6067.969660151671;6098.317380452554;6117.614269788186;5896.997510423238;5966.820995370146;5970.194023806731;5983.611065280743;6010.9480840852675;6083.482903953213;6083.66539840313;6092.603980741238;6104.786332478342;6122.357152499013;5736.541076713853;5964.612300200473;6016.969915150484;6022.066579680157;6052.6671033092725;5827.912581311284;5832.94167058324;5891.027980383275;5903.144044113666;5917.822465326047;4611.054733779567;4725.125851717443;4730.905381892343;4740.265258884879;4768.666193366431;3781.3760729479327;4236.830526778956;4249.341352090369;4255.638270747021;4284.2930916398445;5396.2984811974975;5461.836144915659;5471.5896307777075;5520.91718624221;5576.832695019156;6039.456448919531;6085.300190478151;6103.610425594294;6106.603070800384;6117.2184870185665;5579.944200558024;5583.944160558423;5595.244641973363;5598.1322894951345;5604.663720176721;5088.643794934319;5145;5223.190405487156;5234.42421333653;5235.659682120726;6122.367660829195;6179.196704428396;6188.0717892315615;6192.133101365723;6197.318294987638;5952.910706339322;5985.132155837467;5993.70031498432;5996.760129594767;5997.100434934795;5896.233489646319;6156.507479401547;6199.28708198563;6272.8118156455375;6283;5994.730237139426;5996.820095397145;6001.96981605094;6002.429769171922;6020.849478763066;5728.54171666274;6079.848003799941;6089.604175728564;6093;6097.390260973867;5662.433756624305;5732.3121225453215;5758.3090029196765;5795.275590551181;5879.853003674943;5692.459216374438;5812.680302583399;5822.243108395882;5838.12428135783;5850.23946886902;5535.861603459945;5702.800401985911;5703.600747947604;5707.857303567444;5712.971665100322;5649.71751412436;5714.285714285715;5759.107338362561;5788.652680839163;5842.883142337215;4215.473065866767;4741.383620129361;5642.351129620146;5678.4605462480995;5680.403557626555 17:28:23 INFO - PROCESS | 6558 | |1;ext.html;486.68608747357956;500.11729297789384;500.9974950125249;505.4004077095991;539.9460053994601;37356.43965340522;39703.40444893329;39704.602953970454;39868.401973970416;41635;40598.78203653895;41045.97385065375;41120.383194252114;41134.588654113526;41175.38236926449;7869.606519674022;9094.226990705782;9315.068493150698;9322.580483878242;9328;7935.841283174333;10818.891811081867;11092.168087393438;11124.38815865127;11256.212065155443;9393.342466027381;11069.944650276737;11071.335719856794;11114.777704445905;11145.554177832917;7937.48406353591;8123.918760812376;10982.395968221745;11013.779724405467;11081.667549973474;10610.787784244349;10896.346219226793;10936.453177341102;11063.059639930616;11082.61210857616;37861.86414407572;37920.29358678866;38599;38604.613953860666;38964.80517597394;3651.6713495785243;3756.6806821419937;3765.1528406108405;3782.2624588205313;3833.5208098987628;26911.730882691118;27206.591901121497;27224.59163112555;27645.585316220273;28171.859140704164;3021.6071910651476;3077.1845460952864;3082.321889184376;3094.319249765048;3102.286474110967;442879;443869;445079;446996;452346.9999999967;45364.77317613391;46617.601471955895;53553.464465355624;53925.730371348676;54102;47974.5202547977;55496;56381.7180914101;56813.147802782994;59022.753748543386;13573.660658483617;13727.245001524812;13751.587452376445;13757.449702012007;13767.449302027806;10418.062374386342;10571.418571978615;10583.364998100138;10590.629327973484;10591.417472039111;13585.932070339584;16406.17969101564;17028.97826130436;17054.829451705573;17060.402885898933;6173.567850250529;6415.230172379344;7240.8913866290995;7470.551766894004;7520.435967302475;811.4522697179381;814.7922279818608;829.2081062585216;832.7751507093051;846.2341580869323;23501.17745878886;29241.707582924322;29421.26446838846;29453.26366840846;29829.955951542026;822.272289024206;988.1748739802346;1009.5709323537467;1044.2951008069522;1164.1094562659573;13962.511312104027;14755.77866332006;15085.24573771307;15184.316705748268;15559.29983150761;602905;608911;609130;612048;612509.9374503188;57997.710011450516;58263;58326.8334633305;58352;58493.830123397296;1294.5663202827159;1344.8520662727092;1356.6540532164236;1360.653033476477;1364.8771610555098;28067.859660701564;28178.43643127167;28566;28715.712842871304;29101.563476547446;47109.76445117752;47284;47315.76342118267;47526.76236618933;47595.76202118967;426239;430242;431017;431022.84488577355;431896.6810331982;22523.887380562992;22939.311820645406;25082.623760643968;25758.742412575633;25956.572388518813;44095.33856992212;44288;44938;45159.54840451553;45428.318575220736;35213.119672008404;35387;35568.043757592546;36349.45475817918;36397.45403818892;30923.845380772953;36174;36227.81886090553;37490.437643435915;37499.43750843685;35562;35939.74210902606;36356.636433636384;36545.45181822328;36686.680431336776;31539.684603153673;31712.802509336823;32025;32137.517937231427;32228.516572251905;22193.667094993267;22797.88601056984;24301.39246518851;24502.75497245076;24519.896604652477 17:28:23 INFO - PROCESS | 6558 | |2;jquery.html;358.23874267182237;383.39040924929355;398.49391273083194;408.04110340699344;421.97468151910886;18746.718799218004;19454.610907781873;20592.588148237028;20892.268770593033;21210.681839772416;11695.35675537845;12264.63206103816;12289.262644241351;12301.261924284549;19806.60386792267;5124.846254612358;5354.812581559646;5399.757010934498;5406.459354064582;5418.2685337479525;5107.744612769366;5303.602229832759;5328.680279183242;5339.5728341732765;5360.356757189143;5239.816606418776;5327.627066105374;5341.145416733323;5344.679319240858;5361.463853614627;5093.643444958854;5301.363836339664;5345.305110335651;5348.91976620351;5376.166694162411;5240.973795131038;5243.370795504526;5244.737763111829;5246.291750613656;5247.291615631879;13207.613200613989;17486.91256543722;18511.98184099874;24952.750472495223;25241.36896577582;2541.466292078666;2561.0908127614803;2587.2109006752935;2609.8173127881055;2635.0645520840017;9820;10109.241806864515;10388.636397726119;10400.219983501267;15229.847701522955;1744.1540852686437;1765.2585913916187;1789.4005508154785;1796.7215081662364;1836.1461920207034;106885;111590;112147.87852121537;112381.57138214666;112529.68557043766;9780.608775648894;11445.828312575319;11560.595379161858;11604.187706860439;11680.532778688927;15330.85368048474;15360.308786104652;15384.538463846102;15397.076175429285;15407.61480962985;7779.4554381192775;7883.2116788321855;7939.801504962422;7975.0062484378905;7994.520328780175;7363.153237377663;7376.299251571092;7409.184989651134;7512.136104347961;7547.433942454338;3540.398132317512;4678.760128565933;4691.132140554008;4713.29300604912;4799.736014519235;1671.849533541987;1983.2860170338668;1994.1425187169657;1999.850011249133;2009.5880344529337;917.7613820406742;951.71129773412;967.5452537307455;996.7059717383389;1020.357174979758;21650.458738531663;21675.566488670138;21691.67462488064;21761.891190544262;21798.128074876826;979.3585201692903;989;1014.898510148994;1027.2809033676456;1028.341861208827;9438.310081626703;10692;10945;11197.944010279896;11608.825867611993;687405.822388642;688337.5583122052;694446;720179;721403;151837;157556.63665045032;158191;162362;164643;832.825106727594;949.5679465843025;1007.6876168387823;1037.906588407047;1047.8690163729534;18671.626567468847;19474.8052519473;19967.206230816097;20153.093110809754;20178;59973;60288.69855650693;60667;60844.695776520835;61107;83407.5829620848;84039;84475;84998.57500712457;87517.56241218753;8008.239217274349;8340.791480213044;8345.666173352998;8484.236418722345;8499.74500764978;11583.710407239887;11677.299362038304;11757.294562326288;12802;13007;10870.61952831647;10969.177311701815;11010.779784404107;11198.720031999264;11234.88765112371;10656.467176641292;10937.507812148631;10960.890391096305;11264.929831665979;11351.829722554334;9293.72118836436;10179.98200179976;10712.14302855754;10775.892241077489;10814.080803131821;7931.643076061476;7945.245201705829;8106.108328084024;8290.295324897452;8384.077751447458;8586.613602387783;9560.521973901416;10324.22568307365;10430.322029068086;10534.78930421372 17:28:23 INFO - PROCESS | 6558 | |3;mootools.html;1279.8976081913447;1417.6526750946014;1426.6718654709418;1439.6832696806698;1441.3802065112002;7412.814679633012;7813.531188128716;7815.648295826687;7819.022622172221;7822.569758663285;8044.597770111485;8353.206445387694;8360.623771930263;8454.239118479336;8463.534505602205;2136.1882484655807;2175.6083904897114;2191.057845126595;2193.122750899637;2194.0346247651064;1934.21664225988;2007.3576455534235;2221.7333919929633;2267.943301417461;2283.3720726800098;1988.8210061094499;2188.124750099957;2257.6274914639066;2262.8529145605567;2271;2206.6579680149603;2217.124235926808;2226.666000099982;2231.6429371300515;2236.966445503319;2231.3640612425543;2254.256095488485;2257.604919139144;2258.3563684350047;2259.6723475096182;6941.479389045791;8434.40959132861;8458.534780587066;8467.364947628952;8472.872906906401;4450.755208463534;4950.9504904950845;5004.624653151028;5126.231065340192;5164.483551644843;3270.280538281574;3446.7759595626453;3455.6198818129988;3491.1970246843366;3515.261795023023;1158.6581958322315;1208.0758219961735;1226.3255209634665;1232.3899669663485;1240.8076748104058;10908.454577271104;10990.505427255714;10991.945040274828;10999.175061870312;11038.779224415546;4296.162248361539;4557.225271703818;4630.166570017429;4631.189541830234;4635.072985402933;9508.47703376307;9550.37922535033;9576.56905439243;9578.616855325708;9580.56887440067;5197.454267301954;5208.921866172011;5211.895762084737;5215.817446389358;5217.087009773274;4601.5168407317415;4666.580007799314;4676.929846052312;4733.905321893543;4774.140654682121;3648.5256916600674;3696.9815150924073;3702.5186725725484;3772.679322257584;3775.2445113022577;1114.2089116727213;1222.419350808359;1228.6621179175797;1231.359692959656;1238.8389509363726;760.4638729695552;774.2760518914832;840.7729912923477;860.7073594977737;886.3618194899661;5381.058314794974;5480.451954804567;5617.157426386075;5648.802291919763;5748.597598168171;898.793277546155;910.9681161159327;939.3940908114228;950.1068995144542;980.4460479828874;3590.9102272443397;3717.70258379329;3783.735138540331;3847.403652433877;3850.3261929162286;9842.950785246028;9902.603895844086;9936;10186;10202.38785672862;9243.953780231055;9751.122398984126;9984.900150998397;10062.144717699077;10130.696079117492;7617.352525035434;7786.754119340878;7805.648745806452;7816.41376896735;7818.960905195438;5431.511163995101;5487;5615.298087739033;5728.369879313355;5913.91129133072;7338.816529586803;9298.907010930076;9305.395149315273;9310.860337095084;9320.906790932275;9168.679096231599;9336.159745622926;9364.157225849705;9367.906320936976;9529.809403812023;7105.7868263950095;7161.57030578167;7169.856602868018;7177.677004534913;7279.818004549928;7829.138794732688;7901.762947111596;7914.16901225363;7925.326347260317;7932.960335198287;6167.599106058092;7028.508004439845;7159.03353047332;7243.275672432715;7374.446916481178;7129.643517824192;7271.890921636285;7275.890861636974;7374.705011799468;7517.924820751941;6257.906131407942;6337.36626337381;6453.806385808433;6461.967690161519;6515;4940.925886111783;4947.554720075211;4960.528749768766;5053.570446512088;5134.358205224347;4866.95133048665;4972.303877457087;5049.318342023927;5077.898442031213;5178.689278643294 17:28:23 INFO - PROCESS | 6558 | |4;prototype.html;343.1455675368332;348.67050637147895;357.46737361331606;362.1652091928105;366.44483607334877;4709.552592503711;4883.975580122104;5020.272060551218;5026.421961474427;5205.984832957575;3995.8801235962896;4138.482689663792;4582.747948862811;4969.850904472863;5002.074616196006;3796.4115562087923;3944;3991.361382178852;4021.617946295097;4055.2497787909333;3384.4415671414185;3781.4327850822324;4008.418779277003;4015.919681606381;4037.4953130858644;3187;3973.8211780469946;3984.8605298814546;4004.1991601679633;4012.1975604878994;3754.3805272130066;3875.8255878485534;3918.196769662241;3959.485266915297;3973.8013099344917;3530.470429435605;3549.8225088745457;3558;3558.5018097466377;3565.4830049642915;4244.342126970325;4724.338592597039;4898.657094003421;4978.900421991576;5028.924566131511;3674.3569875271987;4136.503619565641;4356.934645980313;4638.512956139591;4675.438947326308;4696.741679207642;5360.303160589137;5364.712469007449;5375.22059301403;5519.862003449905;3307.9173020674434;3956.960430395688;3994.660453861425;4011.438398624195;4032.858849940267;4357.934630980538;5224.791008359661;5239.345081864767;5325.707086110301;5720.971395143039;3257.641659417462;3928.4303775952326;4021.597840215955;4075;4144.663545845623;3565.94651080234;3896.785676787804;4072.450219220427;4091.447654566655;4120.876373708794;3917.138229589486;4591.678582499259;4665.743384113906;4681.227597446383;4708.576228139484;5267.815626453133;5328.24168024551;5365.290528283192;5395.649282796606;5436.994156081138;1172.1619042384737;1217.7822177822177;1267.7274386007052;1283.165942137618;1314.3296918571598;850.3664769746579;863.8358711844729;895.552223888056;922.5756152170077;952.8618350339162;4819.807207711652;4823.97393094901;4869.610431165498;4896.632752543574;4971.8564730112275;4887.507371240693;4905.386826646669;5110.540051395392;5275.366955965232;5294.841154765363;4302.010537576312;4621.468531118964;4744.430668319824;4813.606407482716;4839.467658557556;2548.4648223872823;2647.6364672193836;2739.671239451279;2759.406727553586;2811.353388720606;4539.524654487305;5216.321878155892;5312.148692198125;5453.291072160594;5513.15309371357;5357.142857142916;5389.79018602379;5404.351477822686;5452.728362982179;5459.563234941195;4607.433472619258;4743.501932297059;4957.7769000395065;5481.397046324901;5545.55815487968;4837.153498137882;5034.723090230073;5166.744950681047;5228.222404382528;5252.737363131904;4653.928407251198;4695.6852081417255;4814.542618451242;5192.870178245574;5209.244659524424;4818.566329030404;4845.832583977846;5301.708406037705;5534.308211473566;5548.833534993957;3180.554722338921;3435.7974708851702;3812.1803812180515;3839.520059992501;3876.6317199865966;4662.114198302447;4965.28003439492;5119.873627801878;5205.906759580379;5654.547636189177;5397.757100930389;5449.809256675997;5485.835424937259;5513.649155956817;5538.446155384429;4804.228680485802;5009.8747531310555;5379.488948549882;5469.343678758574;5512.779488820563;5124.461931497288;5189.365349914765;5233.215017747369;5269.78920843162;5401.8116014476755;5410.134378499579;5419.34967803866;5441.455854414527;5445.918311225256;5481.342238931354;4053.8986525337104;4727.692699974491;5152.562032227303;5351.581830814915;5379.950909572753 17:28:23 INFO - PROCESS | 6558 | |5;yui.html;646.7089809585688;699.786565097645;721.6824597177242;747.3012733094557;866.588370524001;13610.659733506667;13933.790993135111;14384.928075359621;14507.492237771667;14778.187199704013;13067.215967041984;13253;13388.732225355487;13418.396172172252;13475.865241347583;852.0201767966842;854.6965827131341;868.8740132680789;870.4211699220043;870.6125774030559;728.9635518224068;827.9710210142646;850.7362717557577;860.3031544448985;864.5763575847852;887.7514295997099;906.5784410249232;909.9363044586881;911.0661571888801;911.1298709732223;905.8097799462121;906.9138431848996;908.3596064774318;908.4231512989234;908.7001289574424;670.0752960913957;675.5406323699882;676.2257215488288;676.6853413162903;678.1489231015094;14401.639959001004;14651.780223296659;14663.92668036653;14677;14694.853051469456;13473.663158421019;13741.519046833413;13840;13861.584152475441;13933.164010159322;9508.857367139499;11288.322700637988;11534.873565956103;11624.476898539502;12159.027277817753;3055.4194703006356;3550.431930891071;3597.7301702372165;3605.4231322988458;3731.458938453909;101757.4912125442;101874.9812501873;104866.99999999924;105213;105340;10151.492425378701;10523.631672891564;10676.679699609023;10698.946505267579;10758.686882320339;19948.70076948847;21680.13279468835;21722.022508987135;21913.342599722033;21938.341849744535;6205.565610407228;6937.618430986243;7318.670659820321;7516.962415187999;7518.097828260644;3944;4039.394090886332;4047.170330082326;4106.055607210358;4247.915041699149;3481.9477707834403;3606.1886075633297;3609.043603445089;3613.6205698401814;3619.203775169511;632.8544434780026;658.5949640970864;663.8871391863395;666.6733300682631;675.2234929830734;575.7380391921665;626.7399029402837;636.7643971730489;638.3903372279462;639.7792761497276;7197.640117994079;7704.422168337397;8554.700585479479;8712.520811355436;9390.62437502506;512.7974450092267;519.2574618295873;550.2818821438062;602.3885755957706;667.4226793823308;4012.297847876668;4203.5376108628025;4313.67647426438;4319.805608747614;4360.361076868059;66627;75085.24914750783;87197.20415377215;92895.60656590156;95192.52403737936;57731;60346.09480857791;80345.39309213783;82104.58947705223;83572.91067723234;69105;70385.99999999898;71026;71589.64205179045;73774.83576149725;9583.472908989794;10506.317089389166;10615;10616.787664246825;10619.522121504706;46857.062858741956;48524;49646.50353496563;49806.75096624494;50300.49699502958;65999.68000640057;69661.65169174122;69866;70486;71745.54290113915;13034.608961731163;13150.342482875627;13431.86568134306;13634.522791702242;14006.299685015912;14263.144211347353;14411.711765764836;14561;14666.926665366605;15274;11327.943360283145;12821.777492141071;13181.472741090249;13203;13618.659533511345;13437.798433023709;13549.390277437737;13731.62683731619;13854.238016909167;13978.161310321413;13088.345582720636;13131.60605181846;13482.32588370558;13685.45258189701;13800.37898294559;8753;9533.904660953302;9865.65470208568;9869.802603947737;10161.136303414292;9492.905070949202;9521.285903557122;9528.571214295513;9572.521373931137;9573.760655983377 17:28:23 INFO - PROCESS | 6558 | __end_tp_report 17:28:23 INFO - PROCESS | 6558 | __start_cc_report 17:28:23 INFO - PROCESS | 6558 | _x_x_mozilla_cycle_collect,1556 17:28:23 INFO - PROCESS | 6558 | __end_cc_report 17:28:23 INFO - PROCESS | 6558 | __startTimestamp1486603703092__endTimestamp 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | ------- Summary: start ------- 17:28:23 INFO - PROCESS | 6558 | Number of tests: 6 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | [#0] dojo.html Cycles:165 Average:5516.35 Median:5680.40 stddev:646.44 (11.4%) stddev-sans-first:609.32 17:28:23 INFO - PROCESS | 6558 | Values: 2693.6 3289.8 3294.7 3299.5 3355.8 5328.5 5427.4 5507.6 5551.9 5588.3 5454.5 5478.5 5533.3 5537.4 5543.2 4949.3 4983.1 5026.4 5036.4 5077.5 5115.5 5125.7 5130.6 5164.4 5179.5 4955.2 4990.1 4990.7 5006.3 5146.2 4993.8 5041.3 5058.0 5116.6 5120.7 4984.8 4989.8 4997.9 5037.3 5062.2 4946.5 5043.0 5358.2 5472.8 5495.9 5875.9 5910.8 5942.6 5957.8 6015.6 6023.0 6087.7 6091.0 6109.5 6128.8 5589.1 5589.7 5592.2 5596.4 5597.6 6024.6 6031.3 6068.0 6098.3 6117.6 5897.0 5966.8 5970.2 5983.6 6010.9 6083.5 6083.7 6092.6 6104.8 6122.4 5736.5 5964.6 6017.0 6022.1 6052.7 5827.9 5832.9 5891.0 5903.1 5917.8 4611.1 4725.1 4730.9 4740.3 4768.7 3781.4 4236.8 4249.3 4255.6 4284.3 5396.3 5461.8 5471.6 5520.9 5576.8 6039.5 6085.3 6103.6 6106.6 6117.2 5579.9 5583.9 5595.2 5598.1 5604.7 5088.6 5145.0 5223.2 5234.4 5235.7 6122.4 6179.2 6188.1 6192.1 6197.3 5952.9 5985.1 5993.7 5996.8 5997.1 5896.2 6156.5 6199.3 6272.8 6283.0 5994.7 5996.8 6002.0 6002.4 6020.8 5728.5 6079.8 6089.6 6093.0 6097.4 5662.4 5732.3 5758.3 5795.3 5879.9 5692.5 5812.7 5822.2 5838.1 5850.2 5535.9 5702.8 5703.6 5707.9 5713.0 5649.7 5714.3 5759.1 5788.7 5842.9 4215.5 4741.4 5642.4 5678.5 5680.4 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | [#1] ext.html Cycles:180 Average:62681.62 Median:20098.56 stddev:133863.40 (666.0%) stddev-sans-first:134157.48 17:28:23 INFO - PROCESS | 6558 | Values: 486.7 500.1 501.0 505.4 539.9 37356.4 39703.4 39704.6 39868.4 41635.0 40598.8 41046.0 41120.4 41134.6 41175.4 7869.6 9094.2 9315.1 9322.6 9328.0 7935.8 10818.9 11092.2 11124.4 11256.2 9393.3 11069.9 11071.3 11114.8 11145.6 7937.5 8123.9 10982.4 11013.8 11081.7 10610.8 10896.3 10936.5 11063.1 11082.6 37861.9 37920.3 38599.0 38604.6 38964.8 3651.7 3756.7 3765.2 3782.3 3833.5 26911.7 27206.6 27224.6 27645.6 28171.9 3021.6 3077.2 3082.3 3094.3 3102.3 442879.0 443869.0 445079.0 446996.0 452347.0 45364.8 46617.6 53553.5 53925.7 54102.0 47974.5 55496.0 56381.7 56813.1 59022.8 13573.7 13727.2 13751.6 13757.4 13767.4 10418.1 10571.4 10583.4 10590.6 10591.4 13585.9 16406.2 17029.0 17054.8 17060.4 6173.6 6415.2 7240.9 7470.6 7520.4 811.5 814.8 829.2 832.8 846.2 23501.2 29241.7 29421.3 29453.3 29830.0 822.3 988.2 1009.6 1044.3 1164.1 13962.5 14755.8 15085.2 15184.3 15559.3 602905.0 608911.0 609130.0 612048.0 612509.9 57997.7 58263.0 58326.8 58352.0 58493.8 1294.6 1344.9 1356.7 1360.7 1364.9 28067.9 28178.4 28566.0 28715.7 29101.6 47109.8 47284.0 47315.8 47526.8 47595.8 426239.0 430242.0 431017.0 431022.8 431896.7 22523.9 22939.3 25082.6 25758.7 25956.6 44095.3 44288.0 44938.0 45159.5 45428.3 35213.1 35387.0 35568.0 36349.5 36397.5 30923.8 36174.0 36227.8 37490.4 37499.4 35562.0 35939.7 36356.6 36545.5 36686.7 31539.7 31712.8 32025.0 32137.5 32228.5 22193.7 22797.9 24301.4 24502.8 24519.9 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | [#2] jquery.html Cycles:180 Average:38568.99 Median:13891.42 stddev:117230.80 (843.9%) stddev-sans-first:117524.55 17:28:23 INFO - PROCESS | 6558 | Values: 358.2 383.4 398.5 408.0 422.0 18746.7 19454.6 20592.6 20892.3 21210.7 11695.4 12264.6 12289.3 12301.3 19806.6 5124.8 5354.8 5399.8 5406.5 5418.3 5107.7 5303.6 5328.7 5339.6 5360.4 5239.8 5327.6 5341.1 5344.7 5361.5 5093.6 5301.4 5345.3 5348.9 5376.2 5241.0 5243.4 5244.7 5246.3 5247.3 13207.6 17486.9 18512.0 24952.8 25241.4 2541.5 2561.1 2587.2 2609.8 2635.1 9820.0 10109.2 10388.6 10400.2 15229.8 1744.2 1765.3 1789.4 1796.7 1836.1 106885.0 111590.0 112147.9 112381.6 112529.7 9780.6 11445.8 11560.6 11604.2 11680.5 15330.9 15360.3 15384.5 15397.1 15407.6 7779.5 7883.2 7939.8 7975.0 7994.5 7363.2 7376.3 7409.2 7512.1 7547.4 3540.4 4678.8 4691.1 4713.3 4799.7 1671.8 1983.3 1994.1 1999.9 2009.6 917.8 951.7 967.5 996.7 1020.4 21650.5 21675.6 21691.7 21761.9 21798.1 979.4 989.0 1014.9 1027.3 1028.3 9438.3 10692.0 10945.0 11197.9 11608.8 687405.8 688337.6 694446.0 720179.0 721403.0 151837.0 157556.6 158191.0 162362.0 164643.0 832.8 949.6 1007.7 1037.9 1047.9 18671.6 19474.8 19967.2 20153.1 20178.0 59973.0 60288.7 60667.0 60844.7 61107.0 83407.6 84039.0 84475.0 84998.6 87517.6 8008.2 8340.8 8345.7 8484.2 8499.7 11583.7 11677.3 11757.3 12802.0 13007.0 10870.6 10969.2 11010.8 11198.7 11234.9 10656.5 10937.5 10960.9 11264.9 11351.8 9293.7 10180.0 10712.1 10775.9 10814.1 7931.6 7945.2 8106.1 8290.3 8384.1 8586.6 9560.5 10324.2 10430.3 10534.8 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | [#3] mootools.html Cycles:180 Average:5404.82 Median:5210.41 stddev:2977.67 (57.1%) stddev-sans-first:2969.88 17:28:23 INFO - PROCESS | 6558 | Values: 1279.9 1417.7 1426.7 1439.7 1441.4 7412.8 7813.5 7815.6 7819.0 7822.6 8044.6 8353.2 8360.6 8454.2 8463.5 2136.2 2175.6 2191.1 2193.1 2194.0 1934.2 2007.4 2221.7 2267.9 2283.4 1988.8 2188.1 2257.6 2262.9 2271.0 2206.7 2217.1 2226.7 2231.6 2237.0 2231.4 2254.3 2257.6 2258.4 2259.7 6941.5 8434.4 8458.5 8467.4 8472.9 4450.8 4951.0 5004.6 5126.2 5164.5 3270.3 3446.8 3455.6 3491.2 3515.3 1158.7 1208.1 1226.3 1232.4 1240.8 10908.5 10990.5 10991.9 10999.2 11038.8 4296.2 4557.2 4630.2 4631.2 4635.1 9508.5 9550.4 9576.6 9578.6 9580.6 5197.5 5208.9 5211.9 5215.8 5217.1 4601.5 4666.6 4676.9 4733.9 4774.1 3648.5 3697.0 3702.5 3772.7 3775.2 1114.2 1222.4 1228.7 1231.4 1238.8 760.5 774.3 840.8 860.7 886.4 5381.1 5480.5 5617.2 5648.8 5748.6 898.8 911.0 939.4 950.1 980.4 3590.9 3717.7 3783.7 3847.4 3850.3 9843.0 9902.6 9936.0 10186.0 10202.4 9244.0 9751.1 9984.9 10062.1 10130.7 7617.4 7786.8 7805.6 7816.4 7819.0 5431.5 5487.0 5615.3 5728.4 5913.9 7338.8 9298.9 9305.4 9310.9 9320.9 9168.7 9336.2 9364.2 9367.9 9529.8 7105.8 7161.6 7169.9 7177.7 7279.8 7829.1 7901.8 7914.2 7925.3 7933.0 6167.6 7028.5 7159.0 7243.3 7374.4 7129.6 7271.9 7275.9 7374.7 7517.9 6257.9 6337.4 6453.8 6462.0 6515.0 4940.9 4947.6 4960.5 5053.6 5134.4 4867.0 4972.3 5049.3 5077.9 5178.7 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | [#4] prototype.html Cycles:180 Average:4319.57 Median:4814.07 stddev:1274.34 (26.5%) stddev-sans-first:1242.47 17:28:23 INFO - PROCESS | 6558 | Values: 343.1 348.7 357.5 362.2 366.4 4709.6 4884.0 5020.3 5026.4 5206.0 3995.9 4138.5 4582.7 4969.9 5002.1 3796.4 3944.0 3991.4 4021.6 4055.2 3384.4 3781.4 4008.4 4015.9 4037.5 3187.0 3973.8 3984.9 4004.2 4012.2 3754.4 3875.8 3918.2 3959.5 3973.8 3530.5 3549.8 3558.0 3558.5 3565.5 4244.3 4724.3 4898.7 4978.9 5028.9 3674.4 4136.5 4356.9 4638.5 4675.4 4696.7 5360.3 5364.7 5375.2 5519.9 3307.9 3957.0 3994.7 4011.4 4032.9 4357.9 5224.8 5239.3 5325.7 5721.0 3257.6 3928.4 4021.6 4075.0 4144.7 3565.9 3896.8 4072.5 4091.4 4120.9 3917.1 4591.7 4665.7 4681.2 4708.6 5267.8 5328.2 5365.3 5395.6 5437.0 1172.2 1217.8 1267.7 1283.2 1314.3 850.4 863.8 895.6 922.6 952.9 4819.8 4824.0 4869.6 4896.6 4971.9 4887.5 4905.4 5110.5 5275.4 5294.8 4302.0 4621.5 4744.4 4813.6 4839.5 2548.5 2647.6 2739.7 2759.4 2811.4 4539.5 5216.3 5312.1 5453.3 5513.2 5357.1 5389.8 5404.4 5452.7 5459.6 4607.4 4743.5 4957.8 5481.4 5545.6 4837.2 5034.7 5166.7 5228.2 5252.7 4653.9 4695.7 4814.5 5192.9 5209.2 4818.6 4845.8 5301.7 5534.3 5548.8 3180.6 3435.8 3812.2 3839.5 3876.6 4662.1 4965.3 5119.9 5205.9 5654.5 5397.8 5449.8 5485.8 5513.6 5538.4 4804.2 5009.9 5379.5 5469.3 5512.8 5124.5 5189.4 5233.2 5269.8 5401.8 5410.1 5419.3 5441.5 5445.9 5481.3 4053.9 4727.7 5152.6 5351.6 5380.0 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - PROCESS | 6558 | [#5] yui.html Cycles:180 Average:19005.06 Median:49085.25 stddev:26681.36 (54.4%) stddev-sans-first:26720.60 17:28:23 INFO - PROCESS | 6558 | Values: 646.7 699.8 721.7 747.3 866.6 13610.7 13933.8 14384.9 14507.5 14778.2 13067.2 13253.0 13388.7 13418.4 13475.9 852.0 854.7 868.9 870.4 870.6 729.0 828.0 850.7 860.3 864.6 887.8 906.6 909.9 911.1 911.1 905.8 906.9 908.4 908.4 908.7 670.1 675.5 676.2 676.7 678.1 14401.6 14651.8 14663.9 14677.0 14694.9 13473.7 13741.5 13840.0 13861.6 13933.2 9508.9 11288.3 11534.9 11624.5 12159.0 3055.4 3550.4 3597.7 3605.4 3731.5 101757.5 101875.0 104867.0 105213.0 105340.0 10151.5 10523.6 10676.7 10698.9 10758.7 19948.7 21680.1 21722.0 21913.3 21938.3 6205.6 6937.6 7318.7 7517.0 7518.1 3944.0 4039.4 4047.2 4106.1 4247.9 3481.9 3606.2 3609.0 3613.6 3619.2 632.9 658.6 663.9 666.7 675.2 575.7 626.7 636.8 638.4 639.8 7197.6 7704.4 8554.7 8712.5 9390.6 512.8 519.3 550.3 602.4 667.4 4012.3 4203.5 4313.7 4319.8 4360.4 66627.0 75085.2 87197.2 92895.6 95192.5 57731.0 60346.1 80345.4 82104.6 83572.9 69105.0 70386.0 71026.0 71589.6 73774.8 9583.5 10506.3 10615.0 10616.8 10619.5 46857.1 48524.0 49646.5 49806.8 50300.5 65999.7 69661.7 69866.0 70486.0 71745.5 13034.6 13150.3 13431.9 13634.5 14006.3 14263.1 14411.7 14561.0 14666.9 15274.0 11327.9 12821.8 13181.5 13203.0 13618.7 13437.8 13549.4 13731.6 13854.2 13978.2 13088.3 13131.6 13482.3 13685.5 13800.4 8753.0 9533.9 9865.7 9869.8 10161.1 9492.9 9521.3 9528.6 9572.5 9573.8 17:28:23 INFO - PROCESS | 6558 | -------- Summary: end -------- 17:28:23 INFO - PROCESS | 6558 | 17:28:23 INFO - TEST-INFO | 6558: exit 0 17:28:23 INFO - TEST-OK | dromaeo_css | took 1118633ms 17:28:23 INFO - TEST-START | kraken 17:28:23 INFO - operating with platform_type : mac_ 17:28:23 INFO - Initialising browser for kraken test... 17:28:23 INFO - TEST-INFO | started process 6560 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpW50Hwr/profile http://localhost:57085/getInfo.html) 17:28:25 INFO - PROCESS | 6560 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:28:26 INFO - PROCESS | 6560 | __metrics Screen width/height:1600/1200 17:28:26 INFO - PROCESS | 6560 | colorDepth:24 17:28:26 INFO - PROCESS | 6560 | Browser inner width/height: 1024/689 17:28:26 INFO - PROCESS | 6560 | __metrics 17:28:26 INFO - PROCESS | 6560 | 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" 17:28:26 INFO - PROCESS | 6560 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:26 INFO - TEST-INFO | 6560: exit 0 17:28:26 INFO - Browser initialized. 17:28:26 INFO - Running cycle 1/1 for kraken test... 17:28:26 INFO - TEST-INFO | started process 6561 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpW50Hwr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:39 INFO - PROCESS | 6561 | RSS: Main: 227876864 17:28:39 INFO - PROCESS | 6561 | 17:28:41 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57085/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:42 INFO - PROCESS | 6561 | RSS: Main: 289804288 17:28:42 INFO - PROCESS | 6561 | 17:28:45 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57085/tests/kraken/driver.html?testName=audio-dft) 17:28:46 INFO - PROCESS | 6561 | RSS: Main: 293462016 17:28:46 INFO - PROCESS | 6561 | 17:28:49 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57085/tests/kraken/driver.html?testName=audio-fft) 17:28:50 INFO - PROCESS | 6561 | RSS: Main: 380706816 17:28:50 INFO - PROCESS | 6561 | 17:28:52 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57085/tests/kraken/driver.html?testName=audio-oscillator) 17:28:52 INFO - PROCESS | 6561 | RSS: Main: 285478912 17:28:52 INFO - PROCESS | 6561 | 17:28:54 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:55 INFO - PROCESS | 6561 | RSS: Main: 287559680 17:28:55 INFO - PROCESS | 6561 | 17:28:58 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57085/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:58 INFO - PROCESS | 6561 | RSS: Main: 330629120 17:28:58 INFO - PROCESS | 6561 | 17:29:01 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57085/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:02 INFO - PROCESS | 6561 | RSS: Main: 331010048 17:29:02 INFO - PROCESS | 6561 | 17:29:05 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57085/tests/kraken/driver.html?testName=json-parse-financial) 17:29:05 INFO - PROCESS | 6561 | RSS: Main: 328679424 17:29:05 INFO - PROCESS | 6561 | 17:29:07 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:08 INFO - PROCESS | 6561 | RSS: Main: 306700288 17:29:08 INFO - PROCESS | 6561 | 17:29:10 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:10 INFO - PROCESS | 6561 | RSS: Main: 310444032 17:29:10 INFO - PROCESS | 6561 | 17:29:13 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:13 INFO - PROCESS | 6561 | RSS: Main: 313143296 17:29:13 INFO - PROCESS | 6561 | 17:29:16 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:17 INFO - PROCESS | 6561 | RSS: Main: 330002432 17:29:17 INFO - PROCESS | 6561 | 17:29:20 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:21 INFO - PROCESS | 6561 | RSS: Main: 324108288 17:29:21 INFO - PROCESS | 6561 | 17:29:22 INFO - PROCESS | 6561 | Cycle 1(1): loaded http://localhost:57085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57085/tests/kraken/driver.html?testName=ai-astar) 17:29:23 INFO - PROCESS | 6561 | RSS: Main: 369254400 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | __start_tp_report 17:29:23 INFO - PROCESS | 6561 | _x_x_mozilla_page_load 17:29:23 INFO - PROCESS | 6561 | _x_x_mozilla_page_load_details 17:29:23 INFO - PROCESS | 6561 | |i|pagename|runs| 17:29:23 INFO - PROCESS | 6561 | |0;ai-astar;112;114;112;113;113;112;114;113;114;114 17:29:23 INFO - PROCESS | 6561 | |1;audio-beat-detection;143;111;111;148;113;121;138;97;161;138 17:29:23 INFO - PROCESS | 6561 | |2;audio-dft;187;183;183;185;185;185;181;179;181;183 17:29:23 INFO - PROCESS | 6561 | |3;audio-fft;80;60;60;90;63;67;81;81;101;60 17:29:23 INFO - PROCESS | 6561 | |4;audio-oscillator;89;70;90;70;70;70;86;71;70;86 17:29:23 INFO - PROCESS | 6561 | |5;imaging-gaussian-blur;99;130;90;88;88;86;91;87;90;86 17:29:23 INFO - PROCESS | 6561 | |6;imaging-darkroom;96;96;96;97;95;94;96;97;95;97 17:29:23 INFO - PROCESS | 6561 | |7;imaging-desaturate;86;84;86;87;85;86;93;85;86;86 17:29:23 INFO - PROCESS | 6561 | |8;json-parse-financial;61;57;58;82;87;83;85;59;59;58 17:29:23 INFO - PROCESS | 6561 | |9;json-stringify-tinderbox;59;72;76;75;61;83;58;78;93;102 17:29:23 INFO - PROCESS | 6561 | |10;stanford-crypto-aes;89;87;87;106;89;88;90;101;108;88 17:29:23 INFO - PROCESS | 6561 | |11;stanford-crypto-ccm;143;147;144;143;141;142;150;142;207;176 17:29:23 INFO - PROCESS | 6561 | |12;stanford-crypto-pbkdf2;173;172;173;174;173;176;165;170;174;173 17:29:23 INFO - PROCESS | 6561 | |13;stanford-crypto-sha256-iterative;67;67;68;69;67;67;65;66;65;67 17:29:23 INFO - PROCESS | 6561 | __end_tp_report 17:29:23 INFO - PROCESS | 6561 | __start_cc_report 17:29:23 INFO - PROCESS | 6561 | _x_x_mozilla_cycle_collect,2103 17:29:23 INFO - PROCESS | 6561 | __end_cc_report 17:29:23 INFO - PROCESS | 6561 | __startTimestamp1486603763193__endTimestamp 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | ------- Summary: start ------- 17:29:23 INFO - PROCESS | 6561 | Number of tests: 14 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:0.88 (0.8%) stddev-sans-first:0.83 17:29:23 INFO - PROCESS | 6561 | Values: 112.0 114.0 112.0 113.0 113.0 112.0 114.0 113.0 114.0 114.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:140.50 stddev:20.35 (14.5%) stddev-sans-first:20.86 17:29:23 INFO - PROCESS | 6561 | Values: 143.0 111.0 111.0 148.0 113.0 121.0 138.0 97.0 161.0 138.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:2.39 (1.3%) stddev-sans-first:2.11 17:29:23 INFO - PROCESS | 6561 | Values: 187.0 183.0 183.0 185.0 185.0 185.0 181.0 179.0 181.0 183.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#3] audio-fft Cycles:10 Average:74.30 Median:73.50 stddev:14.44 (19.6%) stddev-sans-first:15.17 17:29:23 INFO - PROCESS | 6561 | Values: 80.0 60.0 60.0 90.0 63.0 67.0 81.0 81.0 101.0 60.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.50 stddev:9.16 (11.7%) stddev-sans-first:8.67 17:29:23 INFO - PROCESS | 6561 | Values: 89.0 70.0 90.0 70.0 70.0 70.0 86.0 71.0 70.0 86.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:89.00 stddev:13.37 (15.0%) stddev-sans-first:14.03 17:29:23 INFO - PROCESS | 6561 | Values: 99.0 130.0 90.0 88.0 88.0 86.0 91.0 87.0 90.0 86.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 17:29:23 INFO - PROCESS | 6561 | Values: 96.0 96.0 96.0 97.0 95.0 94.0 96.0 97.0 95.0 97.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:86.00 stddev:2.46 (2.9%) stddev-sans-first:2.60 17:29:23 INFO - PROCESS | 6561 | Values: 86.0 84.0 86.0 87.0 85.0 86.0 93.0 85.0 86.0 86.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:71.50 stddev:13.31 (18.6%) stddev-sans-first:13.81 17:29:23 INFO - PROCESS | 6561 | Values: 61.0 57.0 58.0 82.0 87.0 83.0 85.0 59.0 59.0 58.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:75.50 stddev:14.42 (19.1%) stddev-sans-first:13.97 17:29:23 INFO - PROCESS | 6561 | Values: 59.0 72.0 76.0 75.0 61.0 83.0 58.0 78.0 93.0 102.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:88.00 stddev:8.30 (9.4%) stddev-sans-first:8.66 17:29:23 INFO - PROCESS | 6561 | Values: 89.0 87.0 87.0 106.0 89.0 88.0 90.0 101.0 108.0 88.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:145.50 stddev:21.49 (14.8%) stddev-sans-first:22.45 17:29:23 INFO - PROCESS | 6561 | Values: 143.0 147.0 144.0 143.0 141.0 142.0 150.0 142.0 207.0 176.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:2.98 (1.7%) stddev-sans-first:3.15 17:29:23 INFO - PROCESS | 6561 | Values: 173.0 172.0 173.0 174.0 173.0 176.0 165.0 170.0 174.0 173.0 17:29:23 INFO - PROCESS | 6561 | 17:29:23 INFO - PROCESS | 6561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 17:29:23 INFO - PROCESS | 6561 | Values: 67.0 67.0 68.0 69.0 67.0 67.0 65.0 66.0 65.0 67.0 17:29:23 INFO - PROCESS | 6561 | -------- Summary: end -------- 17:29:23 INFO - PROCESS | 6561 | 17:29:24 INFO - TEST-INFO | 6561: exit 0 17:29:24 INFO - TEST-OK | kraken | took 60319ms 17:29:24 INFO - SUITE-END | took 1178s 17:29:24 INFO - Completed test suite (00:19:39) 17:29:24 INFO - javascript benchmark 17:29:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7019.004195880198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.6498255226816, 3289.753268504862, 3294.6705329467054, 3299.538064670945, 3355.7986520808754, 5328.5470734987575, 5427.43011983741, 5507.5593952483805, 5551.944480555198, 5588.273524441822, 5454.509094181523, 5478.534324582405, 5533.335999680034, 5537.390887002426, 5543.196236545708, 4949.331840201572, 4983.053219888227, 5026.396832380119, 5036.395632524102, 5077.466865979074, 5115.53960143587, 5125.743712814363, 5130.640855140142, 5164.354455693038, 5179.482051794828, 4955.231939049453, 4990.076835785391, 4990.700557966534, 5006.274090256892, 5146.2023386374985, 4993.800247990076, 5041.319421878036, 5058.038972595232, 5116.590672746172, 5120.718360490171, 4984.750762461898, 4989.750512474398, 4997.875053123701, 5037.269595908573, 5062.215356619729, 4946.530079642428, 5042.974785126051, 5358.196270559409, 5472.753726082336, 5495.945040549624, 5875.9118613220835, 5910.7931222407005, 5942.554308426886, 5957.821265362046, 6015.639061656315, 6023.0, 6087.6956152192215, 6090.994985827333, 6109.480694141003, 6128.846778830565, 5589.105743081088, 5589.720513974285, 5592.217089607459, 5596.4403559644525, 5597.63615365, 6024.638521688625, 6031.306399764083, 6067.969660151671, 6098.317380452554, 6117.614269788186, 5896.997510423238, 5966.820995370146, 5970.194023806731, 5983.611065280743, 6010.9480840852675, 6083.482903953213, 6083.66539840313, 6092.603980741238, 6104.786332478342, 6122.357152499013, 5736.541076713853, 5964.612300200473, 6016.969915150484, 6022.066579680157, 6052.6671033092725, 5827.912581311284, 5832.94167058324, 5891.027980383275, 5903.144044113666, 5917.822465326047, 4611.054733779567, 4725.125851717443, 4730.905381892343, 4740.265258884879, 4768.666193366431, 3781.3760729479327, 4236.830526778956, 4249.341352090369, 4255.638270747021, 4284.2930916398445, 5396.2984811974975, 5461.836144915659, 5471.5896307777075, 5520.91718624221, 5576.832695019156, 6039.456448919531, 6085.300190478151, 6103.610425594294, 6106.603070800384, 6117.2184870185665, 5579.944200558024, 5583.944160558423, 5595.244641973363, 5598.1322894951345, 5604.663720176721, 5088.643794934319, 5145.0, 5223.190405487156, 5234.42421333653, 5235.659682120726, 6122.367660829195, 6179.196704428396, 6188.0717892315615, 6192.133101365723, 6197.318294987638, 5952.910706339322, 5985.132155837467, 5993.70031498432, 5996.760129594767, 5997.100434934795, 5896.233489646319, 6156.507479401547, 6199.28708198563, 6272.8118156455375, 6283.0, 5994.730237139426, 5996.820095397145, 6001.96981605094, 6002.429769171922, 6020.849478763066, 5728.54171666274, 6079.848003799941, 6089.604175728564, 6093.0, 6097.390260973867, 5662.433756624305, 5732.3121225453215, 5758.3090029196765, 5795.275590551181, 5879.853003674943, 5692.459216374438, 5812.680302583399, 5822.243108395882, 5838.12428135783, 5850.23946886902, 5535.861603459945, 5702.800401985911, 5703.600747947604, 5707.857303567444, 5712.971665100322, 5649.71751412436, 5714.285714285715, 5759.107338362561, 5788.652680839163, 5842.883142337215, 4215.473065866767, 4741.383620129361, 5642.351129620146, 5678.4605462480995, 5680.403557626555], "value": 5473.5737014708675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.68608747357956, 500.11729297789384, 500.9974950125249, 505.4004077095991, 539.9460053994601, 37356.43965340522, 39703.40444893329, 39704.602953970454, 39868.401973970416, 41635.0, 40598.78203653895, 41045.97385065375, 41120.383194252114, 41134.588654113526, 41175.38236926449, 7869.606519674022, 9094.226990705782, 9315.068493150698, 9322.580483878242, 9328.0, 7935.841283174333, 10818.891811081867, 11092.168087393438, 11124.38815865127, 11256.212065155443, 9393.342466027381, 11069.944650276737, 11071.335719856794, 11114.777704445905, 11145.554177832917, 7937.48406353591, 8123.918760812376, 10982.395968221745, 11013.779724405467, 11081.667549973474, 10610.787784244349, 10896.346219226793, 10936.453177341102, 11063.059639930616, 11082.61210857616, 37861.86414407572, 37920.29358678866, 38599.0, 38604.613953860666, 38964.80517597394, 3651.6713495785243, 3756.6806821419937, 3765.1528406108405, 3782.2624588205313, 3833.5208098987628, 26911.730882691118, 27206.591901121497, 27224.59163112555, 27645.585316220273, 28171.859140704164, 3021.6071910651476, 3077.1845460952864, 3082.321889184376, 3094.319249765048, 3102.286474110967, 442879.0, 443869.0, 445079.0, 446996.0, 452346.9999999967, 45364.77317613391, 46617.601471955895, 53553.464465355624, 53925.730371348676, 54102.0, 47974.5202547977, 55496.0, 56381.7180914101, 56813.147802782994, 59022.753748543386, 13573.660658483617, 13727.245001524812, 13751.587452376445, 13757.449702012007, 13767.449302027806, 10418.062374386342, 10571.418571978615, 10583.364998100138, 10590.629327973484, 10591.417472039111, 13585.932070339584, 16406.17969101564, 17028.97826130436, 17054.829451705573, 17060.402885898933, 6173.567850250529, 6415.230172379344, 7240.8913866290995, 7470.551766894004, 7520.435967302475, 811.4522697179381, 814.7922279818608, 829.2081062585216, 832.7751507093051, 846.2341580869323, 23501.17745878886, 29241.707582924322, 29421.26446838846, 29453.26366840846, 29829.955951542026, 822.272289024206, 988.1748739802346, 1009.5709323537467, 1044.2951008069522, 1164.1094562659573, 13962.511312104027, 14755.77866332006, 15085.24573771307, 15184.316705748268, 15559.29983150761, 602905.0, 608911.0, 609130.0, 612048.0, 612509.9374503188, 57997.710011450516, 58263.0, 58326.8334633305, 58352.0, 58493.830123397296, 1294.5663202827159, 1344.8520662727092, 1356.6540532164236, 1360.653033476477, 1364.8771610555098, 28067.859660701564, 28178.43643127167, 28566.0, 28715.712842871304, 29101.563476547446, 47109.76445117752, 47284.0, 47315.76342118267, 47526.76236618933, 47595.76202118967, 426239.0, 430242.0, 431017.0, 431022.84488577355, 431896.6810331982, 22523.887380562992, 22939.311820645406, 25082.623760643968, 25758.742412575633, 25956.572388518813, 44095.33856992212, 44288.0, 44938.0, 45159.54840451553, 45428.318575220736, 35213.119672008404, 35387.0, 35568.043757592546, 36349.45475817918, 36397.45403818892, 30923.845380772953, 36174.0, 36227.81886090553, 37490.437643435915, 37499.43750843685, 35562.0, 35939.74210902606, 36356.636433636384, 36545.45181822328, 36686.680431336776, 31539.684603153673, 31712.802509336823, 32025.0, 32137.517937231427, 32228.516572251905, 22193.667094993267, 22797.88601056984, 24301.39246518851, 24502.75497245076, 24519.896604652477], "value": 18858.857331459734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.23874267182237, 383.39040924929355, 398.49391273083194, 408.04110340699344, 421.97468151910886, 18746.718799218004, 19454.610907781873, 20592.588148237028, 20892.268770593033, 21210.681839772416, 11695.35675537845, 12264.63206103816, 12289.262644241351, 12301.261924284549, 19806.60386792267, 5124.846254612358, 5354.812581559646, 5399.757010934498, 5406.459354064582, 5418.2685337479525, 5107.744612769366, 5303.602229832759, 5328.680279183242, 5339.5728341732765, 5360.356757189143, 5239.816606418776, 5327.627066105374, 5341.145416733323, 5344.679319240858, 5361.463853614627, 5093.643444958854, 5301.363836339664, 5345.305110335651, 5348.91976620351, 5376.166694162411, 5240.973795131038, 5243.370795504526, 5244.737763111829, 5246.291750613656, 5247.291615631879, 13207.613200613989, 17486.91256543722, 18511.98184099874, 24952.750472495223, 25241.36896577582, 2541.466292078666, 2561.0908127614803, 2587.2109006752935, 2609.8173127881055, 2635.0645520840017, 9820.0, 10109.241806864515, 10388.636397726119, 10400.219983501267, 15229.847701522955, 1744.1540852686437, 1765.2585913916187, 1789.4005508154785, 1796.7215081662364, 1836.1461920207034, 106885.0, 111590.0, 112147.87852121537, 112381.57138214666, 112529.68557043766, 9780.608775648894, 11445.828312575319, 11560.595379161858, 11604.187706860439, 11680.532778688927, 15330.85368048474, 15360.308786104652, 15384.538463846102, 15397.076175429285, 15407.61480962985, 7779.4554381192775, 7883.2116788321855, 7939.801504962422, 7975.0062484378905, 7994.520328780175, 7363.153237377663, 7376.299251571092, 7409.184989651134, 7512.136104347961, 7547.433942454338, 3540.398132317512, 4678.760128565933, 4691.132140554008, 4713.29300604912, 4799.736014519235, 1671.849533541987, 1983.2860170338668, 1994.1425187169657, 1999.850011249133, 2009.5880344529337, 917.7613820406742, 951.71129773412, 967.5452537307455, 996.7059717383389, 1020.357174979758, 21650.458738531663, 21675.566488670138, 21691.67462488064, 21761.891190544262, 21798.128074876826, 979.3585201692903, 989.0, 1014.898510148994, 1027.2809033676456, 1028.341861208827, 9438.310081626703, 10692.0, 10945.0, 11197.944010279896, 11608.825867611993, 687405.822388642, 688337.5583122052, 694446.0, 720179.0, 721403.0, 151837.0, 157556.63665045032, 158191.0, 162362.0, 164643.0, 832.825106727594, 949.5679465843025, 1007.6876168387823, 1037.906588407047, 1047.8690163729534, 18671.626567468847, 19474.8052519473, 19967.206230816097, 20153.093110809754, 20178.0, 59973.0, 60288.69855650693, 60667.0, 60844.695776520835, 61107.0, 83407.5829620848, 84039.0, 84475.0, 84998.57500712457, 87517.56241218753, 8008.239217274349, 8340.791480213044, 8345.666173352998, 8484.236418722345, 8499.74500764978, 11583.710407239887, 11677.299362038304, 11757.294562326288, 12802.0, 13007.0, 10870.61952831647, 10969.177311701815, 11010.779784404107, 11198.720031999264, 11234.88765112371, 10656.467176641292, 10937.507812148631, 10960.890391096305, 11264.929831665979, 11351.829722554334, 9293.72118836436, 10179.98200179976, 10712.14302855754, 10775.892241077489, 10814.080803131821, 7931.643076061476, 7945.245201705829, 8106.108328084024, 8290.295324897452, 8384.077751447458, 8586.613602387783, 9560.521973901416, 10324.22568307365, 10430.322029068086, 10534.78930421372], "value": 9426.253698982293, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.8976081913447, 1417.6526750946014, 1426.6718654709418, 1439.6832696806698, 1441.3802065112002, 7412.814679633012, 7813.531188128716, 7815.648295826687, 7819.022622172221, 7822.569758663285, 8044.597770111485, 8353.206445387694, 8360.623771930263, 8454.239118479336, 8463.534505602205, 2136.1882484655807, 2175.6083904897114, 2191.057845126595, 2193.122750899637, 2194.0346247651064, 1934.21664225988, 2007.3576455534235, 2221.7333919929633, 2267.943301417461, 2283.3720726800098, 1988.8210061094499, 2188.124750099957, 2257.6274914639066, 2262.8529145605567, 2271.0, 2206.6579680149603, 2217.124235926808, 2226.666000099982, 2231.6429371300515, 2236.966445503319, 2231.3640612425543, 2254.256095488485, 2257.604919139144, 2258.3563684350047, 2259.6723475096182, 6941.479389045791, 8434.40959132861, 8458.534780587066, 8467.364947628952, 8472.872906906401, 4450.755208463534, 4950.9504904950845, 5004.624653151028, 5126.231065340192, 5164.483551644843, 3270.280538281574, 3446.7759595626453, 3455.6198818129988, 3491.1970246843366, 3515.261795023023, 1158.6581958322315, 1208.0758219961735, 1226.3255209634665, 1232.3899669663485, 1240.8076748104058, 10908.454577271104, 10990.505427255714, 10991.945040274828, 10999.175061870312, 11038.779224415546, 4296.162248361539, 4557.225271703818, 4630.166570017429, 4631.189541830234, 4635.072985402933, 9508.47703376307, 9550.37922535033, 9576.56905439243, 9578.616855325708, 9580.56887440067, 5197.454267301954, 5208.921866172011, 5211.895762084737, 5215.817446389358, 5217.087009773274, 4601.5168407317415, 4666.580007799314, 4676.929846052312, 4733.905321893543, 4774.140654682121, 3648.5256916600674, 3696.9815150924073, 3702.5186725725484, 3772.679322257584, 3775.2445113022577, 1114.2089116727213, 1222.419350808359, 1228.6621179175797, 1231.359692959656, 1238.8389509363726, 760.4638729695552, 774.2760518914832, 840.7729912923477, 860.7073594977737, 886.3618194899661, 5381.058314794974, 5480.451954804567, 5617.157426386075, 5648.802291919763, 5748.597598168171, 898.793277546155, 910.9681161159327, 939.3940908114228, 950.1068995144542, 980.4460479828874, 3590.9102272443397, 3717.70258379329, 3783.735138540331, 3847.403652433877, 3850.3261929162286, 9842.950785246028, 9902.603895844086, 9936.0, 10186.0, 10202.38785672862, 9243.953780231055, 9751.122398984126, 9984.900150998397, 10062.144717699077, 10130.696079117492, 7617.352525035434, 7786.754119340878, 7805.648745806452, 7816.41376896735, 7818.960905195438, 5431.511163995101, 5487.0, 5615.298087739033, 5728.369879313355, 5913.91129133072, 7338.816529586803, 9298.907010930076, 9305.395149315273, 9310.860337095084, 9320.906790932275, 9168.679096231599, 9336.159745622926, 9364.157225849705, 9367.906320936976, 9529.809403812023, 7105.7868263950095, 7161.57030578167, 7169.856602868018, 7177.677004534913, 7279.818004549928, 7829.138794732688, 7901.762947111596, 7914.16901225363, 7925.326347260317, 7932.960335198287, 6167.599106058092, 7028.508004439845, 7159.03353047332, 7243.275672432715, 7374.446916481178, 7129.643517824192, 7271.890921636285, 7275.890861636974, 7374.705011799468, 7517.924820751941, 6257.906131407942, 6337.36626337381, 6453.806385808433, 6461.967690161519, 6515.0, 4940.925886111783, 4947.554720075211, 4960.528749768766, 5053.570446512088, 5134.358205224347, 4866.95133048665, 4972.303877457087, 5049.318342023927, 5077.898442031213, 5178.689278643294], "value": 4366.949459831647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1455675368332, 348.67050637147895, 357.46737361331606, 362.1652091928105, 366.44483607334877, 4709.552592503711, 4883.975580122104, 5020.272060551218, 5026.421961474427, 5205.984832957575, 3995.8801235962896, 4138.482689663792, 4582.747948862811, 4969.850904472863, 5002.074616196006, 3796.4115562087923, 3944.0, 3991.361382178852, 4021.617946295097, 4055.2497787909333, 3384.4415671414185, 3781.4327850822324, 4008.418779277003, 4015.919681606381, 4037.4953130858644, 3187.0, 3973.8211780469946, 3984.8605298814546, 4004.1991601679633, 4012.1975604878994, 3754.3805272130066, 3875.8255878485534, 3918.196769662241, 3959.485266915297, 3973.8013099344917, 3530.470429435605, 3549.8225088745457, 3558.0, 3558.5018097466377, 3565.4830049642915, 4244.342126970325, 4724.338592597039, 4898.657094003421, 4978.900421991576, 5028.924566131511, 3674.3569875271987, 4136.503619565641, 4356.934645980313, 4638.512956139591, 4675.438947326308, 4696.741679207642, 5360.303160589137, 5364.712469007449, 5375.22059301403, 5519.862003449905, 3307.9173020674434, 3956.960430395688, 3994.660453861425, 4011.438398624195, 4032.858849940267, 4357.934630980538, 5224.791008359661, 5239.345081864767, 5325.707086110301, 5720.971395143039, 3257.641659417462, 3928.4303775952326, 4021.597840215955, 4075.0, 4144.663545845623, 3565.94651080234, 3896.785676787804, 4072.450219220427, 4091.447654566655, 4120.876373708794, 3917.138229589486, 4591.678582499259, 4665.743384113906, 4681.227597446383, 4708.576228139484, 5267.815626453133, 5328.24168024551, 5365.290528283192, 5395.649282796606, 5436.994156081138, 1172.1619042384737, 1217.7822177822177, 1267.7274386007052, 1283.165942137618, 1314.3296918571598, 850.3664769746579, 863.8358711844729, 895.552223888056, 922.5756152170077, 952.8618350339162, 4819.807207711652, 4823.97393094901, 4869.610431165498, 4896.632752543574, 4971.8564730112275, 4887.507371240693, 4905.386826646669, 5110.540051395392, 5275.366955965232, 5294.841154765363, 4302.010537576312, 4621.468531118964, 4744.430668319824, 4813.606407482716, 4839.467658557556, 2548.4648223872823, 2647.6364672193836, 2739.671239451279, 2759.406727553586, 2811.353388720606, 4539.524654487305, 5216.321878155892, 5312.148692198125, 5453.291072160594, 5513.15309371357, 5357.142857142916, 5389.79018602379, 5404.351477822686, 5452.728362982179, 5459.563234941195, 4607.433472619258, 4743.501932297059, 4957.7769000395065, 5481.397046324901, 5545.55815487968, 4837.153498137882, 5034.723090230073, 5166.744950681047, 5228.222404382528, 5252.737363131904, 4653.928407251198, 4695.6852081417255, 4814.542618451242, 5192.870178245574, 5209.244659524424, 4818.566329030404, 4845.832583977846, 5301.708406037705, 5534.308211473566, 5548.833534993957, 3180.554722338921, 3435.7974708851702, 3812.1803812180515, 3839.520059992501, 3876.6317199865966, 4662.114198302447, 4965.28003439492, 5119.873627801878, 5205.906759580379, 5654.547636189177, 5397.757100930389, 5449.809256675997, 5485.835424937259, 5513.649155956817, 5538.446155384429, 4804.228680485802, 5009.8747531310555, 5379.488948549882, 5469.343678758574, 5512.779488820563, 5124.461931497288, 5189.365349914765, 5233.215017747369, 5269.78920843162, 5401.8116014476755, 5410.134378499579, 5419.34967803866, 5441.455854414527, 5445.918311225256, 5481.342238931354, 4053.8986525337104, 4727.692699974491, 5152.562032227303, 5351.581830814915, 5379.950909572753], "value": 3932.391179542942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.7089809585688, 699.786565097645, 721.6824597177242, 747.3012733094557, 866.588370524001, 13610.659733506667, 13933.790993135111, 14384.928075359621, 14507.492237771667, 14778.187199704013, 13067.215967041984, 13253.0, 13388.732225355487, 13418.396172172252, 13475.865241347583, 852.0201767966842, 854.6965827131341, 868.8740132680789, 870.4211699220043, 870.6125774030559, 728.9635518224068, 827.9710210142646, 850.7362717557577, 860.3031544448985, 864.5763575847852, 887.7514295997099, 906.5784410249232, 909.9363044586881, 911.0661571888801, 911.1298709732223, 905.8097799462121, 906.9138431848996, 908.3596064774318, 908.4231512989234, 908.7001289574424, 670.0752960913957, 675.5406323699882, 676.2257215488288, 676.6853413162903, 678.1489231015094, 14401.639959001004, 14651.780223296659, 14663.92668036653, 14677.0, 14694.853051469456, 13473.663158421019, 13741.519046833413, 13840.0, 13861.584152475441, 13933.164010159322, 9508.857367139499, 11288.322700637988, 11534.873565956103, 11624.476898539502, 12159.027277817753, 3055.4194703006356, 3550.431930891071, 3597.7301702372165, 3605.4231322988458, 3731.458938453909, 101757.4912125442, 101874.9812501873, 104866.99999999924, 105213.0, 105340.0, 10151.492425378701, 10523.631672891564, 10676.679699609023, 10698.946505267579, 10758.686882320339, 19948.70076948847, 21680.13279468835, 21722.022508987135, 21913.342599722033, 21938.341849744535, 6205.565610407228, 6937.618430986243, 7318.670659820321, 7516.962415187999, 7518.097828260644, 3944.0, 4039.394090886332, 4047.170330082326, 4106.055607210358, 4247.915041699149, 3481.9477707834403, 3606.1886075633297, 3609.043603445089, 3613.6205698401814, 3619.203775169511, 632.8544434780026, 658.5949640970864, 663.8871391863395, 666.6733300682631, 675.2234929830734, 575.7380391921665, 626.7399029402837, 636.7643971730489, 638.3903372279462, 639.7792761497276, 7197.640117994079, 7704.422168337397, 8554.700585479479, 8712.520811355436, 9390.62437502506, 512.7974450092267, 519.2574618295873, 550.2818821438062, 602.3885755957706, 667.4226793823308, 4012.297847876668, 4203.5376108628025, 4313.67647426438, 4319.805608747614, 4360.361076868059, 66627.0, 75085.24914750783, 87197.20415377215, 92895.60656590156, 95192.52403737936, 57731.0, 60346.09480857791, 80345.39309213783, 82104.58947705223, 83572.91067723234, 69105.0, 70385.99999999898, 71026.0, 71589.64205179045, 73774.83576149725, 9583.472908989794, 10506.317089389166, 10615.0, 10616.787664246825, 10619.522121504706, 46857.062858741956, 48524.0, 49646.50353496563, 49806.75096624494, 50300.49699502958, 65999.68000640057, 69661.65169174122, 69866.0, 70486.0, 71745.54290113915, 13034.608961731163, 13150.342482875627, 13431.86568134306, 13634.522791702242, 14006.299685015912, 14263.144211347353, 14411.711765764836, 14561.0, 14666.926665366605, 15274.0, 11327.943360283145, 12821.777492141071, 13181.472741090249, 13203.0, 13618.659533511345, 13437.798433023709, 13549.390277437737, 13731.62683731619, 13854.238016909167, 13978.161310321413, 13088.345582720636, 13131.60605181846, 13482.32588370558, 13685.45258189701, 13800.37898294559, 8753.0, 9533.904660953302, 9865.65470208568, 9869.802603947737, 10161.136303414292, 9492.905070949202, 9521.285903557122, 9528.571214295513, 9572.521373931137, 9573.760655983377], "value": 7155.580841170498, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 112.0, 113.0, 113.0, 112.0, 114.0, 113.0, 114.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 111.0, 148.0, 113.0, 121.0, 138.0, 97.0, 161.0, 138.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 183.0, 185.0, 185.0, 185.0, 181.0, 179.0, 181.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 90.0, 63.0, 67.0, 81.0, 81.0, 101.0, 60.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 90.0, 70.0, 70.0, 70.0, 86.0, 71.0, 70.0, 86.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 130.0, 90.0, 88.0, 88.0, 86.0, 91.0, 87.0, 90.0, 86.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 94.0, 96.0, 97.0, 95.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 87.0, 85.0, 86.0, 93.0, 85.0, 86.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 58.0, 82.0, 87.0, 83.0, 85.0, 59.0, 59.0, 58.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 72.0, 76.0, 75.0, 61.0, 83.0, 58.0, 78.0, 93.0, 102.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 106.0, 89.0, 88.0, 90.0, 101.0, 108.0, 88.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 147.0, 144.0, 143.0, 141.0, 142.0, 150.0, 142.0, 207.0, 176.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 173.0, 174.0, 173.0, 176.0, 165.0, 170.0, 174.0, 173.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 67.0, 67.0, 65.0, 66.0, 65.0, 67.0], "value": 66.8, "unit": "score"}]}]} 17:29:24 INFO - Return code: 0 17:29:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:29:24 ERROR - # TBPL SUCCESS # 17:29:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:29:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:29:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:29:24 INFO - 2017-02-08 17:29:24.498 screenresolution[6565:119159] starting screenresolution argv=screenresolution get 17:29:24 INFO - 2017-02-08 17:29:24.500 screenresolution[6565:119159] Display 0: 1600x1200x32@60 17:29:24 INFO - 2017-02-08 17:29:24.507 screenresolution[6566:119162] starting screenresolution argv=screenresolution list 17:29:24 INFO - Available Modes on Display 0 17:29:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:29:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:29:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:29:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:29:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:29:24 INFO - Intel Iris: 17:29:24 INFO - Chipset Model: Intel Iris 17:29:24 INFO - Type: GPU 17:29:24 INFO - Bus: Built-In 17:29:24 INFO - VRAM (Dynamic, Max): 1536 MB 17:29:24 INFO - Vendor: Intel (0x8086) 17:29:24 INFO - Device ID: 0x0a2e 17:29:24 INFO - Revision ID: 0x0009 17:29:24 INFO - Displays: 17:29:24 INFO - Display: 17:29:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:29:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:29:24 INFO - Display Serial Number: 1600x1200 60 17:29:24 INFO - Main Display: Yes 17:29:24 INFO - Mirror: Off 17:29:24 INFO - Online: Yes 17:29:24 INFO - Rotation: Supported 17:29:24 INFO - Return code: 0 17:29:24 INFO - Running post-action listener: _resource_record_post_action 17:29:24 INFO - [mozharness: 2017-02-09 01:29:24.749203Z] Finished run-tests step (success) 17:29:24 INFO - Running post-run listener: _resource_record_post_run 17:29:24 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1416192; Write bytes: 553742336; Read time: 19; Write time: 2078 17:29:24 INFO - TinderboxPrint: CPU usage
53.7% 17:29:24 INFO - TinderboxPrint: I/O read bytes / time
1,416,192 / 19 17:29:24 INFO - TinderboxPrint: I/O write bytes / time
553,742,336 / 2,078 17:29:24 INFO - TinderboxPrint: CPU idle
2,225.9 (46.3%) 17:29:24 INFO - TinderboxPrint: CPU system
963.4 (20.0%) 17:29:24 INFO - TinderboxPrint: CPU user
1,620.5 (33.7%) 17:29:24 INFO - TinderboxPrint: Swap in / out
254,017,536 / 0 17:29:24 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 240022016; Write bytes: 234096640; Read time: 17891; Write time: 458 17:29:24 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1416192; Write bytes: 299010048; Read time: 19; Write time: 1570 17:29:25 INFO - Running post-run listener: _upload_blobber_files 17:29:25 INFO - Blob upload gear active. 17:29:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:25 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 17:29:25 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'] 17:29:25 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 17:29:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:29:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:26 INFO - (blobuploader) - INFO - Done attempting. 17:29:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:29:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:29:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:27 INFO - (blobuploader) - INFO - Done attempting. 17:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:28 INFO - (blobuploader) - INFO - Done attempting. 17:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:30 INFO - (blobuploader) - INFO - Done attempting. 17:29:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:30 INFO - Return code: 0 17:29:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f3cdcc0db12bac38ea9558b434757214e7640f283f626464b5661f8423f6377d53b22a8834ada8df6daf32ca7432629875e1bb59ad5977071635b7a3ad170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033211b95304ad527b1d4376f7aff2cec842fe5e17db41bea3dcbca9e0df009ee3694b26312d1dfb82d8fa5ec501b45251cba0d89c446ef333146f9836ff4870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9bf80c87c30e374d0c26ab1cf554f52f50aec38c688f8b82d9aba3e17644d367545f362de841fca92512fd305500e047f27ca01fa095df5d6836536cb94f03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d1ce8b2d0843e03dc411511149251597c06c1aabdf288882c90c59a5107a180e2d0b71979af1d52b6f047979c7464fc324e37b6f017a6d90466b0e3a293e30"} 17:29:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:30 INFO - Contents: 17:29:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f3cdcc0db12bac38ea9558b434757214e7640f283f626464b5661f8423f6377d53b22a8834ada8df6daf32ca7432629875e1bb59ad5977071635b7a3ad170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033211b95304ad527b1d4376f7aff2cec842fe5e17db41bea3dcbca9e0df009ee3694b26312d1dfb82d8fa5ec501b45251cba0d89c446ef333146f9836ff4870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9bf80c87c30e374d0c26ab1cf554f52f50aec38c688f8b82d9aba3e17644d367545f362de841fca92512fd305500e047f27ca01fa095df5d6836536cb94f03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d1ce8b2d0843e03dc411511149251597c06c1aabdf288882c90c59a5107a180e2d0b71979af1d52b6f047979c7464fc324e37b6f017a6d90466b0e3a293e30"} 17:29:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:30 INFO - Copying logs to upload dir... 17:29:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.114904 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-08 17:29:31.435251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 17:29:31.439089) ========= 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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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/f1f3cdcc0db12bac38ea9558b434757214e7640f283f626464b5661f8423f6377d53b22a8834ada8df6daf32ca7432629875e1bb59ad5977071635b7a3ad170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033211b95304ad527b1d4376f7aff2cec842fe5e17db41bea3dcbca9e0df009ee3694b26312d1dfb82d8fa5ec501b45251cba0d89c446ef333146f9836ff4870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9bf80c87c30e374d0c26ab1cf554f52f50aec38c688f8b82d9aba3e17644d367545f362de841fca92512fd305500e047f27ca01fa095df5d6836536cb94f03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d1ce8b2d0843e03dc411511149251597c06c1aabdf288882c90c59a5107a180e2d0b71979af1d52b6f047979c7464fc324e37b6f017a6d90466b0e3a293e30"} build_url:https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/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/f1f3cdcc0db12bac38ea9558b434757214e7640f283f626464b5661f8423f6377d53b22a8834ada8df6daf32ca7432629875e1bb59ad5977071635b7a3ad170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033211b95304ad527b1d4376f7aff2cec842fe5e17db41bea3dcbca9e0df009ee3694b26312d1dfb82d8fa5ec501b45251cba0d89c446ef333146f9836ff4870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9bf80c87c30e374d0c26ab1cf554f52f50aec38c688f8b82d9aba3e17644d367545f362de841fca92512fd305500e047f27ca01fa095df5d6836536cb94f03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d1ce8b2d0843e03dc411511149251597c06c1aabdf288882c90c59a5107a180e2d0b71979af1d52b6f047979c7464fc324e37b6f017a6d90466b0e3a293e30"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 17:29:31.480791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:29:31.481166) ========= 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.LhD8pGbIgI/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.9eQDyqLuqf/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005310 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:29:31.530821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 17:29:31.531177) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 17:29:31.531545) ========= ========= Total master_lag: 0.64 =========