builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0243 starttime: 1490350397.48 results: success (0) buildid: 20170324022724 builduid: 3369a05a698143c9b1f1ce0c254dd578 revision: d6b911d8d67722d0b5aed02f3afbf22343bd6295 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.485090) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.485503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.485783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.533336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.533720) ========= 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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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-03-24 03:13:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2017-03-24 03:13:17 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113885 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.929928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.930276) ========= 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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.031916 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:17.987008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 03:13:17.987414) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d6b911d8d67722d0b5aed02f3afbf22343bd6295 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d6b911d8d67722d0b5aed02f3afbf22343bd6295 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PEeAfR3s4b/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.1pZG6g8QXO/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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-03-24 03:13:18,096 truncating revision to first 12 chars 2017-03-24 03:13:18,096 Setting DEBUG logging. 2017-03-24 03:13:18,096 attempt 1/10 2017-03-24 03:13:18,096 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d6b911d8d677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 03:13:19,528 unpacking tar archive at: mozilla-aurora-d6b911d8d677/testing/mozharness/ program finished with exit code 0 elapsedTime=1.707242 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 03:13:19.725188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:19.725615) ========= script_repo_revision: d6b911d8d67722d0b5aed02f3afbf22343bd6295 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:19.726051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:19.726321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 03:13:19.755291) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-24 03:13:19.755894) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PEeAfR3s4b/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.1pZG6g8QXO/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:13:19 INFO - MultiFileLogger online at 20170324 03:13:19 in /builds/slave/test 03:13:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:13:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:13:19 INFO - {'append_to_log': False, 03:13:19 INFO - 'base_work_dir': '/builds/slave/test', 03:13:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:13:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:13:19 INFO - 'branch': 'Mozilla-Aurora', 03:13:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:13:19 INFO - 'config_files': ('talos/mac_config.py',), 03:13:19 INFO - 'default_actions': ('clobber', 03:13:19 INFO - 'read-buildbot-config', 03:13:19 INFO - 'download-and-extract', 03:13:19 INFO - 'populate-webroot', 03:13:19 INFO - 'create-virtualenv', 03:13:19 INFO - 'install', 03:13:19 INFO - 'run-tests'), 03:13:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:13:19 INFO - 'download_minidump_stackwalk': True, 03:13:19 INFO - 'download_symbols': 'ondemand', 03:13:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:13:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:13:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:13:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:13:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:13:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:13:19 INFO - 'gecko_profile': False, 03:13:19 INFO - 'gecko_profile_interval': 0, 03:13:19 INFO - 'installer_path': 'installer.exe', 03:13:19 INFO - 'log_level': 'info', 03:13:19 INFO - 'log_name': 'talos', 03:13:19 INFO - 'log_to_console': True, 03:13:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:13:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:13:19 INFO - 'opt_config_files': (), 03:13:19 INFO - 'pip_index': False, 03:13:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:13:19 INFO - 'cmd': ('bash', 03:13:19 INFO - '-c', 03:13:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:13:19 INFO - 'enabled': True, 03:13:19 INFO - 'halt_on_failure': False, 03:13:19 INFO - 'name': 'check_screen_resolution'},), 03:13:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:13:19 INFO - 'cmd': ('bash', 03:13:19 INFO - '-c', 03:13:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:13:19 INFO - 'enabled': True, 03:13:19 INFO - 'halt_on_failure': False, 03:13:19 INFO - 'name': 'check_screen_resolution'},), 03:13:19 INFO - 'run_cmd_checks_enabled': True, 03:13:19 INFO - 'suite': 'dromaeojs', 03:13:19 INFO - 'system_bits': '32', 03:13:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:13:19 INFO - 'title': 't-yosemite-r7-0243', 03:13:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:13:19 INFO - 'use_talos_json': True, 03:13:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:13:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:13:19 INFO - 'work_dir': 'build'} 03:13:19 INFO - [mozharness: 2017-03-24 10:13:19.968234Z] Running clobber step. 03:13:19 INFO - Running pre-action listener: _resource_record_pre_action 03:13:19 INFO - Running main action method: clobber 03:13:19 INFO - rmtree: /builds/slave/test/build 03:13:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:13:24 INFO - Running post-action listener: _resource_record_post_action 03:13:24 INFO - [mozharness: 2017-03-24 10:13:24.241152Z] Finished clobber step (success) 03:13:24 INFO - [mozharness: 2017-03-24 10:13:24.241279Z] Running read-buildbot-config step. 03:13:24 INFO - Running pre-action listener: _resource_record_pre_action 03:13:24 INFO - Running main action method: read_buildbot_config 03:13:24 INFO - Using buildbot properties: 03:13:24 INFO - { 03:13:24 INFO - "project": "", 03:13:24 INFO - "product": "firefox", 03:13:24 INFO - "script_repo_revision": "production", 03:13:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:13:24 INFO - "repository": "", 03:13:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:13:24 INFO - "buildid": "20170324022724", 03:13:24 INFO - "pgo_build": "False", 03:13:24 INFO - "basedir": "/builds/slave/test", 03:13:24 INFO - "buildnumber": 98, 03:13:24 INFO - "slavename": "t-yosemite-r7-0243", 03:13:24 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:13:24 INFO - "platform": "yosemite_r7", 03:13:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:13:24 INFO - "branch": "mozilla-aurora", 03:13:24 INFO - "repo_path": "releases/mozilla-aurora", 03:13:24 INFO - "revision": "d6b911d8d67722d0b5aed02f3afbf22343bd6295", 03:13:24 INFO - "stage_platform": "macosx64", 03:13:24 INFO - "builduid": "3369a05a698143c9b1f1ce0c254dd578", 03:13:24 INFO - "slavebuilddir": "test" 03:13:24 INFO - } 03:13:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:13:24 INFO - Running post-action listener: _resource_record_post_action 03:13:24 INFO - [mozharness: 2017-03-24 10:13:24.244550Z] Finished read-buildbot-config step (success) 03:13:24 INFO - [mozharness: 2017-03-24 10:13:24.244683Z] Running download-and-extract step. 03:13:24 INFO - Running pre-action listener: _resource_record_pre_action 03:13:24 INFO - Running main action method: download_and_extract 03:13:24 INFO - mkdir: /builds/slave/test/build/tests 03:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:24 INFO - trying https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:13:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 03:13:25 INFO - Downloaded 1199 bytes. 03:13:25 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:13:25 INFO - Using the following test package requirements: 03:13:25 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:13:25 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:13:25 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:13:25 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'jsshell-mac.zip'], 03:13:25 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:13:25 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:13:25 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:13:25 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:13:25 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:13:25 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:13:25 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:13:25 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:13:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:13:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:13:25 INFO - Fetch https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:13:26 INFO - Expected file size: 51787035 03:13:26 INFO - Obtained file size: 51787035 03:13:42 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:13:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:13:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:13:42 INFO - Fetch https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:13:44 INFO - Expected file size: 51787035 03:13:44 INFO - Obtained file size: 51787035 03:13:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:13:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:13:59 INFO - Fetch https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:14:00 INFO - Expected file size: 14404438 03:14:00 INFO - Obtained file size: 14404438 03:14:01 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')]} 03:14:01 INFO - trying https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:14:01 INFO - Downloading https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 03:14:03 INFO - Downloaded 74765521 bytes. 03:14:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:14:03 INFO - mkdir: /builds/slave/test/properties 03:14:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:14:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:14:03 INFO - Contents: 03:14:03 INFO - build_url:https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:14:03 INFO - Running post-action listener: _resource_record_post_action 03:14:03 INFO - Running post-action listener: set_extra_try_arguments 03:14:03 INFO - [mozharness: 2017-03-24 10:14:03.978344Z] Finished download-and-extract step (success) 03:14:03 INFO - [mozharness: 2017-03-24 10:14:03.978501Z] Running populate-webroot step. 03:14:03 INFO - Running pre-action listener: _resource_record_pre_action 03:14:03 INFO - Running main action method: populate_webroot 03:14:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:14:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:14:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:14:03 INFO - '--tppagecycles', 03:14:03 INFO - '7'], 03:14:03 INFO - 'tests': ['tsvgm']}}, 03:14:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:14:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:14:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:14:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:14:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:14:03 INFO - 'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:14:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:14:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:14:03 INFO - 'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['damp', 'tps']}, 03:14:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:14:03 INFO - 'tests': ['damp', 'tps']}, 03:14:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['dromaeo_dom']}, 03:14:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:14:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['basic_compositor_video']}, 03:14:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:14:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['a11yr', 03:14:03 INFO - 'ts_paint', 03:14:03 INFO - 'tpaint', 03:14:03 INFO - 'sessionrestore', 03:14:03 INFO - 'sessionrestore_no_auto_restore', 03:14:03 INFO - 'tabpaint']}, 03:14:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:14:03 INFO - 'ts_paint', 03:14:03 INFO - 'tpaint', 03:14:03 INFO - 'sessionrestore', 03:14:03 INFO - 'sessionrestore_no_auto_restore', 03:14:03 INFO - 'tabpaint']}, 03:14:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:14:03 INFO - 'ts_paint', 03:14:03 INFO - 'tpaint', 03:14:03 INFO - 'sessionrestore', 03:14:03 INFO - 'sessionrestore_no_auto_restore', 03:14:03 INFO - 'tabpaint']}, 03:14:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:14:03 INFO - 'ts_paint', 03:14:03 INFO - 'tpaint', 03:14:03 INFO - 'sessionrestore', 03:14:03 INFO - 'sessionrestore_no_auto_restore', 03:14:03 INFO - 'tabpaint']}, 03:14:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['a11yr', 03:14:03 INFO - 'ts_paint', 03:14:03 INFO - 'tpaint', 03:14:03 INFO - 'sessionrestore', 03:14:03 INFO - 'sessionrestore_no_auto_restore', 03:14:03 INFO - 'tabpaint']}, 03:14:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['a11yr', 03:14:03 INFO - 'ts_paint', 03:14:03 INFO - 'tpaint', 03:14:03 INFO - 'sessionrestore', 03:14:03 INFO - 'sessionrestore_no_auto_restore', 03:14:03 INFO - 'tabpaint']}, 03:14:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['tsvgx', 03:14:03 INFO - 'tsvgr_opacity', 03:14:03 INFO - 'tart', 03:14:03 INFO - 'tscrollx', 03:14:03 INFO - 'cart', 03:14:03 INFO - 'tsvg_static']}, 03:14:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:14:03 INFO - 'tsvgr_opacity', 03:14:03 INFO - 'tart', 03:14:03 INFO - 'tscrollx', 03:14:03 INFO - 'cart', 03:14:03 INFO - 'tsvg_static']}, 03:14:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:14:03 INFO - 'talos_options': ['--disable-e10s'], 03:14:03 INFO - 'tests': ['tp5o']}, 03:14:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:14:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:14:03 INFO - 'talos_options': ['--disable-e10s', 03:14:03 INFO - '--xperf_path', 03:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:14:03 INFO - 'tests': ['tp5n']}, 03:14:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:14:03 INFO - 'talos_options': ['--xperf_path', 03:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:14:03 INFO - 'tests': ['tp5n']}}, 03:14:03 INFO - 'talos.zip': {'path': '', 03:14:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:14:03 INFO - Running post-action listener: _resource_record_post_action 03:14:03 INFO - [mozharness: 2017-03-24 10:14:03.996855Z] Finished populate-webroot step (success) 03:14:03 INFO - [mozharness: 2017-03-24 10:14:03.996985Z] Running create-virtualenv step. 03:14:03 INFO - Running pre-action listener: _resource_record_pre_action 03:14:03 INFO - Running main action method: create_virtualenv 03:14:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:14:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:14:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:14:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:14:04 INFO - Using real prefix '/tools/python27' 03:14:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:14:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:14:07 INFO - Installing pip.................done. 03:14:07 INFO - Return code: 0 03:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:14:08 INFO - Reading from file tmpfile_stdout 03:14:08 INFO - Output received: 03:14:08 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) 03:14:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:14:08 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')]} 03:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:08 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')]} 03:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:08 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:08 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 03:14:08 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 03:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:08 INFO - 'HOME': '/Users/cltbld', 03:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:08 INFO - 'LOGNAME': 'cltbld', 03:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:08 INFO - 'MOZ_NO_REMOTE': '1', 03:14:08 INFO - 'NO_EM_RESTART': '1', 03:14:08 INFO - 'PAGER': '/bin/cat', 03:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:08 INFO - 'PWD': '/builds/slave/test', 03:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:08 INFO - 'SHELL': '/bin/bash', 03:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:08 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:08 INFO - 'USER': 'cltbld', 03:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:08 INFO - 'XPC_FLAGS': '0x0', 03:14:08 INFO - 'XPC_SERVICE_NAME': '0', 03:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:08 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 03:14:08 INFO - Cleaning up... 03:14:08 INFO - Return code: 0 03:14:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:14:08 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')]} 03:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:08 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')]} 03:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:08 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:08 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 03:14:08 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 03:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:08 INFO - 'HOME': '/Users/cltbld', 03:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:08 INFO - 'LOGNAME': 'cltbld', 03:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:08 INFO - 'MOZ_NO_REMOTE': '1', 03:14:08 INFO - 'NO_EM_RESTART': '1', 03:14:08 INFO - 'PAGER': '/bin/cat', 03:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:08 INFO - 'PWD': '/builds/slave/test', 03:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:08 INFO - 'SHELL': '/bin/bash', 03:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:08 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:08 INFO - 'USER': 'cltbld', 03:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:08 INFO - 'XPC_FLAGS': '0x0', 03:14:08 INFO - 'XPC_SERVICE_NAME': '0', 03:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:08 INFO - Downloading/unpacking psutil>=3.1.1 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:14:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:14:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:14:12 INFO - Installing collected packages: psutil 03:14:12 INFO - Running setup.py install for psutil 03:14:12 INFO - building 'psutil._psutil_osx' extension 03:14:12 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 03:14:12 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 03:14:12 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 03:14:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:14:12 INFO - building 'psutil._psutil_posix' extension 03:14:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:14:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:14:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:14:12 INFO - ^ 03:14:13 INFO - 1 warning generated. 03:14:13 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 03:14:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:14:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:14:13 INFO - Successfully installed psutil 03:14:13 INFO - Cleaning up... 03:14:13 INFO - Return code: 0 03:14:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:14:13 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')]} 03:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:13 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')]} 03:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:14 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:14 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 03:14:14 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 03:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:14 INFO - 'HOME': '/Users/cltbld', 03:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:14 INFO - 'LOGNAME': 'cltbld', 03:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:14 INFO - 'MOZ_NO_REMOTE': '1', 03:14:14 INFO - 'NO_EM_RESTART': '1', 03:14:14 INFO - 'PAGER': '/bin/cat', 03:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:14 INFO - 'PWD': '/builds/slave/test', 03:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:14 INFO - 'SHELL': '/bin/bash', 03:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:14 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:14 INFO - 'USER': 'cltbld', 03:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:14 INFO - 'XPC_FLAGS': '0x0', 03:14:14 INFO - 'XPC_SERVICE_NAME': '0', 03:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:14:17 INFO - Installing collected packages: mozsystemmonitor 03:14:17 INFO - Running setup.py install for mozsystemmonitor 03:14:17 INFO - Successfully installed mozsystemmonitor 03:14:17 INFO - Cleaning up... 03:14:17 INFO - Return code: 0 03:14:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:17 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:17 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 03:14:17 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 03:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:17 INFO - 'HOME': '/Users/cltbld', 03:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:17 INFO - 'LOGNAME': 'cltbld', 03:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:17 INFO - 'MOZ_NO_REMOTE': '1', 03:14:17 INFO - 'NO_EM_RESTART': '1', 03:14:17 INFO - 'PAGER': '/bin/cat', 03:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:17 INFO - 'PWD': '/builds/slave/test', 03:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:17 INFO - 'SHELL': '/bin/bash', 03:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:17 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:17 INFO - 'USER': 'cltbld', 03:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:17 INFO - 'XPC_FLAGS': '0x0', 03:14:17 INFO - 'XPC_SERVICE_NAME': '0', 03:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:17 INFO - Downloading/unpacking jsonschema==2.5.1 03:14:17 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 03:14:17 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 03:14:17 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 03:14:17 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 03:14:17 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 03:14:17 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 03:14:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:14:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:14:20 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 03:14:20 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 03:14:20 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 03:14:20 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 03:14:20 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 03:14:20 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 03:14:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:14:20 INFO - warning: no files found matching '*.txt' 03:14:20 INFO - no previously-included directories found matching 'build' 03:14:20 INFO - no previously-included directories found matching 'dist' 03:14:20 INFO - no previously-included directories found matching '.git*' 03:14:20 INFO - Installing collected packages: jsonschema, functools32 03:14:20 INFO - Running setup.py install for functools32 03:14:21 INFO - warning: no files found matching '*.txt' 03:14:21 INFO - no previously-included directories found matching 'build' 03:14:21 INFO - no previously-included directories found matching 'dist' 03:14:21 INFO - no previously-included directories found matching '.git*' 03:14:21 INFO - Successfully installed jsonschema functools32 03:14:21 INFO - Cleaning up... 03:14:21 INFO - Return code: 0 03:14:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:14: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')]} 03:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14: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')]} 03:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14: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', '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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:14: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 functools32==3.2.3-2 03:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:21 INFO - 'HOME': '/Users/cltbld', 03:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:21 INFO - 'LOGNAME': 'cltbld', 03:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:21 INFO - 'MOZ_NO_REMOTE': '1', 03:14:21 INFO - 'NO_EM_RESTART': '1', 03:14:21 INFO - 'PAGER': '/bin/cat', 03:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:21 INFO - 'PWD': '/builds/slave/test', 03:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:21 INFO - 'SHELL': '/bin/bash', 03:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:21 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:21 INFO - 'USER': 'cltbld', 03:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:21 INFO - 'XPC_FLAGS': '0x0', 03:14:21 INFO - 'XPC_SERVICE_NAME': '0', 03:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:14:21 INFO - Cleaning up... 03:14:21 INFO - Return code: 0 03:14:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:14: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')]} 03:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14: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')]} 03:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14: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', '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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:14: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 blobuploader==1.2.4 03:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:21 INFO - 'HOME': '/Users/cltbld', 03:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:21 INFO - 'LOGNAME': 'cltbld', 03:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:21 INFO - 'MOZ_NO_REMOTE': '1', 03:14:21 INFO - 'NO_EM_RESTART': '1', 03:14:21 INFO - 'PAGER': '/bin/cat', 03:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:21 INFO - 'PWD': '/builds/slave/test', 03:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:21 INFO - 'SHELL': '/bin/bash', 03:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:21 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:21 INFO - 'USER': 'cltbld', 03:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:21 INFO - 'XPC_FLAGS': '0x0', 03:14:21 INFO - 'XPC_SERVICE_NAME': '0', 03:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:21 INFO - Downloading/unpacking blobuploader==1.2.4 03:14:21 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 03:14:21 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 03:14:21 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 03:14:21 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 03:14:21 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 03:14:21 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 03:14:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:14:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:14:24 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 03:14:24 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 03:14:24 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 03:14:24 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 03:14:24 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 03:14:24 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 03:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:14:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:14:25 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 03:14:25 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 03:14:25 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 03:14:25 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 03:14:25 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 03:14:25 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 03:14:25 INFO - Downloading docopt-0.6.1.tar.gz 03:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:14:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:14:25 INFO - Running setup.py install for blobuploader 03:14:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:14:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:14:25 INFO - Running setup.py install for requests 03:14:26 INFO - Running setup.py install for docopt 03:14:26 INFO - Successfully installed blobuploader requests docopt 03:14:26 INFO - Cleaning up... 03:14:26 INFO - Return code: 0 03:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14:26 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')]} 03:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:26 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')]} 03:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:26 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:26 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 03:14:26 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 03:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:26 INFO - 'HOME': '/Users/cltbld', 03:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:26 INFO - 'LOGNAME': 'cltbld', 03:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:26 INFO - 'MOZ_NO_REMOTE': '1', 03:14:26 INFO - 'NO_EM_RESTART': '1', 03:14:26 INFO - 'PAGER': '/bin/cat', 03:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:26 INFO - 'PWD': '/builds/slave/test', 03:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:26 INFO - 'SHELL': '/bin/bash', 03:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:26 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:26 INFO - 'USER': 'cltbld', 03:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:26 INFO - 'XPC_FLAGS': '0x0', 03:14:26 INFO - 'XPC_SERVICE_NAME': '0', 03:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:14:26 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Vuc59l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:14:26 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-lC9uFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:14:26 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-R7YgmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-LLCXkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-TT5S3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-93OUfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Q64Kok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-WxcEHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-jm54Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-dt8r1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-oRn9P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:14:27 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-33lr_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:14:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-hiBMwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:14:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Gnmq5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-VX4WNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:14:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-_vRgQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:14:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-wMcrjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:14:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:14:28 INFO - Running setup.py install for manifestparser 03:14:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:14:28 INFO - Running setup.py install for mozcrash 03:14:28 INFO - Running setup.py install for mozdebug 03:14:28 INFO - Running setup.py install for mozdevice 03:14:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Running setup.py install for mozfile 03:14:29 INFO - Running setup.py install for mozhttpd 03:14:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Running setup.py install for mozinfo 03:14:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Running setup.py install for mozInstall 03:14:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Running setup.py install for mozleak 03:14:29 INFO - Running setup.py install for mozlog 03:14:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for moznetwork 03:14:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for mozprocess 03:14:30 INFO - Running setup.py install for mozprofile 03:14:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for mozrunner 03:14:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for mozscreenshot 03:14:30 INFO - Running setup.py install for moztest 03:14:30 INFO - Running setup.py install for mozversion 03:14:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:14:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:14:31 INFO - Cleaning up... 03:14:31 INFO - Return code: 0 03:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14:31 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')]} 03:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:31 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')]} 03:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:31 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:31 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 03:14:31 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 03:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:31 INFO - 'HOME': '/Users/cltbld', 03:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:31 INFO - 'LOGNAME': 'cltbld', 03:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:31 INFO - 'MOZ_NO_REMOTE': '1', 03:14:31 INFO - 'NO_EM_RESTART': '1', 03:14:31 INFO - 'PAGER': '/bin/cat', 03:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:31 INFO - 'PWD': '/builds/slave/test', 03:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:31 INFO - 'SHELL': '/bin/bash', 03:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:31 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:31 INFO - 'USER': 'cltbld', 03:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:31 INFO - 'XPC_FLAGS': '0x0', 03:14:31 INFO - 'XPC_SERVICE_NAME': '0', 03:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:14:31 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-xquIWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:14:31 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)) 03:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:14:31 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-qK_qGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:14:31 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)) 03:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:14:31 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-7vzPFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:14:31 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)) 03:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:14:31 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-mMKESS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:14:31 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)) 03:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:14:31 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-JO9iUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:14:31 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)) 03:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:14:31 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-IZWF2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-TzgOqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-CPW5Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-lx0McL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-WjHIhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-MCZUbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-uVXq7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:14:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-riyh0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-oRqQRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:32 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-_qyIUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:14:33 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-lzo1al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:14:33 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ituHT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:14:33 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)) 03:14:33 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)) 03:14:33 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)) 03:14:33 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)) 03:14:33 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)) 03:14:33 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)) 03:14:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:14:33 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 03:14:33 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 03:14:33 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 03:14:33 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 03:14:33 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 03:14:33 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 03:14:35 INFO - Downloading blessings-1.6.tar.gz 03:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:14:35 INFO - Installing collected packages: blessings 03:14:35 INFO - Running setup.py install for blessings 03:14:36 INFO - Successfully installed blessings 03:14:36 INFO - Cleaning up... 03:14:36 INFO - Return code: 0 03:14:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:14:36 INFO - Reading from file tmpfile_stdout 03:14:36 INFO - Current package versions: 03:14:36 INFO - blessings == 1.6 03:14:36 INFO - blobuploader == 1.2.4 03:14:36 INFO - docopt == 0.6.1 03:14:36 INFO - functools32 == 3.2.3-2 03:14:36 INFO - jsonschema == 2.5.1 03:14:36 INFO - manifestparser == 1.1 03:14:36 INFO - mozInstall == 1.12 03:14:36 INFO - mozcrash == 1.0 03:14:36 INFO - mozdebug == 0.1 03:14:36 INFO - mozdevice == 0.49 03:14:36 INFO - mozfile == 1.2 03:14:36 INFO - mozhttpd == 0.7 03:14:36 INFO - mozinfo == 0.9 03:14:36 INFO - mozleak == 0.1 03:14:36 INFO - mozlog == 3.4 03:14:36 INFO - moznetwork == 0.27 03:14:36 INFO - mozprocess == 0.25 03:14:36 INFO - mozprofile == 0.28 03:14:36 INFO - mozrunner == 6.13 03:14:36 INFO - mozscreenshot == 0.1 03:14:36 INFO - mozsystemmonitor == 0.3 03:14:36 INFO - moztest == 0.8 03:14:36 INFO - mozversion == 1.4 03:14:36 INFO - psutil == 3.1.1 03:14:36 INFO - requests == 1.2.3 03:14:36 INFO - wsgiref == 0.1.2 03:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14:36 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')]} 03:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:36 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')]} 03:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:36 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:36 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 03:14:36 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 03:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:36 INFO - 'HOME': '/Users/cltbld', 03:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:36 INFO - 'LOGNAME': 'cltbld', 03:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:36 INFO - 'MOZ_NO_REMOTE': '1', 03:14:36 INFO - 'NO_EM_RESTART': '1', 03:14:36 INFO - 'PAGER': '/bin/cat', 03:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:36 INFO - 'PWD': '/builds/slave/test', 03:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:36 INFO - 'SHELL': '/bin/bash', 03:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:36 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:36 INFO - 'USER': 'cltbld', 03:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:36 INFO - 'XPC_FLAGS': '0x0', 03:14:36 INFO - 'XPC_SERVICE_NAME': '0', 03:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 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)) 03:14:36 INFO - Cleaning up... 03:14:36 INFO - Return code: 0 03:14:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:14:36 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')]} 03:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:36 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')]} 03:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:36 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 0x10e817b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e81a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a95c4a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, '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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 03:14:36 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 03:14:36 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 03:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:36 INFO - 'HOME': '/Users/cltbld', 03:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:36 INFO - 'LOGNAME': 'cltbld', 03:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:36 INFO - 'MOZ_NO_REMOTE': '1', 03:14:36 INFO - 'NO_EM_RESTART': '1', 03:14:36 INFO - 'PAGER': '/bin/cat', 03:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:36 INFO - 'PWD': '/builds/slave/test', 03:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:36 INFO - 'SHELL': '/bin/bash', 03:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:36 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:36 INFO - 'USER': 'cltbld', 03:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:36 INFO - 'XPC_FLAGS': '0x0', 03:14:36 INFO - 'XPC_SERVICE_NAME': '0', 03:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:14:37 INFO - Cleaning up... 03:14:37 INFO - Return code: 0 03:14:37 INFO - Running post-action listener: _resource_record_post_action 03:14:37 INFO - Running post-action listener: _start_resource_monitoring 03:14:37 INFO - Starting resource monitoring. 03:14:37 INFO - [mozharness: 2017-03-24 10:14:37.088271Z] Finished create-virtualenv step (success) 03:14:37 INFO - [mozharness: 2017-03-24 10:14:37.089277Z] Running install step. 03:14:37 INFO - Running pre-action listener: _resource_record_pre_action 03:14:37 INFO - Running main action method: install 03:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:14:37 INFO - Reading from file tmpfile_stdout 03:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 03:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:14:37 INFO - Reading from file tmpfile_stdout 03:14:37 INFO - Output received: 03:14:37 INFO - Usage: mozinstall [options] installer 03:14:37 INFO - Options: 03:14:37 INFO - -h, --help show this help message and exit 03:14:37 INFO - -d DEST, --destination=DEST 03:14:37 INFO - Directory to install application into. [default: 03:14:37 INFO - "/builds/slave/test"] 03:14:37 INFO - --app=APP Application being installed. [default: firefox] 03:14:37 INFO - mkdir: /builds/slave/test/build/application 03:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:14:57 INFO - Reading from file tmpfile_stdout 03:14:57 INFO - Output received: 03:14:57 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:14:57 INFO - Running post-action listener: _resource_record_post_action 03:14:57 INFO - [mozharness: 2017-03-24 10:14:57.382521Z] Finished install step (success) 03:14:57 INFO - [mozharness: 2017-03-24 10:14:57.382665Z] Running run-tests step. 03:14:57 INFO - Running pre-action listener: _resource_record_pre_action 03:14:57 INFO - Running main action method: run_tests 03:14:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:14:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:14:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:14:57 INFO - 2017-03-24 03:14:57.397 screenresolution[1627:7502] starting screenresolution argv=screenresolution get 03:14:57 INFO - 2017-03-24 03:14:57.400 screenresolution[1627:7502] Display 0: 1600x1200x32@60 03:14:57 INFO - 2017-03-24 03:14:57.405 screenresolution[1628:7505] starting screenresolution argv=screenresolution list 03:14:57 INFO - Available Modes on Display 0 03:14:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:14:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:14:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:14:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:14:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:14:57 INFO - Intel Iris: 03:14:57 INFO - Chipset Model: Intel Iris 03:14:57 INFO - Type: GPU 03:14:57 INFO - Bus: Built-In 03:14:57 INFO - VRAM (Dynamic, Max): 1536 MB 03:14:57 INFO - Vendor: Intel (0x8086) 03:14:57 INFO - Device ID: 0x0a2e 03:14:57 INFO - Revision ID: 0x0009 03:14:57 INFO - Displays: 03:14:57 INFO - Display: 03:14:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:14:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:14:57 INFO - Display Serial Number: 1600x1200 60 03:14:57 INFO - Main Display: Yes 03:14:57 INFO - Mirror: Off 03:14:57 INFO - Online: Yes 03:14:57 INFO - Rotation: Supported 03:14:57 INFO - Return code: 0 03:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:14:57 INFO - Python 2.7.3 03:14:57 INFO - Return code: 0 03:14:57 INFO - grabbing minidump binary from tooltool 03:14: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')]} 03:14:57 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 0x10e5f5d30>, '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 0x10e51cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:14:57 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 03:14:57 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 03:14:57 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 03:14:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:14:57 INFO - Return code: 0 03:14:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:14:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:14:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:14:57 INFO - ENV: RUST_BACKTRACE is now 1 03:14:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:14:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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 03:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0243 --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 03:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEeAfR3s4b/Render', 03:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:57 INFO - 'HOME': '/Users/cltbld', 03:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:57 INFO - 'LOGNAME': 'cltbld', 03:14:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:14:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:57 INFO - 'MOZ_NO_REMOTE': '1', 03:14:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:14:57 INFO - 'NO_EM_RESTART': '1', 03:14:57 INFO - 'PAGER': '/bin/cat', 03:14:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:57 INFO - 'PWD': '/builds/slave/test', 03:14:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:57 INFO - 'RUST_BACKTRACE': '1', 03:14:57 INFO - 'SHELL': '/bin/bash', 03:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1pZG6g8QXO/Listeners', 03:14:57 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 03:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:57 INFO - 'USER': 'cltbld', 03:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:57 INFO - 'XPC_FLAGS': '0x0', 03:14:57 INFO - 'XPC_SERVICE_NAME': '0', 03:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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 03:14:57 INFO - mozversion application_buildid: 20170324022724 03:14:57 INFO - mozversion application_changeset: d6b911d8d67722d0b5aed02f3afbf22343bd6295 03:14:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:14:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:14:57 INFO - mozversion application_name: Firefox 03:14:57 INFO - mozversion application_remotingname: firefox-dev 03:14:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:14:57 INFO - mozversion application_vendor: Mozilla 03:14:57 INFO - mozversion application_version: 54.0a2 03:14:57 INFO - mozversion platform_buildid: 20170324022724 03:14:57 INFO - mozversion platform_changeset: d6b911d8d67722d0b5aed02f3afbf22343bd6295 03:14:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:14:57 INFO - mozversion platform_version: 54.0a2 03:14:57 INFO - using testdate: 1490350497 03:14:57 INFO - actual date: 1490350497 03:14:57 INFO - starting webserver on 'localhost:49248' 03:14:57 INFO - SUITE-START | Running 2 tests 03:14:57 INFO - TEST-START | dromaeo_css 03:14:57 INFO - operating with platform_type : mac_ 03:14:57 INFO - Initialising browser for dromaeo_css test... 03:14:58 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpJ4bSaq/profile http://localhost:49248/getInfo.html) 03:15:00 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 03:15:00 INFO - PROCESS | 1638 | colorDepth:24 03:15:00 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 03:15:00 INFO - PROCESS | 1638 | __metrics 03:15:00 INFO - PROCESS | 1638 | 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" 03:15:00 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:15:01 INFO - TEST-INFO | 1638: exit 0 03:15:01 INFO - Browser initialized. 03:15:01 INFO - Running cycle 1/1 for dromaeo_css test... 03:15:01 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpJ4bSaq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:13 INFO - PROCESS | 1640 | RSS: Main: 215367680 03:15:13 INFO - PROCESS | 1640 | 03:18:18 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 03:18:20 INFO - PROCESS | 1640 | RSS: Main: 341458944 03:18:20 INFO - PROCESS | 1640 | 03:20:03 INFO - PROCESS | 1640 | ************************* 03:20:03 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 03:20:03 INFO - PROCESS | 1640 | 03:20:03 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:20:03 INFO - PROCESS | 1640 | Full stack: 03:20:03 INFO - PROCESS | 1640 | ************************* 03:21:23 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 03:21:23 INFO - PROCESS | 1640 | RSS: Main: 349433856 03:21:23 INFO - PROCESS | 1640 | 03:24:26 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 03:24:26 INFO - PROCESS | 1640 | RSS: Main: 334057472 03:24:26 INFO - PROCESS | 1640 | 03:27:29 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 03:27:29 INFO - PROCESS | 1640 | RSS: Main: 336011264 03:27:29 INFO - PROCESS | 1640 | 03:30:33 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 03:30:34 INFO - PROCESS | 1640 | RSS: Main: 321347584 03:30:34 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 03:33:37 INFO - PROCESS | 1640 | RSS: Main: 478961664 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | __start_tp_report 03:33:37 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 03:33:37 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 03:33:37 INFO - PROCESS | 1640 | |i|pagename|runs| 03:33:37 INFO - PROCESS | 1640 | |0;dojo.html;3429.416999110151;3445.328161008604;3463.1861512544556;3479.1302174456387;3502.7723197992127;6106.816795496136;6141.293751218611;6142.877142457148;6143.170671959284;6166.105914642374;5256.817216126369;6056.818295451144;6090.208272924514;6134.539909506793;6147.846303842406;5422.078246698061;5436.891262174754;5471.425500322469;5491.917621235684;5576.107822748361;5000.5999520038495;5378.2470454136255;5388.811391601294;5580.051391263474;5580.99542082425;5445.673259604417;5447.12845944647;5505.889882202354;5557.944420555783;5559.610827242094;5481.890362192754;5529.944700552983;5531.557475401958;5534.557235421156;5545.085060964936;5357.678539287616;5429.8099566515375;5478.726063696799;5482.91775623366;5517.779288828442;5953.553483488712;5978.372270911535;6001.759929602811;6062.151298818169;6130.4176103270565;5533.667979921218;5561.277033985596;6409.029273350887;6445.903311450332;6474.643894585796;6481.351864813481;6508.25155107164;6530.44491218247;6536.869262614769;6561.3438656134485;6016;6069.484093851984;6087.05650624154;6156.907646385353;6230.5638605297645;6568.014797780275;6608.735650574019;6664.067030615718;6715.93284067153;6716.597004179765;6313.905291420632;6320.5891617044745;6327.303996560375;6333.398327158912;6337.366263373626;6239.376062393815;6397.232332120176;6474.708638111297;6478.449331806755;6484.675766211671;6267.122602835607;6272.1219029335925;6280.214973128359;6351.904721429182;6366.331535188739;6186.133941248228;6227.937720622826;6283.277423096311;6318.8420289492215;6379.362063793584;5157.58739300855;5195.948040519546;5236.3716354037;5278.551323137576;5280.023195708806;4547.613452856544;4634.420697412824;4637.976810115928;4643.558861908114;4672.509386514435;6050.273967123885;6062.545309101835;6067.514598832083;6074.058520929263;6077.20996270482;6301.6534090625455;6308.684565771693;6315.55791094619;6316.210473690789;6323.27282362525;6128.1114238435175;6138.449706860586;6201.782937597162;6229.595076320024;6232.002879539252;5709.685967271756;5748.5688573357165;5757.165211044375;5758.539316854642;5786.826395208151;6763.256041835394;6763.864722705617;6777.728890844508;6799;6808.93191068083;5835.387284335084;6241.095041218907;6290.591111577733;6427.871442571029;6496.545241833026;6762.323767623395;6765.1205343305055;6778.593284402951;6786.76246331376;6795.456363491007;6373.776917807854;6404.071409645669;6407.3592640737415;6425.06836508713;6430.582012169194;6209.658468784261;6278.968605156945;6332.0501924709815;6332.398422149889;6487.935120648733;6279.96860015697;6294.748210071546;6323.241211054703;6328.9050664240995;6331.335209803088;6248.250209974832;6282.120503129474;6282.497400207881;6290.276618188784;6299.937000630119;4822.794301424644;6108.7670647404;6131.172291740736;6204.906926396198;6224.906626400698;5388.191771234347;6211.627302361872;6247.687615619292;6251.9684252097895;6263.4362907338555;6065.6663883486835;6265.530085243534;6268.686565671789;6275.34108918557;6301.653409062362 03:33:37 INFO - PROCESS | 1640 | |1;ext.html;753.551636776118;758.3402439877308;761.4974117082727;814.3932770086283;882.15753954973;27158.86420567897;28163.718362816366;28226.435471290588;28295.717042829565;28342.291442713944;27330.31674208141;39520.60479395205;40053;41896.37155442671;42027.57972420275;9151.084891510845;9312.627494900196;9316.627334906596;9326.114019168203;9347.76630584234;7252.7461538846155;9184.448933064004;9344.439333640003;9385.530723463833;9391.154796068353;7398.889016664754;10940.288881222696;11170.944145279262;11364.31814091153;11408.144389170804;11122.777544449105;11174.888251117547;11175.944120279428;11195.160362972769;11197.27217730853;9520.524318730608;10860.1311895049;10907.563697452093;10919.39943303118;10931.398773067478;27040.188794336005;27479.86260068687;37505.24989500194;37924.43113353302;39939.40090898639;3710.8330125144435;3779.829907654162;3830.7510011849417;3836.75061121029;3896.6298201670797;26212.737872621412;26275.73724262752;26705.866470667715;27426.862865685544;28185.436291274058;3041.528563072727;3058.2965917839024;3252.121927079675;3267.052554759117;3297.241634424072;327164;328014;330608;332383;332498;51473;51611.48388516142;51634.48365516297;51695.22457163146;51729.74135129376;52539;52590.73704631453;52714;52730.472695273325;52802.73598631982;14225.928870355789;14611.488597899022;14645.414183432544;14672;14680.04579702316;12644.747105057848;12652.936735316265;12661.36693165338;12682.985361171084;12692.238465692088;10436.321639093434;11473.50844390224;12047.879521204852;12073.33596652175;12130.211536250115;4170.457840480718;4865.221564549655;4868.78090485929;4894.748415728734;4895.828645997373;977.9511024448749;1103.9503222355013;1180.6930198148543;1181.7400171962154;1218.585680868509;23138.07447702073;24223.7577624225;25691.84386702603;26259.737402625728;26946.595801063;1218.823270625772;1229.1088960503564;1238.4055653286293;1256.9622911312674;1279.5713435999044;13339.799903001463;13548.525801596898;13558;13618.659533511742;13863.445462181602;410671;411406;411474;412229;412806;52767.73616131895;52786.47213527892;52878;52892.73553632207;53153.46846531562;1381.8134551835574;1430.0847457627126;1434.3688776938322;1434.8636879496223;1441.0633088492564;24507.63238551459;25265.49469010646;25273.241802745946;25310.114146005537;25785;44412.77793611011;44447.33329000132;44450;44493;44608.33087503625;286133.569332152;336282;336753;338020;339901;32694;33130;33349.499757503174;33388.49917251195;33480.1629959253;37245.813770930974;38918.80540597392;39458.01354966149;42345.576544234165;42405.57594424016;29192.854035729684;31753.523697145025;31972.6802731979;32609.673903260664;33177.50233746544;30543.847280763453;32340.86806961745;32761.67238327586;32880;32930.835345823114;31651.36697265996;32029.83985080153;32081;32687.836560817042;32742.83628581842;27425;28948.565771513866;29418.11745647634;29422.558661620522;30073.94741184048;22669.88507117196;22812.885935570215;22859.88570057139;22988.4252893679;23035.308940731804 03:33:37 INFO - PROCESS | 1640 | |2;jquery.html;392.80752431308633;405.9776712280825;413.7889676265104;417.84049263294355;431.40466156703746;12980.610581682553;14949.850501494982;15826.97124686896;21160.57678846426;21172.89413552934;20695;20998.26506072288;21207.893960530215;21963.23128690496;22275.888620556914;6522.902156467657;6813.114295141625;6995.65021748913;7325.890111648329;7534.773956781305;7139.071920650308;7335.77992660221;7422.851542969164;7433.851322973537;7434.293742094493;7341.632918354087;7390;7396.297351751602;7397.445191610624;7410.444216683743;6769.7292108315605;7057.117860267466;7204.675789589429;7222.566646001257;7391.039164908554;6796.660166991631;6932.514723969324;6978.685959131852;7020.824479388005;7040.436765058834;25117;25443.49113017729;25638.359041024123;25714;25967;3222.8388580570877;3287.4247006773717;3340.064781861083;3348.497725341194;3367.9158021049425;15333.386664533406;15368.462103826312;15383.307751151226;15700;16054.5986350341;1869.2336142181641;2039.8266147377342;2071.06801939128;2079.2826474866147;2083.2187929526426;139238;139333.3033334837;156982.99999999886;158599.20700396423;161501;16196.59508512273;19097.427077187705;19117.13972871224;19450.319238826574;19608.117634706472;25685.3578660535;31793.364132717677;31822.204444889063;31822.681773182434;32020.359592808014;9861.506924653739;9958.800823983625;10169.694909152737;10315.1747860171;10320.380777153396;6999.580025198505;8426.747197584082;8482.151784821592;8629.39594228398;8639.740807775777;7983.12185659577;8964.462132272085;9082.86375704365;9157.175854173023;9325.244125496047;3857.72995890285;3868.9367871737377;3903.633728195109;3903.8964023601307;3907.902302442462;996.7508122969258;1007.0282177698409;1014.2443879309961;1018.4500369800373;1046.7435478307711;20724.58550828975;21052.789472105083;21139.894300528707;21342.267244199084;21387.79183122544;1000.8398656214971;1003.3127307794184;1044.8484969679355;1050.76883085721;1053.9209559283083;10098;10731.678049658523;10854.07740342064;10869.728256793644;10882.891171088346;741936;746717;752540;759777;762081;164585;164595.3540464604;164601;167476;172449;1292.5863723608543;1302.2902518127644;1353.7630914589906;1354.4582167133226;1363.3319673359981;19198.71201932;19567;19782.80217197867;20155.294564690164;20274.59450811005;61932;62083.06875396963;63012;63441.99999999815;63607.68196158989;55947.720261398434;90082.64876026734;93150;93164.478486508;94217.528912355;10108.797824043624;11436.599719009795;11472.94263528677;11917;11939.46272417726;12939.288339141061;13164.736705266032;13180.868191318348;13227;13303.933480332536;9493.905060949302;10643.201759867887;10898;11035.668929932115;11188.776224475629;11064;11218.270812397168;11284.605038823602;11490.94254528722;11568;11180.608678696206;11672.649820505398;11771.293722376684;11835.70410739704;11851.466683999413;11469.827952580885;11612.12909031809;11636.243644163102;11818.881811182122;11892.345920974083;10530.894691052992;11085.889141108486;11147.331160130418;11368.602098926498;11418.429078546205 03:33:37 INFO - PROCESS | 1640 | |3;mootools.html;1344.9932750336247;1535.2630737246122;1559.8518140776623;1576.4403636708964;1582.620171158922;9282.628694852207;9674;9684.46735429552;9774.266929980262;9787.657431989881;8234.300084492825;10354.430506322149;10672.573097076127;10780.622678206264;10783.352998820077;2406.3142004528713;2436.0377650827913;2436.9634455483183;2438.9512209755794;2446.13162327373;2037.4397040813822;2313.5719891820067;2367.6803631509783;2381.5117900830373;2395.4849707312924;2101.05452546354;2123.9469013274716;2328.906843726249;2409.4578719788083;2420.249722585995;2314.7569505201964;2319.2462449703744;2328.2316835444262;2328.627419612854;2330.673705681206;2320.0951628864755;2437.695288088989;2438.536678031186;2446.0949448704096;2447.5472037672907;11008.009279164913;11082.556697732081;11107.83338249927;11134.888651113466;11169.609063682814;5836.124581312794;6002.3697511761075;6006.12911127884;6007.309159446632;6010.729517171694;3392.5759280089987;3431.7083047940955;3616.1140520572626;3666.2484190740834;3678.668919797231;1065.387402243713;1093.6937657455926;1117.2458590451413;1234.7653945750278;1245.3524167432975;15254.08475491463;15393.307301171475;15398.999065060736;15415.3833846646;15419.768703469457;4747.311639812277;4954.479779623088;5022.070916880316;5030.044291584587;5030.37120359955;12848.614541563767;12868.806967895489;12887.93556032214;12898.03264755147;12908.483660653468;5875.441833025856;6026.728797204137;6037.607555508878;6046.727897244635;6051.122587224828;5127.102757017507;5195.038917800219;5264.710440925785;5272.868178295496;5283.418823929364;3469.9479507807405;4013.779242141652;4133.338665813455;4174.123434078817;4177.185448837508;1149.8677652070119;1155.7399585093456;1156.3235507228198;1168.1005625668188;1169.351010189353;692.3388164303179;809.299955538455;817.3910436724678;829.7925518620345;840.8990921089509;6447.226332839996;6491.545591808528;6620.702068406933;6626.734930602722;6807.3873351398615;1009.707184916366;1022.7443139215196;1027.0602398805158;1032.4321623107262;1049.559185142242;4454.844080457168;4469.240229161051;4583.816647334136;4712.24604063355;4725.40932383452;13797.24115173675;14078;14084.788728169086;14089;14134.64663383403;13271.800922986164;13749.931250343685;14007.509737159151;14021.439142434392;14033.368498417392;7822.6479808409895;8565.271951884035;8830.690925817695;8876.467411955304;9941.80116397668;5737.512311453574;6469.77355792545;6573.605583664996;6617.7683781067435;6621.569597976116;11712.941435292769;11885.76228475443;11935.76128477443;11966.341851198267;11993.700157496132;12121.151519393557;12164.330961796832;12269.325187114795;12369.257844529357;12509.624711258677;8963.014068452596;9234.861477077984;9236.353455258068;9241.861372079558;9283.62865485373;9985.950070249603;10010.099091081838;10014.198864091;10124.08883200486;10128.493575321352;7616.619169041636;8948.910510895068;9071.047540008203;9213.493257870881;9297.535123243675;8711.433756805787;8768.912310876809;8858.867116993379;8870.290376769972;9031;7775.066991961001;7896.526208427513;8008.199180081945;8017.919820801951;8034.919650803651;5839.153322768259;5906.173135761082;5907.91138132937;6021.969890150521;6086.513078953762;5877.265341832271;6027.21646185993;6129.662868542095;6136.417040381157;6185.597936134137 03:33:37 INFO - PROCESS | 1640 | |4;prototype.html;362.22122436760975;373.2516304808858;379.2301627695779;380.51104330934754;384.4732716178834;4927.679700819444;5120.795168193277;5152;5243.423223445423;5265.210218467232;4740.668153229275;4954.504549545044;4968.900621987558;4969.751512424374;4998.750062496879;3891.9297193271796;3980.2685831663175;4263.467066616673;4266.565414841044;4431.357453169288;3906.9023274418223;3983.760974341534;4300.6344460720875;4305.4833419989645;4359.38968544404;4128;4257.7445353278745;4364.563543645626;4365.454318210223;4375.234333991555;4337.002489427434;4338.739675619473;4347.84782532613;4356.150550642642;4432.556744325541;3833.2333533293454;3936.389859571771;4095.955531339519;4162.438070860456;4251.87244382669;4155.833766649331;4232.101010807607;4585.220512512881;4601.631869450436;4799;4698.389209402756;5053.574284343499;5090.618203634742;5094.847154585368;5132.691163753257;4989.3264409305;5039.193729003342;5202.713850738208;5392.272043274147;5448;4058.5738497457933;4234.830606775725;4325.697201195918;4582.770861456914;4659.88350291242;5068.214426763858;5147.202183661539;5438.891222175614;5559.805406810742;5675.914861277125;3928.2339943710704;4140.565240649748;4489.326601009875;4781.904361912742;4794.352762377104;3846.4999550058315;3985.940210896839;4218.514870789899;4506.436695413074;4612.723236605747;4427.867163985085;4857.8299759508245;4867.1969125093965;4882.780274887638;4910.189818679878;5104.82589004531;5351.688836235069;5476.890462190813;5528.612997090165;5531.174712344997;1350.514434122477;1487.7768334749658;1554.689062187567;1555.7044161609258;1561.4144695739099;1072.6406653771073;1074.2641290715885;1130.3895896216115;1155.3530023187043;1166.8389951997647;4444.422225110715;4818.734969576707;5019.548240658285;5035.597152227813;5057.418396884332;4776.704074188799;5221.660592061504;5572.944270557324;5577;5599.244102046253;4772.331873537708;5037.496250374933;5085.923711144335;5114.33513643224;5119.897602047939;2496.9750302497105;2743.478739039576;2851.900183493568;2950.6279579994975;2956.5565165224957;4900.754962251873;5350.5987050971335;5476.945230547723;5859.384764599741;5865.325487568899;5205.713685747321;5272.235525848807;5286.418493965661;5436.891262174813;5522;5323.86690332737;5444.537214336747;5482.753276102505;5524.779008839601;5847.795327163529;4897.90204195907;5127.53852153308;5661.518770904355;5688.914666279927;5717.885642287048;4625.93061104077;4987.875303117451;5428.321459817523;5553.16702494629;5597.6845441322075;5358.632714337802;5731.111677689798;5820.621659592113;5888.4700376964565;5898.882022359615;4002.7198096132993;4189.455370801777;4312.331588603772;4484.6321871829405;4492.528284530208;4867.367242258625;5497.120460726264;5591.329040515164;5640.956423061582;5692.5730570208225;4801.023365513404;5298.767751671554;5324.121519949165;5511;5561.805336813354;4692.460367057832;4785.162596545661;5312.282841816305;5350.759215835219;5468.343798744176;4667.509911459248;5093.529638125432;5331.466853314638;5351.625386222927;5353;5105.493879305688;5128.307678463509;5203.907179492349;5254.7667241423005;5501;4704.600108990774;4765.642576806684;5216.713080780593;5302.443243459381;5305.442928492453 03:33:37 INFO - PROCESS | 1640 | |5;yui.html;716.7706333973124;766.6320166320163;769.0195001373252;837.8533756592597;843.8650809822233;14686.926565367172;15306.770398444005;15433.69132617347;15437.305321260543;15496.380144794195;12480.93759531201;13827.723445531083;14120.57638270851;14284.857151428483;14551.490697825579;911.3301723233435;917.614601867214;918.1140199707281;919.6367434863225;919.8482250428672;900.0864122915247;908.2824568590838;909.1181553892746;910.0580898769774;931.4597533430627;979.5983646704852;982.5971351745785;983.4984158079395;985.3201291109148;986.9901300987005;977.7702239973601;977.9070988256104;978.2907392140642;979.5396163803073;980.691082309074;724.8985142080113;726.742006587659;728.3372131360436;728.351766927435;728.3808762551841;15473.148976806271;15603.375864965388;15658.138802365866;15822.446214382442;15901.284442200129;13896.58310250694;14164.716705665933;14227.644308892257;14306.356213970292;14333.140011599233;11640.883591164065;11822.231554948901;11899.821502677467;11908.047356211482;12017.158798884082;3635.1820840310984;3720.4977328060636;3721.0697325668584;3859.9421008684894;3873.438351439054;92361.07638923592;95486.04513954841;102124.48937755339;104279;105749.99999999923;10598.364098153981;10601.310914790514;10995.065419439437;11002;11505.942470287595;22061.779382205972;22122.22572209997;22136;22159.44601384978;22186.44533886666;7772.727954521678;7844.725434609762;7869.252421019994;7898.170692077364;7954.920450795534;4253.340732186516;4298.677599180074;4330.675199360061;4396.098799746044;4485.798139083749;2987.3129180288656;3544.521489598871;3546.6098729139776;3560.946585801215;3564.9305208437363;639.0222958872839;643.6910283064155;645.8417687666552;667.642811096071;667.8597494526107;563.1837324628042;711.4877288352378;721.1670520548774;732.7655150351836;738.7968308715039;9320.95339523298;10107.494625268708;10142.949285253526;10236.33463824849;10390.9609039097;670.9563878347892;709.9219085900547;719.0975325965984;730.3718801830422;733.5598640815575;4505.954940450553;4597.172508948354;4600.125976064604;4613.861584152481;4619.69971951822;105101;106501.93498065075;106800.21608441268;108990;109884.35173472404;57869.71065144731;64174;74687.25312746804;84716;92272.15455690848;76213.85679214816;76683.23316766873;78079.60960195163;78427.60786196032;79288.20711792808;8823.779405514913;9874.555644996137;10814.513346899252;11197.328160310408;11200.775984480428;35479;42742.93142671458;49733.50266497289;49802.52172261121;51364;63720.362796371446;64210.357896420435;65719.35701607498;65944.6702766483;66397;10834.620788272372;11278.266912650652;11314.321140731583;12119.58680969422;12990.545330913372;13713.451461941411;14685.779713304522;14694.926525367733;15000.774988374966;15117.773233401727;13429.865701343253;13744.450221991008;13972.580822575339;14088.647783805487;14221.64445888861;12985.155964862253;13533.120347177402;13807.447702091804;13972.510962116277;14463.783043254149;12997;13792.655183620089;13807.378667960167;13821.447142114605;13905.860941390456;10870.891291087304;11078.390688511887;11415.200935934738;11582.94208528952;11975.94012029969;9562.282828788007;10054.748631283985;11086.577917148512;11282.661520154408;11741.76516469683 03:33:37 INFO - PROCESS | 1640 | __end_tp_report 03:33:37 INFO - PROCESS | 1640 | __start_cc_report 03:33:37 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1292 03:33:37 INFO - PROCESS | 1640 | __end_cc_report 03:33:37 INFO - PROCESS | 1640 | __startTimestamp1490351617865__endTimestamp 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | ------- Summary: start ------- 03:33:37 INFO - PROCESS | 1640 | Number of tests: 6 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5974.08 Median:6209.66 stddev:662.31 (10.7%) stddev-sans-first:633.54 03:33:37 INFO - PROCESS | 1640 | Values: 3429.4 3445.3 3463.2 3479.1 3502.8 6106.8 6141.3 6142.9 6143.2 6166.1 5256.8 6056.8 6090.2 6134.5 6147.8 5422.1 5436.9 5471.4 5491.9 5576.1 5000.6 5378.2 5388.8 5580.1 5581.0 5445.7 5447.1 5505.9 5557.9 5559.6 5481.9 5529.9 5531.6 5534.6 5545.1 5357.7 5429.8 5478.7 5482.9 5517.8 5953.6 5978.4 6001.8 6062.2 6130.4 5533.7 5561.3 6409.0 6445.9 6474.6 6481.4 6508.3 6530.4 6536.9 6561.3 6016.0 6069.5 6087.1 6156.9 6230.6 6568.0 6608.7 6664.1 6715.9 6716.6 6313.9 6320.6 6327.3 6333.4 6337.4 6239.4 6397.2 6474.7 6478.4 6484.7 6267.1 6272.1 6280.2 6351.9 6366.3 6186.1 6227.9 6283.3 6318.8 6379.4 5157.6 5195.9 5236.4 5278.6 5280.0 4547.6 4634.4 4638.0 4643.6 4672.5 6050.3 6062.5 6067.5 6074.1 6077.2 6301.7 6308.7 6315.6 6316.2 6323.3 6128.1 6138.4 6201.8 6229.6 6232.0 5709.7 5748.6 5757.2 5758.5 5786.8 6763.3 6763.9 6777.7 6799.0 6808.9 5835.4 6241.1 6290.6 6427.9 6496.5 6762.3 6765.1 6778.6 6786.8 6795.5 6373.8 6404.1 6407.4 6425.1 6430.6 6209.7 6279.0 6332.1 6332.4 6487.9 6280.0 6294.7 6323.2 6328.9 6331.3 6248.3 6282.1 6282.5 6290.3 6299.9 4822.8 6108.8 6131.2 6204.9 6224.9 5388.2 6211.6 6247.7 6252.0 6263.4 6065.7 6265.5 6268.7 6275.3 6301.7 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:49702.75 Median:17796.49 stddev:94738.14 (532.3%) stddev-sans-first:94932.62 03:33:37 INFO - PROCESS | 1640 | Values: 753.6 758.3 761.5 814.4 882.2 27158.9 28163.7 28226.4 28295.7 28342.3 27330.3 39520.6 40053.0 41896.4 42027.6 9151.1 9312.6 9316.6 9326.1 9347.8 7252.7 9184.4 9344.4 9385.5 9391.2 7398.9 10940.3 11170.9 11364.3 11408.1 11122.8 11174.9 11175.9 11195.2 11197.3 9520.5 10860.1 10907.6 10919.4 10931.4 27040.2 27479.9 37505.2 37924.4 39939.4 3710.8 3779.8 3830.8 3836.8 3896.6 26212.7 26275.7 26705.9 27426.9 28185.4 3041.5 3058.3 3252.1 3267.1 3297.2 327164.0 328014.0 330608.0 332383.0 332498.0 51473.0 51611.5 51634.5 51695.2 51729.7 52539.0 52590.7 52714.0 52730.5 52802.7 14225.9 14611.5 14645.4 14672.0 14680.0 12644.7 12652.9 12661.4 12683.0 12692.2 10436.3 11473.5 12047.9 12073.3 12130.2 4170.5 4865.2 4868.8 4894.7 4895.8 978.0 1104.0 1180.7 1181.7 1218.6 23138.1 24223.8 25691.8 26259.7 26946.6 1218.8 1229.1 1238.4 1257.0 1279.6 13339.8 13548.5 13558.0 13618.7 13863.4 410671.0 411406.0 411474.0 412229.0 412806.0 52767.7 52786.5 52878.0 52892.7 53153.5 1381.8 1430.1 1434.4 1434.9 1441.1 24507.6 25265.5 25273.2 25310.1 25785.0 44412.8 44447.3 44450.0 44493.0 44608.3 286133.6 336282.0 336753.0 338020.0 339901.0 32694.0 33130.0 33349.5 33388.5 33480.2 37245.8 38918.8 39458.0 42345.6 42405.6 29192.9 31753.5 31972.7 32609.7 33177.5 30543.8 32340.9 32761.7 32880.0 32930.8 31651.4 32029.8 32081.0 32687.8 32742.8 27425.0 28948.6 29418.1 29422.6 30073.9 22669.9 22812.9 22859.9 22988.4 23035.3 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:43234.93 Median:11540.74 stddev:125823.81 (1090.3%) stddev-sans-first:126135.66 03:33:37 INFO - PROCESS | 1640 | Values: 392.8 406.0 413.8 417.8 431.4 12980.6 14949.9 15827.0 21160.6 21172.9 20695.0 20998.3 21207.9 21963.2 22275.9 6522.9 6813.1 6995.7 7325.9 7534.8 7139.1 7335.8 7422.9 7433.9 7434.3 7341.6 7390.0 7396.3 7397.4 7410.4 6769.7 7057.1 7204.7 7222.6 7391.0 6796.7 6932.5 6978.7 7020.8 7040.4 25117.0 25443.5 25638.4 25714.0 25967.0 3222.8 3287.4 3340.1 3348.5 3367.9 15333.4 15368.5 15383.3 15700.0 16054.6 1869.2 2039.8 2071.1 2079.3 2083.2 139238.0 139333.3 156983.0 158599.2 161501.0 16196.6 19097.4 19117.1 19450.3 19608.1 25685.4 31793.4 31822.2 31822.7 32020.4 9861.5 9958.8 10169.7 10315.2 10320.4 6999.6 8426.7 8482.2 8629.4 8639.7 7983.1 8964.5 9082.9 9157.2 9325.2 3857.7 3868.9 3903.6 3903.9 3907.9 996.8 1007.0 1014.2 1018.5 1046.7 20724.6 21052.8 21139.9 21342.3 21387.8 1000.8 1003.3 1044.8 1050.8 1053.9 10098.0 10731.7 10854.1 10869.7 10882.9 741936.0 746717.0 752540.0 759777.0 762081.0 164585.0 164595.4 164601.0 167476.0 172449.0 1292.6 1302.3 1353.8 1354.5 1363.3 19198.7 19567.0 19782.8 20155.3 20274.6 61932.0 62083.1 63012.0 63442.0 63607.7 55947.7 90082.6 93150.0 93164.5 94217.5 10108.8 11436.6 11472.9 11917.0 11939.5 12939.3 13164.7 13180.9 13227.0 13303.9 9493.9 10643.2 10898.0 11035.7 11188.8 11064.0 11218.3 11284.6 11490.9 11568.0 11180.6 11672.6 11771.3 11835.7 11851.5 11469.8 11612.1 11636.2 11818.9 11892.3 10530.9 11085.9 11147.3 11368.6 11418.4 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6711.67 Median:3543.03 stddev:4195.07 (118.4%) stddev-sans-first:4187.46 03:33:37 INFO - PROCESS | 1640 | Values: 1345.0 1535.3 1559.9 1576.4 1582.6 9282.6 9674.0 9684.5 9774.3 9787.7 8234.3 10354.4 10672.6 10780.6 10783.4 2406.3 2436.0 2437.0 2439.0 2446.1 2037.4 2313.6 2367.7 2381.5 2395.5 2101.1 2123.9 2328.9 2409.5 2420.2 2314.8 2319.2 2328.2 2328.6 2330.7 2320.1 2437.7 2438.5 2446.1 2447.5 11008.0 11082.6 11107.8 11134.9 11169.6 5836.1 6002.4 6006.1 6007.3 6010.7 3392.6 3431.7 3616.1 3666.2 3678.7 1065.4 1093.7 1117.2 1234.8 1245.4 15254.1 15393.3 15399.0 15415.4 15419.8 4747.3 4954.5 5022.1 5030.0 5030.4 12848.6 12868.8 12887.9 12898.0 12908.5 5875.4 6026.7 6037.6 6046.7 6051.1 5127.1 5195.0 5264.7 5272.9 5283.4 3469.9 4013.8 4133.3 4174.1 4177.2 1149.9 1155.7 1156.3 1168.1 1169.4 692.3 809.3 817.4 829.8 840.9 6447.2 6491.5 6620.7 6626.7 6807.4 1009.7 1022.7 1027.1 1032.4 1049.6 4454.8 4469.2 4583.8 4712.2 4725.4 13797.2 14078.0 14084.8 14089.0 14134.6 13271.8 13749.9 14007.5 14021.4 14033.4 7822.6 8565.3 8830.7 8876.5 9941.8 5737.5 6469.8 6573.6 6617.8 6621.6 11712.9 11885.8 11935.8 11966.3 11993.7 12121.2 12164.3 12269.3 12369.3 12509.6 8963.0 9234.9 9236.4 9241.9 9283.6 9986.0 10010.1 10014.2 10124.1 10128.5 7616.6 8948.9 9071.0 9213.5 9297.5 8711.4 8768.9 8858.9 8870.3 9031.0 7775.1 7896.5 8008.2 8017.9 8034.9 5839.2 5906.2 5907.9 6022.0 6086.5 5877.3 6027.2 6129.7 6136.4 6185.6 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4551.74 Median:4918.93 stddev:1246.88 (25.3%) stddev-sans-first:1210.07 03:33:37 INFO - PROCESS | 1640 | Values: 362.2 373.3 379.2 380.5 384.5 4927.7 5120.8 5152.0 5243.4 5265.2 4740.7 4954.5 4968.9 4969.8 4998.8 3891.9 3980.3 4263.5 4266.6 4431.4 3906.9 3983.8 4300.6 4305.5 4359.4 4128.0 4257.7 4364.6 4365.5 4375.2 4337.0 4338.7 4347.8 4356.2 4432.6 3833.2 3936.4 4096.0 4162.4 4251.9 4155.8 4232.1 4585.2 4601.6 4799.0 4698.4 5053.6 5090.6 5094.8 5132.7 4989.3 5039.2 5202.7 5392.3 5448.0 4058.6 4234.8 4325.7 4582.8 4659.9 5068.2 5147.2 5438.9 5559.8 5675.9 3928.2 4140.6 4489.3 4781.9 4794.4 3846.5 3985.9 4218.5 4506.4 4612.7 4427.9 4857.8 4867.2 4882.8 4910.2 5104.8 5351.7 5476.9 5528.6 5531.2 1350.5 1487.8 1554.7 1555.7 1561.4 1072.6 1074.3 1130.4 1155.4 1166.8 4444.4 4818.7 5019.5 5035.6 5057.4 4776.7 5221.7 5572.9 5577.0 5599.2 4772.3 5037.5 5085.9 5114.3 5119.9 2497.0 2743.5 2851.9 2950.6 2956.6 4900.8 5350.6 5476.9 5859.4 5865.3 5205.7 5272.2 5286.4 5436.9 5522.0 5323.9 5444.5 5482.8 5524.8 5847.8 4897.9 5127.5 5661.5 5688.9 5717.9 4625.9 4987.9 5428.3 5553.2 5597.7 5358.6 5731.1 5820.6 5888.5 5898.9 4002.7 4189.5 4312.3 4484.6 4492.5 4867.4 5497.1 5591.3 5641.0 5692.6 4801.0 5298.8 5324.1 5511.0 5561.8 4692.5 4785.2 5312.3 5350.8 5468.3 4667.5 5093.5 5331.5 5351.6 5353.0 5105.5 5128.3 5203.9 5254.8 5501.0 4704.6 4765.6 5216.7 5302.4 5305.4 03:33:37 INFO - PROCESS | 1640 | 03:33:37 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19902.27 Median:3677.84 stddev:28279.85 (768.9%) stddev-sans-first:28322.49 03:33:37 INFO - PROCESS | 1640 | Values: 716.8 766.6 769.0 837.9 843.9 14686.9 15306.8 15433.7 15437.3 15496.4 12480.9 13827.7 14120.6 14284.9 14551.5 911.3 917.6 918.1 919.6 919.8 900.1 908.3 909.1 910.1 931.5 979.6 982.6 983.5 985.3 987.0 977.8 977.9 978.3 979.5 980.7 724.9 726.7 728.3 728.4 728.4 15473.1 15603.4 15658.1 15822.4 15901.3 13896.6 14164.7 14227.6 14306.4 14333.1 11640.9 11822.2 11899.8 11908.0 12017.2 3635.2 3720.5 3721.1 3859.9 3873.4 92361.1 95486.0 102124.5 104279.0 105750.0 10598.4 10601.3 10995.1 11002.0 11505.9 22061.8 22122.2 22136.0 22159.4 22186.4 7772.7 7844.7 7869.3 7898.2 7954.9 4253.3 4298.7 4330.7 4396.1 4485.8 2987.3 3544.5 3546.6 3560.9 3564.9 639.0 643.7 645.8 667.6 667.9 563.2 711.5 721.2 732.8 738.8 9321.0 10107.5 10142.9 10236.3 10391.0 671.0 709.9 719.1 730.4 733.6 4506.0 4597.2 4600.1 4613.9 4619.7 105101.0 106501.9 106800.2 108990.0 109884.4 57869.7 64174.0 74687.3 84716.0 92272.2 76213.9 76683.2 78079.6 78427.6 79288.2 8823.8 9874.6 10814.5 11197.3 11200.8 35479.0 42742.9 49733.5 49802.5 51364.0 63720.4 64210.4 65719.4 65944.7 66397.0 10834.6 11278.3 11314.3 12119.6 12990.5 13713.5 14685.8 14694.9 15000.8 15117.8 13429.9 13744.5 13972.6 14088.6 14221.6 12985.2 13533.1 13807.4 13972.5 14463.8 12997.0 13792.7 13807.4 13821.4 13905.9 10870.9 11078.4 11415.2 11582.9 11975.9 9562.3 10054.7 11086.6 11282.7 11741.8 03:33:37 INFO - PROCESS | 1640 | -------- Summary: end -------- 03:33:37 INFO - PROCESS | 1640 | 03:33:38 INFO - TEST-INFO | 1640: exit 0 03:33:38 INFO - TEST-OK | dromaeo_css | took 1120536ms 03:33:38 INFO - TEST-START | kraken 03:33:38 INFO - operating with platform_type : mac_ 03:33:38 INFO - Initialising browser for kraken test... 03:33:38 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpokaYtz/profile http://localhost:49248/getInfo.html) 03:33:40 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 03:33:40 INFO - PROCESS | 1653 | colorDepth:24 03:33:40 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 03:33:40 INFO - PROCESS | 1653 | __metrics 03:33:40 INFO - PROCESS | 1653 | 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" 03:33:40 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:33:41 INFO - TEST-INFO | 1653: exit 0 03:33:41 INFO - Browser initialized. 03:33:41 INFO - Running cycle 1/1 for kraken test... 03:33:41 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpokaYtz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:53 INFO - PROCESS | 1654 | RSS: Main: 215085056 03:33:53 INFO - PROCESS | 1654 | 03:33:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 03:33:57 INFO - PROCESS | 1654 | RSS: Main: 267710464 03:33:57 INFO - PROCESS | 1654 | 03:34:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 03:34:00 INFO - PROCESS | 1654 | RSS: Main: 279187456 03:34:00 INFO - PROCESS | 1654 | 03:34:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 03:34:04 INFO - PROCESS | 1654 | RSS: Main: 375840768 03:34:04 INFO - PROCESS | 1654 | 03:34:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 03:34:07 INFO - PROCESS | 1654 | RSS: Main: 278056960 03:34:07 INFO - PROCESS | 1654 | 03:34:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:34:09 INFO - PROCESS | 1654 | RSS: Main: 279494656 03:34:09 INFO - PROCESS | 1654 | 03:34:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 03:34:13 INFO - PROCESS | 1654 | RSS: Main: 321183744 03:34:13 INFO - PROCESS | 1654 | 03:34:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 03:34:17 INFO - PROCESS | 1654 | RSS: Main: 319479808 03:34:17 INFO - PROCESS | 1654 | 03:34:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 03:34:20 INFO - PROCESS | 1654 | RSS: Main: 318803968 03:34:20 INFO - PROCESS | 1654 | 03:34:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:34:23 INFO - PROCESS | 1654 | RSS: Main: 294952960 03:34:23 INFO - PROCESS | 1654 | 03:34:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:34:25 INFO - PROCESS | 1654 | RSS: Main: 296144896 03:34:25 INFO - PROCESS | 1654 | 03:34:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:34:28 INFO - PROCESS | 1654 | RSS: Main: 305594368 03:34:28 INFO - PROCESS | 1654 | 03:34:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:34:31 INFO - PROCESS | 1654 | RSS: Main: 310521856 03:34:31 INFO - PROCESS | 1654 | 03:34:34 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:34:35 INFO - PROCESS | 1654 | RSS: Main: 311697408 03:34:35 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 03:34:37 INFO - PROCESS | 1654 | RSS: Main: 356159488 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | __start_tp_report 03:34:37 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 03:34:37 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 03:34:37 INFO - PROCESS | 1654 | |i|pagename|runs| 03:34:37 INFO - PROCESS | 1654 | |0;ai-astar;117;117;115;116;115;113;113;116;116;117 03:34:37 INFO - PROCESS | 1654 | |1;audio-beat-detection;147;129;133;172;110;111;133;128;130;111 03:34:37 INFO - PROCESS | 1654 | |2;audio-dft;184;175;182;187;184;182;184;184;187;184 03:34:37 INFO - PROCESS | 1654 | |3;audio-fft;81;61;62;93;61;58;78;81;94;60 03:34:37 INFO - PROCESS | 1654 | |4;audio-oscillator;90;69;87;70;70;68;82;68;68;84 03:34:37 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;88;105;130;129;88;88;87;88;91 03:34:37 INFO - PROCESS | 1654 | |6;imaging-darkroom;95;95;95;95;95;94;95;95;94;95 03:34:37 INFO - PROCESS | 1654 | |7;imaging-desaturate;85;84;84;83;84;86;95;128;126;84 03:34:37 INFO - PROCESS | 1654 | |8;json-parse-financial;63;60;59;60;63;65;64;63;61;62 03:34:37 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;55;57;65;64;60;58;58;58;57;59 03:34:37 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;88;88;87;87;87;83;92;94;92;107 03:34:37 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;138;137;139;138;135;129;133;135;151;139 03:34:37 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;169;210;194;163;165;164;166;166;163;160 03:34:37 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;66;66;66;65;65;67;63;65;61;64 03:34:37 INFO - PROCESS | 1654 | __end_tp_report 03:34:37 INFO - PROCESS | 1654 | __start_cc_report 03:34:37 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2056 03:34:37 INFO - PROCESS | 1654 | __end_cc_report 03:34:37 INFO - PROCESS | 1654 | __startTimestamp1490351677366__endTimestamp 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | ------- Summary: start ------- 03:34:37 INFO - PROCESS | 1654 | Number of tests: 14 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:1.51 (1.3%) stddev-sans-first:1.50 03:34:37 INFO - PROCESS | 1654 | Values: 117.0 117.0 115.0 116.0 115.0 113.0 113.0 116.0 116.0 117.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:131.50 stddev:18.85 (14.3%) stddev-sans-first:19.01 03:34:37 INFO - PROCESS | 1654 | Values: 147.0 129.0 133.0 172.0 110.0 111.0 133.0 128.0 130.0 111.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:3.37 (1.8%) stddev-sans-first:3.56 03:34:37 INFO - PROCESS | 1654 | Values: 184.0 175.0 182.0 187.0 184.0 182.0 184.0 184.0 187.0 184.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:72.90 Median:79.50 stddev:14.13 (17.8%) stddev-sans-first:14.68 03:34:37 INFO - PROCESS | 1654 | Values: 81.0 61.0 62.0 93.0 61.0 58.0 78.0 81.0 94.0 60.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.00 stddev:9.00 (11.8%) stddev-sans-first:7.89 03:34:37 INFO - PROCESS | 1654 | Values: 90.0 69.0 87.0 70.0 70.0 68.0 82.0 68.0 68.0 84.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:88.00 stddev:17.33 (19.7%) stddev-sans-first:17.99 03:34:37 INFO - PROCESS | 1654 | Values: 88.0 88.0 105.0 130.0 129.0 88.0 88.0 87.0 88.0 91.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:34:37 INFO - PROCESS | 1654 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:84.00 stddev:17.79 (21.2%) stddev-sans-first:18.57 03:34:37 INFO - PROCESS | 1654 | Values: 85.0 84.0 84.0 83.0 84.0 86.0 95.0 128.0 126.0 84.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:63.00 stddev:1.94 (3.1%) stddev-sans-first:2.03 03:34:37 INFO - PROCESS | 1654 | Values: 63.0 60.0 59.0 60.0 63.0 65.0 64.0 63.0 61.0 62.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.50 stddev:3.14 (5.4%) stddev-sans-first:2.96 03:34:37 INFO - PROCESS | 1654 | Values: 55.0 57.0 65.0 64.0 60.0 58.0 58.0 58.0 57.0 59.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:88.00 stddev:6.62 (7.5%) stddev-sans-first:6.96 03:34:37 INFO - PROCESS | 1654 | Values: 88.0 88.0 87.0 87.0 87.0 83.0 92.0 94.0 92.0 107.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:138.00 stddev:5.70 (4.1%) stddev-sans-first:6.04 03:34:37 INFO - PROCESS | 1654 | Values: 138.0 137.0 139.0 138.0 135.0 129.0 133.0 135.0 151.0 139.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:166.00 stddev:16.42 (9.9%) stddev-sans-first:17.39 03:34:37 INFO - PROCESS | 1654 | Values: 169.0 210.0 194.0 163.0 165.0 164.0 166.0 166.0 163.0 160.0 03:34:37 INFO - PROCESS | 1654 | 03:34:37 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:1.75 (2.7%) stddev-sans-first:1.80 03:34:37 INFO - PROCESS | 1654 | Values: 66.0 66.0 66.0 65.0 65.0 67.0 63.0 65.0 61.0 64.0 03:34:37 INFO - PROCESS | 1654 | -------- Summary: end -------- 03:34:37 INFO - PROCESS | 1654 | 03:34:38 INFO - TEST-INFO | 1654: exit 0 03:34:38 INFO - TEST-OK | kraken | took 59755ms 03:34:38 INFO - SUITE-END | took 1180s 03:34:38 INFO - Completed test suite (00:19:40) 03:34:38 INFO - javascript benchmark 03:34:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7652.113944688376, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.416999110151, 3445.328161008604, 3463.1861512544556, 3479.1302174456387, 3502.7723197992127, 6106.816795496136, 6141.293751218611, 6142.877142457148, 6143.170671959284, 6166.105914642374, 5256.817216126369, 6056.818295451144, 6090.208272924514, 6134.539909506793, 6147.846303842406, 5422.078246698061, 5436.891262174754, 5471.425500322469, 5491.917621235684, 5576.107822748361, 5000.5999520038495, 5378.2470454136255, 5388.811391601294, 5580.051391263474, 5580.99542082425, 5445.673259604417, 5447.12845944647, 5505.889882202354, 5557.944420555783, 5559.610827242094, 5481.890362192754, 5529.944700552983, 5531.557475401958, 5534.557235421156, 5545.085060964936, 5357.678539287616, 5429.8099566515375, 5478.726063696799, 5482.91775623366, 5517.779288828442, 5953.553483488712, 5978.372270911535, 6001.759929602811, 6062.151298818169, 6130.4176103270565, 5533.667979921218, 5561.277033985596, 6409.029273350887, 6445.903311450332, 6474.643894585796, 6481.351864813481, 6508.25155107164, 6530.44491218247, 6536.869262614769, 6561.3438656134485, 6016.0, 6069.484093851984, 6087.05650624154, 6156.907646385353, 6230.5638605297645, 6568.014797780275, 6608.735650574019, 6664.067030615718, 6715.93284067153, 6716.597004179765, 6313.905291420632, 6320.5891617044745, 6327.303996560375, 6333.398327158912, 6337.366263373626, 6239.376062393815, 6397.232332120176, 6474.708638111297, 6478.449331806755, 6484.675766211671, 6267.122602835607, 6272.1219029335925, 6280.214973128359, 6351.904721429182, 6366.331535188739, 6186.133941248228, 6227.937720622826, 6283.277423096311, 6318.8420289492215, 6379.362063793584, 5157.58739300855, 5195.948040519546, 5236.3716354037, 5278.551323137576, 5280.023195708806, 4547.613452856544, 4634.420697412824, 4637.976810115928, 4643.558861908114, 4672.509386514435, 6050.273967123885, 6062.545309101835, 6067.514598832083, 6074.058520929263, 6077.20996270482, 6301.6534090625455, 6308.684565771693, 6315.55791094619, 6316.210473690789, 6323.27282362525, 6128.1114238435175, 6138.449706860586, 6201.782937597162, 6229.595076320024, 6232.002879539252, 5709.685967271756, 5748.5688573357165, 5757.165211044375, 5758.539316854642, 5786.826395208151, 6763.256041835394, 6763.864722705617, 6777.728890844508, 6799.0, 6808.93191068083, 5835.387284335084, 6241.095041218907, 6290.591111577733, 6427.871442571029, 6496.545241833026, 6762.323767623395, 6765.1205343305055, 6778.593284402951, 6786.76246331376, 6795.456363491007, 6373.776917807854, 6404.071409645669, 6407.3592640737415, 6425.06836508713, 6430.582012169194, 6209.658468784261, 6278.968605156945, 6332.0501924709815, 6332.398422149889, 6487.935120648733, 6279.96860015697, 6294.748210071546, 6323.241211054703, 6328.9050664240995, 6331.335209803088, 6248.250209974832, 6282.120503129474, 6282.497400207881, 6290.276618188784, 6299.937000630119, 4822.794301424644, 6108.7670647404, 6131.172291740736, 6204.906926396198, 6224.906626400698, 5388.191771234347, 6211.627302361872, 6247.687615619292, 6251.9684252097895, 6263.4362907338555, 6065.6663883486835, 6265.530085243534, 6268.686565671789, 6275.34108918557, 6301.653409062362], "value": 5932.708421996555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.551636776118, 758.3402439877308, 761.4974117082727, 814.3932770086283, 882.15753954973, 27158.86420567897, 28163.718362816366, 28226.435471290588, 28295.717042829565, 28342.291442713944, 27330.31674208141, 39520.60479395205, 40053.0, 41896.37155442671, 42027.57972420275, 9151.084891510845, 9312.627494900196, 9316.627334906596, 9326.114019168203, 9347.76630584234, 7252.7461538846155, 9184.448933064004, 9344.439333640003, 9385.530723463833, 9391.154796068353, 7398.889016664754, 10940.288881222696, 11170.944145279262, 11364.31814091153, 11408.144389170804, 11122.777544449105, 11174.888251117547, 11175.944120279428, 11195.160362972769, 11197.27217730853, 9520.524318730608, 10860.1311895049, 10907.563697452093, 10919.39943303118, 10931.398773067478, 27040.188794336005, 27479.86260068687, 37505.24989500194, 37924.43113353302, 39939.40090898639, 3710.8330125144435, 3779.829907654162, 3830.7510011849417, 3836.75061121029, 3896.6298201670797, 26212.737872621412, 26275.73724262752, 26705.866470667715, 27426.862865685544, 28185.436291274058, 3041.528563072727, 3058.2965917839024, 3252.121927079675, 3267.052554759117, 3297.241634424072, 327164.0, 328014.0, 330608.0, 332383.0, 332498.0, 51473.0, 51611.48388516142, 51634.48365516297, 51695.22457163146, 51729.74135129376, 52539.0, 52590.73704631453, 52714.0, 52730.472695273325, 52802.73598631982, 14225.928870355789, 14611.488597899022, 14645.414183432544, 14672.0, 14680.04579702316, 12644.747105057848, 12652.936735316265, 12661.36693165338, 12682.985361171084, 12692.238465692088, 10436.321639093434, 11473.50844390224, 12047.879521204852, 12073.33596652175, 12130.211536250115, 4170.457840480718, 4865.221564549655, 4868.78090485929, 4894.748415728734, 4895.828645997373, 977.9511024448749, 1103.9503222355013, 1180.6930198148543, 1181.7400171962154, 1218.585680868509, 23138.07447702073, 24223.7577624225, 25691.84386702603, 26259.737402625728, 26946.595801063, 1218.823270625772, 1229.1088960503564, 1238.4055653286293, 1256.9622911312674, 1279.5713435999044, 13339.799903001463, 13548.525801596898, 13558.0, 13618.659533511742, 13863.445462181602, 410671.0, 411406.0, 411474.0, 412229.0, 412806.0, 52767.73616131895, 52786.47213527892, 52878.0, 52892.73553632207, 53153.46846531562, 1381.8134551835574, 1430.0847457627126, 1434.3688776938322, 1434.8636879496223, 1441.0633088492564, 24507.63238551459, 25265.49469010646, 25273.241802745946, 25310.114146005537, 25785.0, 44412.77793611011, 44447.33329000132, 44450.0, 44493.0, 44608.33087503625, 286133.569332152, 336282.0, 336753.0, 338020.0, 339901.0, 32694.0, 33130.0, 33349.499757503174, 33388.49917251195, 33480.1629959253, 37245.813770930974, 38918.80540597392, 39458.01354966149, 42345.576544234165, 42405.57594424016, 29192.854035729684, 31753.523697145025, 31972.6802731979, 32609.673903260664, 33177.50233746544, 30543.847280763453, 32340.86806961745, 32761.67238327586, 32880.0, 32930.835345823114, 31651.36697265996, 32029.83985080153, 32081.0, 32687.836560817042, 32742.83628581842, 27425.0, 28948.565771513866, 29418.11745647634, 29422.558661620522, 30073.94741184048, 22669.88507117196, 22812.885935570215, 22859.88570057139, 22988.4252893679, 23035.308940731804], "value": 17961.579356215992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.80752431308633, 405.9776712280825, 413.7889676265104, 417.84049263294355, 431.40466156703746, 12980.610581682553, 14949.850501494982, 15826.97124686896, 21160.57678846426, 21172.89413552934, 20695.0, 20998.26506072288, 21207.893960530215, 21963.23128690496, 22275.888620556914, 6522.902156467657, 6813.114295141625, 6995.65021748913, 7325.890111648329, 7534.773956781305, 7139.071920650308, 7335.77992660221, 7422.851542969164, 7433.851322973537, 7434.293742094493, 7341.632918354087, 7390.0, 7396.297351751602, 7397.445191610624, 7410.444216683743, 6769.7292108315605, 7057.117860267466, 7204.675789589429, 7222.566646001257, 7391.039164908554, 6796.660166991631, 6932.514723969324, 6978.685959131852, 7020.824479388005, 7040.436765058834, 25117.0, 25443.49113017729, 25638.359041024123, 25714.0, 25967.0, 3222.8388580570877, 3287.4247006773717, 3340.064781861083, 3348.497725341194, 3367.9158021049425, 15333.386664533406, 15368.462103826312, 15383.307751151226, 15700.0, 16054.5986350341, 1869.2336142181641, 2039.8266147377342, 2071.06801939128, 2079.2826474866147, 2083.2187929526426, 139238.0, 139333.3033334837, 156982.99999999886, 158599.20700396423, 161501.0, 16196.59508512273, 19097.427077187705, 19117.13972871224, 19450.319238826574, 19608.117634706472, 25685.3578660535, 31793.364132717677, 31822.204444889063, 31822.681773182434, 32020.359592808014, 9861.506924653739, 9958.800823983625, 10169.694909152737, 10315.1747860171, 10320.380777153396, 6999.580025198505, 8426.747197584082, 8482.151784821592, 8629.39594228398, 8639.740807775777, 7983.12185659577, 8964.462132272085, 9082.86375704365, 9157.175854173023, 9325.244125496047, 3857.72995890285, 3868.9367871737377, 3903.633728195109, 3903.8964023601307, 3907.902302442462, 996.7508122969258, 1007.0282177698409, 1014.2443879309961, 1018.4500369800373, 1046.7435478307711, 20724.58550828975, 21052.789472105083, 21139.894300528707, 21342.267244199084, 21387.79183122544, 1000.8398656214971, 1003.3127307794184, 1044.8484969679355, 1050.76883085721, 1053.9209559283083, 10098.0, 10731.678049658523, 10854.07740342064, 10869.728256793644, 10882.891171088346, 741936.0, 746717.0, 752540.0, 759777.0, 762081.0, 164585.0, 164595.3540464604, 164601.0, 167476.0, 172449.0, 1292.5863723608543, 1302.2902518127644, 1353.7630914589906, 1354.4582167133226, 1363.3319673359981, 19198.71201932, 19567.0, 19782.80217197867, 20155.294564690164, 20274.59450811005, 61932.0, 62083.06875396963, 63012.0, 63441.99999999815, 63607.68196158989, 55947.720261398434, 90082.64876026734, 93150.0, 93164.478486508, 94217.528912355, 10108.797824043624, 11436.599719009795, 11472.94263528677, 11917.0, 11939.46272417726, 12939.288339141061, 13164.736705266032, 13180.868191318348, 13227.0, 13303.933480332536, 9493.905060949302, 10643.201759867887, 10898.0, 11035.668929932115, 11188.776224475629, 11064.0, 11218.270812397168, 11284.605038823602, 11490.94254528722, 11568.0, 11180.608678696206, 11672.649820505398, 11771.293722376684, 11835.70410739704, 11851.466683999413, 11469.827952580885, 11612.12909031809, 11636.243644163102, 11818.881811182122, 11892.345920974083, 10530.894691052992, 11085.889141108486, 11147.331160130418, 11368.602098926498, 11418.429078546205], "value": 11620.056743511353, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.9932750336247, 1535.2630737246122, 1559.8518140776623, 1576.4403636708964, 1582.620171158922, 9282.628694852207, 9674.0, 9684.46735429552, 9774.266929980262, 9787.657431989881, 8234.300084492825, 10354.430506322149, 10672.573097076127, 10780.622678206264, 10783.352998820077, 2406.3142004528713, 2436.0377650827913, 2436.9634455483183, 2438.9512209755794, 2446.13162327373, 2037.4397040813822, 2313.5719891820067, 2367.6803631509783, 2381.5117900830373, 2395.4849707312924, 2101.05452546354, 2123.9469013274716, 2328.906843726249, 2409.4578719788083, 2420.249722585995, 2314.7569505201964, 2319.2462449703744, 2328.2316835444262, 2328.627419612854, 2330.673705681206, 2320.0951628864755, 2437.695288088989, 2438.536678031186, 2446.0949448704096, 2447.5472037672907, 11008.009279164913, 11082.556697732081, 11107.83338249927, 11134.888651113466, 11169.609063682814, 5836.124581312794, 6002.3697511761075, 6006.12911127884, 6007.309159446632, 6010.729517171694, 3392.5759280089987, 3431.7083047940955, 3616.1140520572626, 3666.2484190740834, 3678.668919797231, 1065.387402243713, 1093.6937657455926, 1117.2458590451413, 1234.7653945750278, 1245.3524167432975, 15254.08475491463, 15393.307301171475, 15398.999065060736, 15415.3833846646, 15419.768703469457, 4747.311639812277, 4954.479779623088, 5022.070916880316, 5030.044291584587, 5030.37120359955, 12848.614541563767, 12868.806967895489, 12887.93556032214, 12898.03264755147, 12908.483660653468, 5875.441833025856, 6026.728797204137, 6037.607555508878, 6046.727897244635, 6051.122587224828, 5127.102757017507, 5195.038917800219, 5264.710440925785, 5272.868178295496, 5283.418823929364, 3469.9479507807405, 4013.779242141652, 4133.338665813455, 4174.123434078817, 4177.185448837508, 1149.8677652070119, 1155.7399585093456, 1156.3235507228198, 1168.1005625668188, 1169.351010189353, 692.3388164303179, 809.299955538455, 817.3910436724678, 829.7925518620345, 840.8990921089509, 6447.226332839996, 6491.545591808528, 6620.702068406933, 6626.734930602722, 6807.3873351398615, 1009.707184916366, 1022.7443139215196, 1027.0602398805158, 1032.4321623107262, 1049.559185142242, 4454.844080457168, 4469.240229161051, 4583.816647334136, 4712.24604063355, 4725.40932383452, 13797.24115173675, 14078.0, 14084.788728169086, 14089.0, 14134.64663383403, 13271.800922986164, 13749.931250343685, 14007.509737159151, 14021.439142434392, 14033.368498417392, 7822.6479808409895, 8565.271951884035, 8830.690925817695, 8876.467411955304, 9941.80116397668, 5737.512311453574, 6469.77355792545, 6573.605583664996, 6617.7683781067435, 6621.569597976116, 11712.941435292769, 11885.76228475443, 11935.76128477443, 11966.341851198267, 11993.700157496132, 12121.151519393557, 12164.330961796832, 12269.325187114795, 12369.257844529357, 12509.624711258677, 8963.014068452596, 9234.861477077984, 9236.353455258068, 9241.861372079558, 9283.62865485373, 9985.950070249603, 10010.099091081838, 10014.198864091, 10124.08883200486, 10128.493575321352, 7616.619169041636, 8948.910510895068, 9071.047540008203, 9213.493257870881, 9297.535123243675, 8711.433756805787, 8768.912310876809, 8858.867116993379, 8870.290376769972, 9031.0, 7775.066991961001, 7896.526208427513, 8008.199180081945, 8017.919820801951, 8034.919650803651, 5839.153322768259, 5906.173135761082, 5907.91138132937, 6021.969890150521, 6086.513078953762, 5877.265341832271, 6027.21646185993, 6129.662868542095, 6136.417040381157, 6185.597936134137], "value": 5119.986985039916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.22122436760975, 373.2516304808858, 379.2301627695779, 380.51104330934754, 384.4732716178834, 4927.679700819444, 5120.795168193277, 5152.0, 5243.423223445423, 5265.210218467232, 4740.668153229275, 4954.504549545044, 4968.900621987558, 4969.751512424374, 4998.750062496879, 3891.9297193271796, 3980.2685831663175, 4263.467066616673, 4266.565414841044, 4431.357453169288, 3906.9023274418223, 3983.760974341534, 4300.6344460720875, 4305.4833419989645, 4359.38968544404, 4128.0, 4257.7445353278745, 4364.563543645626, 4365.454318210223, 4375.234333991555, 4337.002489427434, 4338.739675619473, 4347.84782532613, 4356.150550642642, 4432.556744325541, 3833.2333533293454, 3936.389859571771, 4095.955531339519, 4162.438070860456, 4251.87244382669, 4155.833766649331, 4232.101010807607, 4585.220512512881, 4601.631869450436, 4799.0, 4698.389209402756, 5053.574284343499, 5090.618203634742, 5094.847154585368, 5132.691163753257, 4989.3264409305, 5039.193729003342, 5202.713850738208, 5392.272043274147, 5448.0, 4058.5738497457933, 4234.830606775725, 4325.697201195918, 4582.770861456914, 4659.88350291242, 5068.214426763858, 5147.202183661539, 5438.891222175614, 5559.805406810742, 5675.914861277125, 3928.2339943710704, 4140.565240649748, 4489.326601009875, 4781.904361912742, 4794.352762377104, 3846.4999550058315, 3985.940210896839, 4218.514870789899, 4506.436695413074, 4612.723236605747, 4427.867163985085, 4857.8299759508245, 4867.1969125093965, 4882.780274887638, 4910.189818679878, 5104.82589004531, 5351.688836235069, 5476.890462190813, 5528.612997090165, 5531.174712344997, 1350.514434122477, 1487.7768334749658, 1554.689062187567, 1555.7044161609258, 1561.4144695739099, 1072.6406653771073, 1074.2641290715885, 1130.3895896216115, 1155.3530023187043, 1166.8389951997647, 4444.422225110715, 4818.734969576707, 5019.548240658285, 5035.597152227813, 5057.418396884332, 4776.704074188799, 5221.660592061504, 5572.944270557324, 5577.0, 5599.244102046253, 4772.331873537708, 5037.496250374933, 5085.923711144335, 5114.33513643224, 5119.897602047939, 2496.9750302497105, 2743.478739039576, 2851.900183493568, 2950.6279579994975, 2956.5565165224957, 4900.754962251873, 5350.5987050971335, 5476.945230547723, 5859.384764599741, 5865.325487568899, 5205.713685747321, 5272.235525848807, 5286.418493965661, 5436.891262174813, 5522.0, 5323.86690332737, 5444.537214336747, 5482.753276102505, 5524.779008839601, 5847.795327163529, 4897.90204195907, 5127.53852153308, 5661.518770904355, 5688.914666279927, 5717.885642287048, 4625.93061104077, 4987.875303117451, 5428.321459817523, 5553.16702494629, 5597.6845441322075, 5358.632714337802, 5731.111677689798, 5820.621659592113, 5888.4700376964565, 5898.882022359615, 4002.7198096132993, 4189.455370801777, 4312.331588603772, 4484.6321871829405, 4492.528284530208, 4867.367242258625, 5497.120460726264, 5591.329040515164, 5640.956423061582, 5692.5730570208225, 4801.023365513404, 5298.767751671554, 5324.121519949165, 5511.0, 5561.805336813354, 4692.460367057832, 4785.162596545661, 5312.282841816305, 5350.759215835219, 5468.343798744176, 4667.509911459248, 5093.529638125432, 5331.466853314638, 5351.625386222927, 5353.0, 5105.493879305688, 5128.307678463509, 5203.907179492349, 5254.7667241423005, 5501.0, 4704.600108990774, 4765.642576806684, 5216.713080780593, 5302.443243459381, 5305.442928492453], "value": 4184.170237925171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7706333973124, 766.6320166320163, 769.0195001373252, 837.8533756592597, 843.8650809822233, 14686.926565367172, 15306.770398444005, 15433.69132617347, 15437.305321260543, 15496.380144794195, 12480.93759531201, 13827.723445531083, 14120.57638270851, 14284.857151428483, 14551.490697825579, 911.3301723233435, 917.614601867214, 918.1140199707281, 919.6367434863225, 919.8482250428672, 900.0864122915247, 908.2824568590838, 909.1181553892746, 910.0580898769774, 931.4597533430627, 979.5983646704852, 982.5971351745785, 983.4984158079395, 985.3201291109148, 986.9901300987005, 977.7702239973601, 977.9070988256104, 978.2907392140642, 979.5396163803073, 980.691082309074, 724.8985142080113, 726.742006587659, 728.3372131360436, 728.351766927435, 728.3808762551841, 15473.148976806271, 15603.375864965388, 15658.138802365866, 15822.446214382442, 15901.284442200129, 13896.58310250694, 14164.716705665933, 14227.644308892257, 14306.356213970292, 14333.140011599233, 11640.883591164065, 11822.231554948901, 11899.821502677467, 11908.047356211482, 12017.158798884082, 3635.1820840310984, 3720.4977328060636, 3721.0697325668584, 3859.9421008684894, 3873.438351439054, 92361.07638923592, 95486.04513954841, 102124.48937755339, 104279.0, 105749.99999999923, 10598.364098153981, 10601.310914790514, 10995.065419439437, 11002.0, 11505.942470287595, 22061.779382205972, 22122.22572209997, 22136.0, 22159.44601384978, 22186.44533886666, 7772.727954521678, 7844.725434609762, 7869.252421019994, 7898.170692077364, 7954.920450795534, 4253.340732186516, 4298.677599180074, 4330.675199360061, 4396.098799746044, 4485.798139083749, 2987.3129180288656, 3544.521489598871, 3546.6098729139776, 3560.946585801215, 3564.9305208437363, 639.0222958872839, 643.6910283064155, 645.8417687666552, 667.642811096071, 667.8597494526107, 563.1837324628042, 711.4877288352378, 721.1670520548774, 732.7655150351836, 738.7968308715039, 9320.95339523298, 10107.494625268708, 10142.949285253526, 10236.33463824849, 10390.9609039097, 670.9563878347892, 709.9219085900547, 719.0975325965984, 730.3718801830422, 733.5598640815575, 4505.954940450553, 4597.172508948354, 4600.125976064604, 4613.861584152481, 4619.69971951822, 105101.0, 106501.93498065075, 106800.21608441268, 108990.0, 109884.35173472404, 57869.71065144731, 64174.0, 74687.25312746804, 84716.0, 92272.15455690848, 76213.85679214816, 76683.23316766873, 78079.60960195163, 78427.60786196032, 79288.20711792808, 8823.779405514913, 9874.555644996137, 10814.513346899252, 11197.328160310408, 11200.775984480428, 35479.0, 42742.93142671458, 49733.50266497289, 49802.52172261121, 51364.0, 63720.362796371446, 64210.357896420435, 65719.35701607498, 65944.6702766483, 66397.0, 10834.620788272372, 11278.266912650652, 11314.321140731583, 12119.58680969422, 12990.545330913372, 13713.451461941411, 14685.779713304522, 14694.926525367733, 15000.774988374966, 15117.773233401727, 13429.865701343253, 13744.450221991008, 13972.580822575339, 14088.647783805487, 14221.64445888861, 12985.155964862253, 13533.120347177402, 13807.447702091804, 13972.510962116277, 14463.783043254149, 12997.0, 13792.655183620089, 13807.378667960167, 13821.447142114605, 13905.860941390456, 10870.891291087304, 11078.390688511887, 11415.200935934738, 11582.94208528952, 11975.94012029969, 9562.282828788007, 10054.748631283985, 11086.577917148512, 11282.661520154408, 11741.76516469683], "value": 7567.708046078961, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 115.0, 116.0, 115.0, 113.0, 113.0, 116.0, 116.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 129.0, 133.0, 172.0, 110.0, 111.0, 133.0, 128.0, 130.0, 111.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 175.0, 182.0, 187.0, 184.0, 182.0, 184.0, 184.0, 187.0, 184.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 62.0, 93.0, 61.0, 58.0, 78.0, 81.0, 94.0, 60.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 87.0, 70.0, 70.0, 68.0, 82.0, 68.0, 68.0, 84.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 105.0, 130.0, 129.0, 88.0, 88.0, 87.0, 88.0, 91.0], "value": 98.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 83.0, 84.0, 86.0, 95.0, 128.0, 126.0, 84.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 59.0, 60.0, 63.0, 65.0, 64.0, 63.0, 61.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 65.0, 64.0, 60.0, 58.0, 58.0, 58.0, 57.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 87.0, 83.0, 92.0, 94.0, 92.0, 107.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 139.0, 138.0, 135.0, 129.0, 133.0, 135.0, 151.0, 139.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 210.0, 194.0, 163.0, 165.0, 164.0, 166.0, 166.0, 163.0, 160.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 67.0, 63.0, 65.0, 61.0, 64.0], "value": 64.8, "unit": "score"}]}]} 03:34:38 INFO - Return code: 0 03:34:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:34:38 ERROR - # TBPL SUCCESS # 03:34:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:34:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:34:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:34:38 INFO - 2017-03-24 03:34:38.679 screenresolution[1658:9917] starting screenresolution argv=screenresolution get 03:34:38 INFO - 2017-03-24 03:34:38.682 screenresolution[1658:9917] Display 0: 1600x1200x32@60 03:34:38 INFO - 2017-03-24 03:34:38.688 screenresolution[1659:9920] starting screenresolution argv=screenresolution list 03:34:38 INFO - Available Modes on Display 0 03:34:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:34:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:34:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:34:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:34:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:34:38 INFO - Intel Iris: 03:34:38 INFO - Chipset Model: Intel Iris 03:34:38 INFO - Type: GPU 03:34:38 INFO - Bus: Built-In 03:34:38 INFO - VRAM (Dynamic, Max): 1536 MB 03:34:38 INFO - Vendor: Intel (0x8086) 03:34:38 INFO - Device ID: 0x0a2e 03:34:38 INFO - Revision ID: 0x0009 03:34:38 INFO - Displays: 03:34:38 INFO - Display: 03:34:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:34:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:34:38 INFO - Display Serial Number: 1600x1200 60 03:34:38 INFO - Main Display: Yes 03:34:38 INFO - Mirror: Off 03:34:38 INFO - Online: Yes 03:34:38 INFO - Rotation: Supported 03:34:38 INFO - Return code: 0 03:34:38 INFO - Running post-action listener: _resource_record_post_action 03:34:38 INFO - [mozharness: 2017-03-24 10:34:38.934669Z] Finished run-tests step (success) 03:34:38 INFO - Running post-run listener: _resource_record_post_run 03:34:38 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37159936; Write bytes: 509940736; Read time: 241; Write time: 1571 03:34:38 INFO - TinderboxPrint: CPU usage
54.2% 03:34:38 INFO - TinderboxPrint: I/O read bytes / time
37,159,936 / 241 03:34:38 INFO - TinderboxPrint: I/O write bytes / time
509,940,736 / 1,571 03:34:38 INFO - TinderboxPrint: CPU idle
2,203.3 (45.8%) 03:34:38 INFO - TinderboxPrint: CPU system
962.2 (20.0%) 03:34:38 INFO - TinderboxPrint: CPU user
1,640.3 (34.1%) 03:34:38 INFO - TinderboxPrint: Swap in / out
245,633,024 / 0 03:34:38 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206641664; Write bytes: 201590784; Read time: 15697; Write time: 431 03:34:39 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 34993152; Write bytes: 297229312; Read time: 219; Write time: 1103 03:34:39 INFO - Running post-run listener: _upload_blobber_files 03:34:39 INFO - Blob upload gear active. 03:34:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:34:39 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 03:34:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:34:39 INFO - (blobuploader) - INFO - Open directory for files ... 03:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:40 INFO - (blobuploader) - INFO - Done attempting. 03:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:41 INFO - (blobuploader) - INFO - Done attempting. 03:34:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:34:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:42 INFO - (blobuploader) - INFO - Done attempting. 03:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:44 INFO - (blobuploader) - INFO - Done attempting. 03:34:44 INFO - (blobuploader) - INFO - Iteration through files over. 03:34:44 INFO - Return code: 0 03:34:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:34:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:34:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2557a8d904825454376f60d7fb52b6d17e0400cd8d1e01dcfd50e9bee13f519ec3533a035ba2d36dd46bd37e92ea14c9c50486e24f80260155c26574fe4104d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99763ea73a51203f90f519ee853c6eb7ae548b32544b70b8b34fb07e551bea4c5e7ca4c853488a8761455b7b4e8142c9cb5eba6136bf490bc496d911e276fba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fa210915299da2f6d773856f63e3fa9aac0f4116e95c4e609d33e1c486d1ee20feb3607ab5c0d93c4b9b45b347b06348c54c86ea41d0d26028a90ff51e05956", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d68f09d997df74a2dee8fefe1a32a638275dbdad12c2b1e08f97abcd2b82bf37787873303b1b110ab147f15324ed7a7be18e3211c6a7ba1a1506ad6a1c87b0b"} 03:34:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:34:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:34:44 INFO - Contents: 03:34:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2557a8d904825454376f60d7fb52b6d17e0400cd8d1e01dcfd50e9bee13f519ec3533a035ba2d36dd46bd37e92ea14c9c50486e24f80260155c26574fe4104d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99763ea73a51203f90f519ee853c6eb7ae548b32544b70b8b34fb07e551bea4c5e7ca4c853488a8761455b7b4e8142c9cb5eba6136bf490bc496d911e276fba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fa210915299da2f6d773856f63e3fa9aac0f4116e95c4e609d33e1c486d1ee20feb3607ab5c0d93c4b9b45b347b06348c54c86ea41d0d26028a90ff51e05956", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d68f09d997df74a2dee8fefe1a32a638275dbdad12c2b1e08f97abcd2b82bf37787873303b1b110ab147f15324ed7a7be18e3211c6a7ba1a1506ad6a1c87b0b"} 03:34:44 INFO - Running post-run listener: copy_logs_to_upload_dir 03:34:44 INFO - Copying logs to upload dir... 03:34:44 INFO - mkdir: /builds/slave/test/build/upload/logs 03:34:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.120719 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-24 03:34:45.096734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 03:34:45.100494) ========= 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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2557a8d904825454376f60d7fb52b6d17e0400cd8d1e01dcfd50e9bee13f519ec3533a035ba2d36dd46bd37e92ea14c9c50486e24f80260155c26574fe4104d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99763ea73a51203f90f519ee853c6eb7ae548b32544b70b8b34fb07e551bea4c5e7ca4c853488a8761455b7b4e8142c9cb5eba6136bf490bc496d911e276fba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fa210915299da2f6d773856f63e3fa9aac0f4116e95c4e609d33e1c486d1ee20feb3607ab5c0d93c4b9b45b347b06348c54c86ea41d0d26028a90ff51e05956", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d68f09d997df74a2dee8fefe1a32a638275dbdad12c2b1e08f97abcd2b82bf37787873303b1b110ab147f15324ed7a7be18e3211c6a7ba1a1506ad6a1c87b0b"} build_url:https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010856 build_url: 'https://queue.taskcluster.net/v1/task/NsHne-y_SA6LdzCwlrBXHA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2557a8d904825454376f60d7fb52b6d17e0400cd8d1e01dcfd50e9bee13f519ec3533a035ba2d36dd46bd37e92ea14c9c50486e24f80260155c26574fe4104d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99763ea73a51203f90f519ee853c6eb7ae548b32544b70b8b34fb07e551bea4c5e7ca4c853488a8761455b7b4e8142c9cb5eba6136bf490bc496d911e276fba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fa210915299da2f6d773856f63e3fa9aac0f4116e95c4e609d33e1c486d1ee20feb3607ab5c0d93c4b9b45b347b06348c54c86ea41d0d26028a90ff51e05956", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d68f09d997df74a2dee8fefe1a32a638275dbdad12c2b1e08f97abcd2b82bf37787873303b1b110ab147f15324ed7a7be18e3211c6a7ba1a1506ad6a1c87b0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 03:34:45.134591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 03:34:45.134915) ========= 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.PEeAfR3s4b/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.1pZG6g8QXO/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.005213 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 03:34:45.184748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 03:34:45.185105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 03:34:45.185460) ========= ========= Total master_lag: 0.63 =========