builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1491146686.3 results: success (0) buildid: 20170402074622 builduid: 96e82754fbf44badb46709b7cc66a3a3 revision: b4076d6343bec612bfd11437656508bd5533a194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:46.302060) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:46.302462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:46.302764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:46.329782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:46.330134) ========= 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.fMTYcvyy8s/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.1IGYGVubxy/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-04-02 08:24:46-- 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% 13.8M=0.001s 2017-04-02 08:24:46 (13.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.592238 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:46.994339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:46.994699) ========= 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.fMTYcvyy8s/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.1IGYGVubxy/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.027900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:47.051179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:47.051971) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b4076d6343bec612bfd11437656508bd5533a194 --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 b4076d6343bec612bfd11437656508bd5533a194 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fMTYcvyy8s/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.1IGYGVubxy/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-04-02 08:24:47,116 truncating revision to first 12 chars 2017-04-02 08:24:47,116 Setting DEBUG logging. 2017-04-02 08:24:47,116 attempt 1/10 2017-04-02 08:24:47,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b4076d6343be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 08:24:47,727 unpacking tar archive at: mozilla-aurora-b4076d6343be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.880125 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:47.959073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:47.959349) ========= script_repo_revision: b4076d6343bec612bfd11437656508bd5533a194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:47.959709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:47.960007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 08:24:47.980272) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-02 08:24:47.980560) ========= /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.fMTYcvyy8s/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.1IGYGVubxy/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:24:48 INFO - MultiFileLogger online at 20170402 08:24:48 in /builds/slave/test 08:24:48 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 08:24:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:48 INFO - {'append_to_log': False, 08:24:48 INFO - 'base_work_dir': '/builds/slave/test', 08:24:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:48 INFO - 'branch': 'Mozilla-Aurora', 08:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:48 INFO - 'config_files': ('talos/mac_config.py',), 08:24:48 INFO - 'default_actions': ('clobber', 08:24:48 INFO - 'read-buildbot-config', 08:24:48 INFO - 'download-and-extract', 08:24:48 INFO - 'populate-webroot', 08:24:48 INFO - 'create-virtualenv', 08:24:48 INFO - 'install', 08:24:48 INFO - 'run-tests'), 08:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:48 INFO - 'download_minidump_stackwalk': True, 08:24:48 INFO - 'download_symbols': 'ondemand', 08:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:48 INFO - 'gecko_profile': False, 08:24:48 INFO - 'gecko_profile_interval': 0, 08:24:48 INFO - 'installer_path': 'installer.exe', 08:24:48 INFO - 'log_level': 'info', 08:24:48 INFO - 'log_name': 'talos', 08:24:48 INFO - 'log_to_console': True, 08:24:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:24:48 INFO - 'opt_config_files': (), 08:24:48 INFO - 'pip_index': False, 08:24:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:24:48 INFO - 'cmd': ('bash', 08:24:48 INFO - '-c', 08:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:24:48 INFO - 'enabled': True, 08:24:48 INFO - 'halt_on_failure': False, 08:24:48 INFO - 'name': 'check_screen_resolution'},), 08:24:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:24:48 INFO - 'cmd': ('bash', 08:24:48 INFO - '-c', 08:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:24:48 INFO - 'enabled': True, 08:24:48 INFO - 'halt_on_failure': False, 08:24:48 INFO - 'name': 'check_screen_resolution'},), 08:24:48 INFO - 'run_cmd_checks_enabled': True, 08:24:48 INFO - 'suite': 'dromaeojs', 08:24:48 INFO - 'system_bits': '32', 08:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:48 INFO - 'title': 't-yosemite-r7-0028', 08:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:48 INFO - 'use_talos_json': True, 08:24:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:48 INFO - 'work_dir': 'build'} 08:24:48 INFO - [mozharness: 2017-04-02 15:24:48.151766Z] Running clobber step. 08:24:48 INFO - Running pre-action listener: _resource_record_pre_action 08:24:48 INFO - Running main action method: clobber 08:24:48 INFO - rmtree: /builds/slave/test/build 08:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:50 INFO - Running post-action listener: _resource_record_post_action 08:24:50 INFO - [mozharness: 2017-04-02 15:24:50.729026Z] Finished clobber step (success) 08:24:50 INFO - [mozharness: 2017-04-02 15:24:50.729283Z] Running read-buildbot-config step. 08:24:50 INFO - Running pre-action listener: _resource_record_pre_action 08:24:50 INFO - Running main action method: read_buildbot_config 08:24:50 INFO - Using buildbot properties: 08:24:50 INFO - { 08:24:50 INFO - "project": "", 08:24:50 INFO - "product": "firefox", 08:24:50 INFO - "script_repo_revision": "production", 08:24:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:24:50 INFO - "repository": "", 08:24:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:24:50 INFO - "buildid": "20170402074622", 08:24:50 INFO - "pgo_build": "False", 08:24:50 INFO - "basedir": "/builds/slave/test", 08:24:50 INFO - "buildnumber": 5, 08:24:50 INFO - "slavename": "t-yosemite-r7-0028", 08:24:50 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:24:50 INFO - "platform": "yosemite_r7", 08:24:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:24:50 INFO - "branch": "mozilla-aurora", 08:24:50 INFO - "repo_path": "releases/mozilla-aurora", 08:24:50 INFO - "revision": "b4076d6343bec612bfd11437656508bd5533a194", 08:24:50 INFO - "stage_platform": "macosx64", 08:24:50 INFO - "builduid": "96e82754fbf44badb46709b7cc66a3a3", 08:24:50 INFO - "slavebuilddir": "test" 08:24:50 INFO - } 08:24:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 08:24:50 INFO - Running post-action listener: _resource_record_post_action 08:24:50 INFO - [mozharness: 2017-04-02 15:24:50.734724Z] Finished read-buildbot-config step (success) 08:24:50 INFO - [mozharness: 2017-04-02 15:24:50.734937Z] Running download-and-extract step. 08:24:50 INFO - Running pre-action listener: _resource_record_pre_action 08:24:50 INFO - Running main action method: download_and_extract 08:24:50 INFO - mkdir: /builds/slave/test/build/tests 08:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:50 INFO - trying https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 08:24:50 INFO - Downloading https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/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 08:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/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 08:24:52 INFO - Downloaded 1199 bytes. 08:24:52 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:24:52 INFO - Using the following test package requirements: 08:24:52 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:24:52 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 08:24:52 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 08:24:52 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'jsshell-mac.zip'], 08:24:52 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 08:24:52 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:24:52 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 08:24:52 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 08:24:52 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 08:24:52 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:24:52 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 08:24:52 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:24:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:24:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:24:52 INFO - Fetch https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:24:53 INFO - Expected file size: 51792701 08:24:53 INFO - Obtained file size: 51792701 08:25:10 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 08:25:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:25:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:25:10 INFO - Fetch https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:25:12 INFO - Expected file size: 51792701 08:25:12 INFO - Obtained file size: 51792701 08:25:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 08:25:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:25:27 INFO - Fetch https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 08:25:28 INFO - Expected file size: 14404438 08:25:28 INFO - Obtained file size: 14404438 08:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:28 INFO - trying https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:25:28 INFO - Downloading https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 08:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/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 08:25:31 INFO - Downloaded 74686234 bytes. 08:25:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:25:31 INFO - mkdir: /builds/slave/test/properties 08:25:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:31 INFO - Contents: 08:25:31 INFO - build_url:https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:25:32 INFO - Running post-action listener: _resource_record_post_action 08:25:32 INFO - Running post-action listener: set_extra_try_arguments 08:25:32 INFO - [mozharness: 2017-04-02 15:25:32.137268Z] Finished download-and-extract step (success) 08:25:32 INFO - [mozharness: 2017-04-02 15:25:32.137390Z] Running populate-webroot step. 08:25:32 INFO - Running pre-action listener: _resource_record_pre_action 08:25:32 INFO - Running main action method: populate_webroot 08:25:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:32 INFO - '--tppagecycles', 08:25:32 INFO - '7'], 08:25:32 INFO - 'tests': ['tsvgm']}}, 08:25:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:25:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:25:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:25:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:25:32 INFO - 'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:25:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:25:32 INFO - 'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['damp', 'tps']}, 08:25:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:25:32 INFO - 'tests': ['damp', 'tps']}, 08:25:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['dromaeo_dom']}, 08:25:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['basic_compositor_video']}, 08:25:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:25:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['a11yr', 08:25:32 INFO - 'ts_paint', 08:25:32 INFO - 'tpaint', 08:25:32 INFO - 'sessionrestore', 08:25:32 INFO - 'sessionrestore_no_auto_restore', 08:25:32 INFO - 'tabpaint']}, 08:25:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:25:32 INFO - 'ts_paint', 08:25:32 INFO - 'tpaint', 08:25:32 INFO - 'sessionrestore', 08:25:32 INFO - 'sessionrestore_no_auto_restore', 08:25:32 INFO - 'tabpaint']}, 08:25:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:25:32 INFO - 'ts_paint', 08:25:32 INFO - 'tpaint', 08:25:32 INFO - 'sessionrestore', 08:25:32 INFO - 'sessionrestore_no_auto_restore', 08:25:32 INFO - 'tabpaint']}, 08:25:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:25:32 INFO - 'ts_paint', 08:25:32 INFO - 'tpaint', 08:25:32 INFO - 'sessionrestore', 08:25:32 INFO - 'sessionrestore_no_auto_restore', 08:25:32 INFO - 'tabpaint']}, 08:25:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['a11yr', 08:25:32 INFO - 'ts_paint', 08:25:32 INFO - 'tpaint', 08:25:32 INFO - 'sessionrestore', 08:25:32 INFO - 'sessionrestore_no_auto_restore', 08:25:32 INFO - 'tabpaint']}, 08:25:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['a11yr', 08:25:32 INFO - 'ts_paint', 08:25:32 INFO - 'tpaint', 08:25:32 INFO - 'sessionrestore', 08:25:32 INFO - 'sessionrestore_no_auto_restore', 08:25:32 INFO - 'tabpaint']}, 08:25:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['tsvgx', 08:25:32 INFO - 'tsvgr_opacity', 08:25:32 INFO - 'tart', 08:25:32 INFO - 'tscrollx', 08:25:32 INFO - 'cart', 08:25:32 INFO - 'tsvg_static']}, 08:25:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:25:32 INFO - 'tsvgr_opacity', 08:25:32 INFO - 'tart', 08:25:32 INFO - 'tscrollx', 08:25:32 INFO - 'cart', 08:25:32 INFO - 'tsvg_static']}, 08:25:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:25:32 INFO - 'talos_options': ['--disable-e10s'], 08:25:32 INFO - 'tests': ['tp5o']}, 08:25:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:25:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:25:32 INFO - 'talos_options': ['--disable-e10s', 08:25:32 INFO - '--xperf_path', 08:25:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:32 INFO - 'tests': ['tp5n']}, 08:25:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:25:32 INFO - 'talos_options': ['--xperf_path', 08:25:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:32 INFO - 'tests': ['tp5n']}}, 08:25:32 INFO - 'talos.zip': {'path': '', 08:25:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:32 INFO - Running post-action listener: _resource_record_post_action 08:25:32 INFO - [mozharness: 2017-04-02 15:25:32.155795Z] Finished populate-webroot step (success) 08:25:32 INFO - [mozharness: 2017-04-02 15:25:32.155912Z] Running create-virtualenv step. 08:25:32 INFO - Running pre-action listener: _resource_record_pre_action 08:25:32 INFO - Running main action method: create_virtualenv 08:25:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:25:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:32 INFO - Using real prefix '/tools/python27' 08:25:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:35 INFO - Installing pip.................done. 08:25:35 INFO - Return code: 0 08:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:25:36 INFO - Reading from file tmpfile_stdout 08:25:36 INFO - Output received: 08:25:36 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) 08:25:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25: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', 'pip>=1.5'] in /builds/slave/test/build 08:25: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 pip>=1.5 08:25:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:36 INFO - 'HOME': '/Users/cltbld', 08:25:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:36 INFO - 'LOGNAME': 'cltbld', 08:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:36 INFO - 'MOZ_NO_REMOTE': '1', 08:25:36 INFO - 'NO_EM_RESTART': '1', 08:25:36 INFO - 'PAGER': '/bin/cat', 08:25:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:36 INFO - 'PWD': '/builds/slave/test', 08:25:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:36 INFO - 'SHELL': '/bin/bash', 08:25:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:36 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:36 INFO - 'USER': 'cltbld', 08:25:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:36 INFO - 'XPC_FLAGS': '0x0', 08:25:36 INFO - 'XPC_SERVICE_NAME': '0', 08:25:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:25:36 INFO - Cleaning up... 08:25:36 INFO - Return code: 0 08:25:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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', '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 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:25: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 psutil>=3.1.1 08:25:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:36 INFO - 'HOME': '/Users/cltbld', 08:25:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:36 INFO - 'LOGNAME': 'cltbld', 08:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:36 INFO - 'MOZ_NO_REMOTE': '1', 08:25:36 INFO - 'NO_EM_RESTART': '1', 08:25:36 INFO - 'PAGER': '/bin/cat', 08:25:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:36 INFO - 'PWD': '/builds/slave/test', 08:25:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:36 INFO - 'SHELL': '/bin/bash', 08:25:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:36 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:36 INFO - 'USER': 'cltbld', 08:25:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:36 INFO - 'XPC_FLAGS': '0x0', 08:25:36 INFO - 'XPC_SERVICE_NAME': '0', 08:25:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:36 INFO - Downloading/unpacking psutil>=3.1.1 08:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:40 INFO - Installing collected packages: psutil 08:25:40 INFO - Running setup.py install for psutil 08:25:40 INFO - building 'psutil._psutil_osx' extension 08:25:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:25:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:25:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:25:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:25:41 INFO - building 'psutil._psutil_posix' extension 08:25:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:25:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:25:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:25:41 INFO - ^ 08:25:41 INFO - 1 warning generated. 08:25:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:41 INFO - Successfully installed psutil 08:25:41 INFO - Cleaning up... 08:25:41 INFO - Return code: 0 08:25:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:25:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:42 INFO - 'HOME': '/Users/cltbld', 08:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:42 INFO - 'LOGNAME': 'cltbld', 08:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:42 INFO - 'MOZ_NO_REMOTE': '1', 08:25:42 INFO - 'NO_EM_RESTART': '1', 08:25:42 INFO - 'PAGER': '/bin/cat', 08:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:42 INFO - 'PWD': '/builds/slave/test', 08:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:42 INFO - 'SHELL': '/bin/bash', 08:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:42 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:42 INFO - 'USER': 'cltbld', 08:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:42 INFO - 'XPC_FLAGS': '0x0', 08:25:42 INFO - 'XPC_SERVICE_NAME': '0', 08:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:25:44 INFO - Installing collected packages: mozsystemmonitor 08:25:44 INFO - Running setup.py install for mozsystemmonitor 08:25:45 INFO - Successfully installed mozsystemmonitor 08:25:45 INFO - Cleaning up... 08:25:45 INFO - Return code: 0 08:25:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:45 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 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:45 INFO - 'HOME': '/Users/cltbld', 08:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:45 INFO - 'LOGNAME': 'cltbld', 08:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:45 INFO - 'MOZ_NO_REMOTE': '1', 08:25:45 INFO - 'NO_EM_RESTART': '1', 08:25:45 INFO - 'PAGER': '/bin/cat', 08:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:45 INFO - 'PWD': '/builds/slave/test', 08:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:45 INFO - 'SHELL': '/bin/bash', 08:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:45 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:45 INFO - 'USER': 'cltbld', 08:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:45 INFO - 'XPC_FLAGS': '0x0', 08:25:45 INFO - 'XPC_SERVICE_NAME': '0', 08:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:48 INFO - warning: no files found matching '*.txt' 08:25:48 INFO - no previously-included directories found matching 'build' 08:25:48 INFO - no previously-included directories found matching 'dist' 08:25:48 INFO - no previously-included directories found matching '.git*' 08:25:48 INFO - Installing collected packages: jsonschema, functools32 08:25:48 INFO - Running setup.py install for functools32 08:25:48 INFO - warning: no files found matching '*.txt' 08:25:48 INFO - no previously-included directories found matching 'build' 08:25:48 INFO - no previously-included directories found matching 'dist' 08:25:48 INFO - no previously-included directories found matching '.git*' 08:25:48 INFO - Successfully installed jsonschema functools32 08:25:48 INFO - Cleaning up... 08:25:48 INFO - Return code: 0 08:25:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:48 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 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:48 INFO - 'HOME': '/Users/cltbld', 08:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:48 INFO - 'LOGNAME': 'cltbld', 08:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:48 INFO - 'MOZ_NO_REMOTE': '1', 08:25:48 INFO - 'NO_EM_RESTART': '1', 08:25:48 INFO - 'PAGER': '/bin/cat', 08:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:48 INFO - 'PWD': '/builds/slave/test', 08:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:48 INFO - 'SHELL': '/bin/bash', 08:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:48 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:48 INFO - 'USER': 'cltbld', 08:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:48 INFO - 'XPC_FLAGS': '0x0', 08:25:48 INFO - 'XPC_SERVICE_NAME': '0', 08:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:25:49 INFO - Cleaning up... 08:25:49 INFO - Return code: 0 08:25:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:49 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 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:49 INFO - 'HOME': '/Users/cltbld', 08:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:49 INFO - 'LOGNAME': 'cltbld', 08:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:49 INFO - 'MOZ_NO_REMOTE': '1', 08:25:49 INFO - 'NO_EM_RESTART': '1', 08:25:49 INFO - 'PAGER': '/bin/cat', 08:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:49 INFO - 'PWD': '/builds/slave/test', 08:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:49 INFO - 'SHELL': '/bin/bash', 08:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:49 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:49 INFO - 'USER': 'cltbld', 08:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:49 INFO - 'XPC_FLAGS': '0x0', 08:25:49 INFO - 'XPC_SERVICE_NAME': '0', 08:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:53 INFO - Downloading docopt-0.6.1.tar.gz 08:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:53 INFO - Running setup.py install for blobuploader 08:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:53 INFO - Running setup.py install for requests 08:25:54 INFO - Running setup.py install for docopt 08:25:54 INFO - Successfully installed blobuploader requests docopt 08:25:54 INFO - Cleaning up... 08:25:54 INFO - Return code: 0 08:25:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:54 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 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:54 INFO - 'HOME': '/Users/cltbld', 08:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:54 INFO - 'LOGNAME': 'cltbld', 08:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:54 INFO - 'MOZ_NO_REMOTE': '1', 08:25:54 INFO - 'NO_EM_RESTART': '1', 08:25:54 INFO - 'PAGER': '/bin/cat', 08:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:54 INFO - 'PWD': '/builds/slave/test', 08:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:54 INFO - 'SHELL': '/bin/bash', 08:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:54 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:54 INFO - 'USER': 'cltbld', 08:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:54 INFO - 'XPC_FLAGS': '0x0', 08:25:54 INFO - 'XPC_SERVICE_NAME': '0', 08:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qx11yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-GS8yQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-0rtTL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7LrbU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-sgmfbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Ihv1bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Bp68H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-FseXyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-R59tKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Sxq9_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ZVxcrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-CMBZDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-08oV_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jVhZRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-b0nRlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-8UZLpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-VZYviv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:25:56 INFO - Running setup.py install for manifestparser 08:25:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:25:56 INFO - Running setup.py install for mozcrash 08:25:56 INFO - Running setup.py install for mozdebug 08:25:56 INFO - Running setup.py install for mozdevice 08:25:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:25:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:25:56 INFO - Running setup.py install for mozfile 08:25:57 INFO - Running setup.py install for mozhttpd 08:25:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Running setup.py install for mozinfo 08:25:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Running setup.py install for mozInstall 08:25:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Running setup.py install for mozleak 08:25:57 INFO - Running setup.py install for mozlog 08:25:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Running setup.py install for moznetwork 08:25:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:57 INFO - Running setup.py install for mozprocess 08:25:58 INFO - Running setup.py install for mozprofile 08:25:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:58 INFO - Running setup.py install for mozrunner 08:25:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:58 INFO - Running setup.py install for mozscreenshot 08:25:58 INFO - Running setup.py install for moztest 08:25:58 INFO - Running setup.py install for mozversion 08:25:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:58 INFO - Cleaning up... 08:25:58 INFO - Return code: 0 08:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:58 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 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:58 INFO - 'HOME': '/Users/cltbld', 08:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:58 INFO - 'LOGNAME': 'cltbld', 08:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:58 INFO - 'MOZ_NO_REMOTE': '1', 08:25:58 INFO - 'NO_EM_RESTART': '1', 08:25:58 INFO - 'PAGER': '/bin/cat', 08:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:58 INFO - 'PWD': '/builds/slave/test', 08:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:58 INFO - 'SHELL': '/bin/bash', 08:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:25:58 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:58 INFO - 'USER': 'cltbld', 08:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:58 INFO - 'XPC_FLAGS': '0x0', 08:25:58 INFO - 'XPC_SERVICE_NAME': '0', 08:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-018eJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-xkv6aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:59 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)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-r1Tnd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Vr7tS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:59 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)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-z242jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-53mCeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-XtJ2ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-PXnRSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-TKv9GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-L7F8dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:00 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)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Fj_sgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UZB3Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:00 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)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-5r5RWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jRgTXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:00 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)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Y3YBEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Fa1Pcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:00 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)) 08:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-uL3KJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:26:00 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)) 08:26:00 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)) 08:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:26:00 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)) 08:26:00 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)) 08:26:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:03 INFO - Downloading blessings-1.6.tar.gz 08:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:26:03 INFO - Installing collected packages: blessings 08:26:03 INFO - Running setup.py install for blessings 08:26:03 INFO - Successfully installed blessings 08:26:03 INFO - Cleaning up... 08:26:03 INFO - Return code: 0 08:26:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:04 INFO - Reading from file tmpfile_stdout 08:26:04 INFO - Current package versions: 08:26:04 INFO - blessings == 1.6 08:26:04 INFO - blobuploader == 1.2.4 08:26:04 INFO - docopt == 0.6.1 08:26:04 INFO - functools32 == 3.2.3-2 08:26:04 INFO - jsonschema == 2.5.1 08:26:04 INFO - manifestparser == 1.1 08:26:04 INFO - mozInstall == 1.12 08:26:04 INFO - mozcrash == 1.0 08:26:04 INFO - mozdebug == 0.1 08:26:04 INFO - mozdevice == 0.49 08:26:04 INFO - mozfile == 1.2 08:26:04 INFO - mozhttpd == 0.7 08:26:04 INFO - mozinfo == 0.9 08:26:04 INFO - mozleak == 0.1 08:26:04 INFO - mozlog == 3.4 08:26:04 INFO - moznetwork == 0.27 08:26:04 INFO - mozprocess == 0.25 08:26:04 INFO - mozprofile == 0.28 08:26:04 INFO - mozrunner == 6.13 08:26:04 INFO - mozscreenshot == 0.1 08:26:04 INFO - mozsystemmonitor == 0.3 08:26:04 INFO - moztest == 0.8 08:26:04 INFO - mozversion == 1.4 08:26:04 INFO - psutil == 3.1.1 08:26:04 INFO - requests == 1.2.3 08:26:04 INFO - wsgiref == 0.1.2 08:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:04 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 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:04 INFO - 'HOME': '/Users/cltbld', 08:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:04 INFO - 'LOGNAME': 'cltbld', 08:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:04 INFO - 'MOZ_NO_REMOTE': '1', 08:26:04 INFO - 'NO_EM_RESTART': '1', 08:26:04 INFO - 'PAGER': '/bin/cat', 08:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:04 INFO - 'PWD': '/builds/slave/test', 08:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:04 INFO - 'SHELL': '/bin/bash', 08:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:26:04 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:04 INFO - 'USER': 'cltbld', 08:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:04 INFO - 'XPC_FLAGS': '0x0', 08:26:04 INFO - 'XPC_SERVICE_NAME': '0', 08:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:26:04 INFO - Cleaning up... 08:26:04 INFO - Return code: 0 08:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108cf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9334e5ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, '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.fMTYcvyy8s/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.1IGYGVubxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:04 INFO - 'HOME': '/Users/cltbld', 08:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:04 INFO - 'LOGNAME': 'cltbld', 08:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:04 INFO - 'MOZ_NO_REMOTE': '1', 08:26:04 INFO - 'NO_EM_RESTART': '1', 08:26:04 INFO - 'PAGER': '/bin/cat', 08:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:04 INFO - 'PWD': '/builds/slave/test', 08:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:04 INFO - 'SHELL': '/bin/bash', 08:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:26:04 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:04 INFO - 'USER': 'cltbld', 08:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:04 INFO - 'XPC_FLAGS': '0x0', 08:26:04 INFO - 'XPC_SERVICE_NAME': '0', 08:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:26:04 INFO - Cleaning up... 08:26:04 INFO - Return code: 0 08:26:04 INFO - Running post-action listener: _resource_record_post_action 08:26:04 INFO - Running post-action listener: _start_resource_monitoring 08:26:04 INFO - Starting resource monitoring. 08:26:04 INFO - [mozharness: 2017-04-02 15:26:04.786382Z] Finished create-virtualenv step (success) 08:26:04 INFO - [mozharness: 2017-04-02 15:26:04.787380Z] Running install step. 08:26:04 INFO - Running pre-action listener: _resource_record_pre_action 08:26:04 INFO - Running main action method: install 08:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:05 INFO - Reading from file tmpfile_stdout 08:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:26:05 INFO - Reading from file tmpfile_stdout 08:26:05 INFO - Output received: 08:26:05 INFO - Usage: mozinstall [options] installer 08:26:05 INFO - Options: 08:26:05 INFO - -h, --help show this help message and exit 08:26:05 INFO - -d DEST, --destination=DEST 08:26:05 INFO - Directory to install application into. [default: 08:26:05 INFO - "/builds/slave/test"] 08:26:05 INFO - --app=APP Application being installed. [default: firefox] 08:26:05 INFO - mkdir: /builds/slave/test/build/application 08:26:05 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'] 08:26:05 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 08:26:25 INFO - Reading from file tmpfile_stdout 08:26:25 INFO - Output received: 08:26:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:26:25 INFO - Running post-action listener: _resource_record_post_action 08:26:25 INFO - [mozharness: 2017-04-02 15:26:25.247606Z] Finished install step (success) 08:26:25 INFO - [mozharness: 2017-04-02 15:26:25.247741Z] Running run-tests step. 08:26:25 INFO - Running pre-action listener: _resource_record_pre_action 08:26:25 INFO - Running main action method: run_tests 08:26:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:26:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:26:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:26:25 INFO - 2017-04-02 08:26:25.260 screenresolution[1632:11744] starting screenresolution argv=screenresolution get 08:26:25 INFO - 2017-04-02 08:26:25.262 screenresolution[1632:11744] Display 0: 1600x1200x32@60 08:26:25 INFO - 2017-04-02 08:26:25.267 screenresolution[1633:11746] starting screenresolution argv=screenresolution list 08:26:25 INFO - Available Modes on Display 0 08:26:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:26:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:26:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:26:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:26:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:26:25 INFO - Intel Iris: 08:26:25 INFO - Chipset Model: Intel Iris 08:26:25 INFO - Type: GPU 08:26:25 INFO - Bus: Built-In 08:26:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:26:25 INFO - Vendor: Intel (0x8086) 08:26:25 INFO - Device ID: 0x0a2e 08:26:25 INFO - Revision ID: 0x0009 08:26:25 INFO - Displays: 08:26:25 INFO - Display: 08:26:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:26:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:26:25 INFO - Display Serial Number: 1600x1200 60 08:26:25 INFO - Main Display: Yes 08:26:25 INFO - Mirror: Off 08:26:25 INFO - Online: Yes 08:26:25 INFO - Rotation: Supported 08:26:25 INFO - Return code: 0 08:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:26:25 INFO - Python 2.7.3 08:26:25 INFO - Return code: 0 08:26:25 INFO - grabbing minidump binary from tooltool 08:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:25 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 0x108ad1d30>, '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 0x1089f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ac6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:26:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:26:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:26:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:26:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:26:25 INFO - Return code: 0 08:26:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:26:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:26:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:26:25 INFO - ENV: RUST_BACKTRACE is now 1 08:26:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:26:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:26:25 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/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:26:25 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/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMTYcvyy8s/Render', 08:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:25 INFO - 'HOME': '/Users/cltbld', 08:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:25 INFO - 'LOGNAME': 'cltbld', 08:26:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:26:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:25 INFO - 'MOZ_NO_REMOTE': '1', 08:26:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:26:25 INFO - 'NO_EM_RESTART': '1', 08:26:25 INFO - 'PAGER': '/bin/cat', 08:26:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:25 INFO - 'PWD': '/builds/slave/test', 08:26:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:25 INFO - 'RUST_BACKTRACE': '1', 08:26:25 INFO - 'SHELL': '/bin/bash', 08:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1IGYGVubxy/Listeners', 08:26:25 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 08:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:25 INFO - 'USER': 'cltbld', 08:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:25 INFO - 'XPC_FLAGS': '0x0', 08:26:25 INFO - 'XPC_SERVICE_NAME': '0', 08:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:25 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/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:26:25 INFO - mozversion application_buildid: 20170402074622 08:26:25 INFO - mozversion application_changeset: b4076d6343bec612bfd11437656508bd5533a194 08:26:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:26:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:26:25 INFO - mozversion application_name: Firefox 08:26:25 INFO - mozversion application_remotingname: firefox-dev 08:26:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:26:25 INFO - mozversion application_vendor: Mozilla 08:26:25 INFO - mozversion application_version: 54.0a2 08:26:25 INFO - mozversion platform_buildid: 20170402074622 08:26:25 INFO - mozversion platform_changeset: b4076d6343bec612bfd11437656508bd5533a194 08:26:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:26:25 INFO - mozversion platform_version: 54.0a2 08:26:25 INFO - using testdate: 1491146785 08:26:25 INFO - actual date: 1491146785 08:26:25 INFO - starting webserver on 'localhost:49241' 08:26:25 INFO - SUITE-START | Running 2 tests 08:26:25 INFO - TEST-START | dromaeo_css 08:26:25 INFO - operating with platform_type : mac_ 08:26:25 INFO - Initialising browser for dromaeo_css test... 08:26:25 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpemeSTv/profile http://localhost:49241/getInfo.html) 08:26:28 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 08:26:28 INFO - PROCESS | 1643 | colorDepth:24 08:26:28 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 08:26:28 INFO - PROCESS | 1643 | __metrics 08:26:28 INFO - PROCESS | 1643 | 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" 08:26:28 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:26:29 INFO - TEST-INFO | 1643: exit 0 08:26:29 INFO - Browser initialized. 08:26:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:26:29 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpemeSTv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:41 INFO - PROCESS | 1646 | RSS: Main: 215425024 08:26:41 INFO - PROCESS | 1646 | 08:29:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:29:47 INFO - PROCESS | 1646 | RSS: Main: 347832320 08:29:47 INFO - PROCESS | 1646 | 08:31:30 INFO - PROCESS | 1646 | ************************* 08:31:30 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 08:31:30 INFO - PROCESS | 1646 | 08:31:30 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:31:30 INFO - PROCESS | 1646 | Full stack: 08:31:30 INFO - PROCESS | 1646 | ************************* 08:32:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:32:51 INFO - PROCESS | 1646 | RSS: Main: 351178752 08:32:51 INFO - PROCESS | 1646 | 08:35:53 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:35:54 INFO - PROCESS | 1646 | RSS: Main: 337281024 08:35:54 INFO - PROCESS | 1646 | 08:38:56 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:38:57 INFO - PROCESS | 1646 | RSS: Main: 315957248 08:38:57 INFO - PROCESS | 1646 | 08:42:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:42:01 INFO - PROCESS | 1646 | RSS: Main: 326729728 08:42:01 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:45:05 INFO - PROCESS | 1646 | RSS: Main: 503087104 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | __start_tp_report 08:45:05 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 08:45:05 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 08:45:05 INFO - PROCESS | 1646 | |i|pagename|runs| 08:45:05 INFO - PROCESS | 1646 | |0;dojo.html;3394.049666093494;3397.4394224952885;3404.3021180657965;3414.829258537073;3451.102713294543;5552.361478429982;5749.683767392792;5916.55625828063;5928.05151175812;5942.316633587139;5856.414358564141;5889.646621202731;5946.5242780577555;5951.404859514047;5953;4407.889802754925;5322.414534401213;5364.865878353034;5425.810096646618;5483.725813709319;5291.3650361956425;5294.52349288564;5320.308359913206;5405.810796622119;5470.671759694411;5429.077056900317;5468.835934921959;5469.206964990074;5473.589480788937;5510.448955104497;5438.972805135989;5445.700486473243;5467.425920278373;5470.8085217017215;5471.50756431923;5213.191955246943;5224.373075230958;5315.123004704219;5426.31419323725;5440.483154100354;5770.451807078321;5784.045632470637;5787.855303617401;5795.478406943354;5809.070548712186;6290.056491526262;6353.078803573502;6360.268569114564;6378.712957916859;6380.744770209186;5987.341392446828;6428.582142160744;6445.51658625605;6450.258220304678;6450.419462248373;5812.970935145382;6029.336772954972;6124.35694252106;6133.6319820810895;6134.877302453926;6343;6369.71336289868;6411.326810684905;6447.3552644735155;6478.902816457757;6297.811065668037;6360.395762402564;6364.045393190966;6371.33101024395;6372.299047104815;6408;6418.679066046772;6424.903626445607;6451.806445806634;6459.354064593503;5901.616394934402;6192.8761424771255;6264.906026409608;6268.341824108494;6374.872502549923;6345;6350.237971443364;6362.840928976812;6363.427291543783;6367.299597044322;5088.592912566985;5089.51649593288;5091.872703182376;5094.872628184251;5098.923516147261;4500.302453119772;4515;4551.772411379484;4556.70381425213;4566.771661416916;4804.759762011955;5674.602777805597;5718.799842005593;5790.073588225948;5800.39095894925;6293.181886354744;6331;6357.618542887441;6363.459105975951;6406.807795766134;5935.910961335583;5942.286925568959;5948.583599148104;5956.702164891738;5987.760489580455;5569.944300556943;5618.887622247532;5626.634268772516;5643.40744221859;5651.886962260814;6299.748010079546;6321.5258855586935;6367.044943258548;6552.3775241352;6584.374484423972;6296.181496405438;6374.330695276929;6382.457491113121;6398.808035758934;6400.615963042233;6473.546851720334;6533.314002029909;6549.508786840911;6554.868902622016;6568.244651865097;5518.834434966958;6239.845628558731;6386.361363863576;6387.744490220525;6401.487880969418;6139.1098290746695;6211.534134939988;6311.179546658905;6352.714127864349;6375.6812159392775;6299.86602411552;6309.305976342691;6312.116303717575;6317.084022816574;6333.619982801047;6222.968885155546;6228.844278892882;6294.402031806971;6297.937020629735;6326.6520341381665;5940.702964851826;5948.8810223796145;5953.702314884152;5980.700964951648;5985.0723137911955;6188.102725104744;6223.813285601439;6236.594621349598;6341.714622841891;6346.904796427965;6202.2867370253;6206.193194884636;6210.658413787285;6214.9067763984485;6254.499640028877 08:45:05 INFO - PROCESS | 1646 | |1;ext.html;789.4473868292196;816.1226681317585;873.4453621950064;897.4929165021758;899.1233547291388;39569;40773.79613101934;40960.18079638409;40993;43568;42790.78604606973;42907.3563896541;43002.35496467556;43018.569814301845;43047.78476107615;7413.073365829271;9268.07319268073;9438.197753190987;9460.290478214127;9468.384555003937;7533.698652053911;10910;11140.777184456307;11298.830517542243;11312.547498100066;11163.553457861717;11164.385958772264;11166.832497512503;11168.106551475903;11170.888291117066;7302.269773022708;11109.166812489095;11113.277636953571;11122.666320010332;11146.498407571638;7506.211847756016;7527.698892044312;7544.0569928758905;7545.547267163988;10745.301555398873;33454.498182527284;40730.796346018375;40854.591454085676;40855.38716919249;40880.38679419811;3798.1264309209037;3828.7319887607878;3842.5773164951834;3866.4393662919;3938.2911076006308;23376.18183363591;28803.56794648082;29143.562846557317;29203.85398073017;29604.259893502618;3079.414911166871;3123.2660324823646;3157.2106973256687;3160;3170;328322;330958;331121;331954;332637;42709.35935960963;43317.78341108337;53847.92304153895;53904.46095539073;53956.46043539593;46490.53509464862;46544;46633.76683116631;46668.7666561665;46688.533114669095;14360.56918292453;14874.479393221185;15255.313510892036;15363;15371.615709607126;12887.871121288854;12919.677008074874;12922.41849116792;12924.612261632166;12944.546940857024;13103.737925241632;13126.343682815821;13150.802737958938;13202.141860779018;13286.867131328563;4721.457032441244;5561.499465048084;5640.32316122068;5647.774089036392;5656.575756818255;973.59595767757;1079.266099052636;1111.5498223219608;1124.8368986496912;1175.341808587194;23277.3016809496;25080.749192508207;27287.590686139723;27578.724212758018;27664.308392290353;968.7190714692802;1067.2849191042021;1105.1545567640762;1160.4081918221768;1191.7020744813797;14014.439422423193;14041.438342466392;14177.015217869506;14291.499797507038;14396.064255823547;495943;496264;497288;497362;497467;59892.401075989554;60014.699926500085;60114.49713757104;60123.39876601265;60237;1407.3596513586294;1460.9123452592878;1461.5834487171105;1469.6619777451247;1473.6978919321514;26060;26335.34161645974;26427.735722642527;26681.599776003764;26866.59700104461;50040.249396258354;50077.998440030264;50093.74953125211;50121;50137;413924;414875.7768633533;415894;418113;418375;27228.183154505397;27661.031863885473;30921.381572368875;32927.83536082304;33206.83396583002;43393.78303108464;44605.661830145145;45895.623131306114;46267.074658507314;46270.30594541152;29346.55980160342;30284;30343;30789;31955.68044319527;30690.23274418068;30816;31244.531332029583;31900;32212.35575288434;29861.850690746407;36890.63109368872;37597.81201093977;37621.62378376291;37665.81167094257;30159.69840301569;30260.394792103594;30327.545086824157;31234.21914452157;31342.843285784336;23719.644205337278;24775.50448991046;24926.626100608144;25544.872275638503;25818 08:45:05 INFO - PROCESS | 1646 | |2;jquery.html;390.67769090500343;411.88995656705174;412.5358971157448;430.63396113303685;437.549324196078;13042.413091410886;14809.703805923875;21014.474638134034;21078.89460552695;21558.029888655008;21782.237621683245;22163.667544986798;22246.666300005512;22523.662145067836;22704.88647556764;6505.056766768816;6619.834504137399;6723.966380168093;6784.151981002375;6796.694148763293;5589.35722391924;6423.197100362455;6745.898811517831;6748.865022699543;6827.726890924357;6819.283975182609;6824.965875170617;6829.965850170767;6839.0425340452375;6848.246692863781;6570.704318305688;6724.092247546568;6746.359095885883;6807.523473356867;6817.113775209215;6599.967000164968;6605.141331626905;6610.438112760373;6627.768028118992;6671.633060181688;25500.744992550022;26060.86969565159;26104.47589575421;26300.079497217695;26338.736612634013;2894.2185609885423;2914.4316858212655;2944.764418846487;2967.317516971087;2975.8096761295437;7243.89134162988;7367.852642947111;10801.459927003618;14530.491432799907;16087;1979.3171355882341;2006.2476571285767;2010.6280338137344;2035.6946458031266;2036.134642776814;136130;139504.30247848696;162646;162879;165546;19670.901645491682;20405;20571.794282057286;20574.794252057287;20651.69022464664;31692.841535792635;32277;32383.51424728584;32418.02745917626;32471.51292730611;10198.235132365102;10283.177345812317;10547.683569492927;10548.736281593021;10651.467426628638;8787.868181977148;8788.428752131218;8842.602082906285;8966.910330896739;8976.012638609878;7677.500962437535;7734.690612375442;9327;9327.647491113887;9477.668281610111;3378.9324213515592;3942.2903877301787;3997.137802866168;4048.595140485928;4057.3102572562734;820.8440396324679;846.552395403854;880.5157163560017;886.5301390263171;897.8563429851192;20241.49396265076;21170.153193872073;21171.047302871408;21214.893925530272;21276.468088297916;915.3180880244261;941.6421759731259;944.6835310171169;946.4132238012339;964.6527250189926;8684;10605.681829545127;11067.391293478775;11074.224804263624;11079.390633515233;720350;721602;728245;743499;755819;84443;117608.99999999828;146686;147427;152338.23830880775;1246.2273390497949;1269.270169652435;1286.2411177405377;1289.8065290206544;1290.1356091418772;17886.731699024785;18569.16438760232;19170.233190672774;21169;21213.469663258544;66718.33281667315;66843.66578167077;67447;68686.65656671685;69034;89946;90966.05329949375;91508;92977.07022929683;93628.53185734028;11221.719457013314;11704.414779260833;11839;11899.107566932342;12065.638030859089;12910.741785164431;12918.289494077915;12937.353132343533;13292.202467851574;13329.266890320738;10814.783704325711;11122.944385278022;11134.27627204229;11258.718532036764;11361.602343917923;10316.587336506756;10413;10450;10639.840402394126;10650;10668.30656007357;11388.772224555629;11394;11521.711957201138;11772.764544709229;11701.654309754147;11775.470103845519;11815.70460738454;11974.64076077719;12039;10947.56209751633;10963.287386319864;11160.274582152135;11276.32342059479;11291 08:45:05 INFO - PROCESS | 1646 | |3;mootools.html;1537.7847101405805;1544.5289186798022;1566.8354822743604;1589.2133393969982;1595.3379347570763;10478.318909270893;11094.445277736111;11133.1093512519;11138.944305278472;11162.274452160624;10661.413622250773;10856.674299771019;10991;11168.162387820905;11184.217104802667;2396.8561886286834;2435.7929575986063;2436.049940523197;2436.8294219404647;2439.1706819681303;2317.582835089683;2414.7826695597482;2420.4311986683115;2427.5751743444916;2429.6962879640046;1978.584497255578;1982.8215460608542;2398.5083057973075;2412.9396765080837;2426.648136020276;1956.5891162855817;2070.3995841206033;2283.5432913417385;2389.462370966536;2396.8082553395775;2386.05750728463;2391.6128645385634;2391.8086553075887;2394.7485514021128;2396.352984694123;11109.72225694356;11184.049355804766;11194.38430886301;11212.607558735486;11276.097912167006;5601.215829783833;5708.372079071299;5907.881842363128;5920.585559010871;5923.141144534018;3394.96605033949;3619.0771353305004;3642.1440961374055;3699.648533389324;3703.6111208323277;1121.7419993401481;1185.5080141741253;1192.0880526397314;1198.3888217009387;1218.9085818563553;13685.726285474235;14031.228282444461;14309.28453577317;15657.451989180325;15685.372585096582;4563.817447302071;4711.222648263067;4734.431868175772;4737.431508219036;4762.261849413347;11951.04391648666;11965.820512692317;11972.700682483008;11981.221220620806;12010.219335743148;4810.965642386904;4998.075356059141;5403.324584426947;5773.6824474654295;5784.913226301609;4622.422197225347;5065.468125846733;5225.268462415265;5225.3207083079715;5229.607779416559;3667.5965643779164;3830.8467661293794;3855.556610989716;3898.766074035567;3908.0620651043546;1014.9238807089498;1016.5476363018386;1017.1862509991977;1032.948352582368;1035.4770840725537;853.2832420766586;923.8845144356956;943.9669611563562;954.3271993244746;955.6225291010151;6581.967090164614;6658.667066646745;6707.295733947963;6837.111175547247;6843.520953533205;1005.9990309641806;1039.8544203811473;1041.8958104189671;1060.8620879285643;1086.9293495922739;4206.26390381682;4214.915701685949;4220.514640816284;4334.219840428753;4346.304591265445;13084.280364579849;13647;13678;13690.110142840882;13700.314984250748;13094.934525327313;13259.734805304033;13581.932090339682;13607.795883061763;13704.65738356549;8578.871316930252;10082.949585252027;10087.293889427816;10270.870204277524;10310.96890310963;6532.216134063943;6547.410733033859;6577.638229897401;6665.533412661067;6706.161729783777;12183.147179697336;12201.69495762613;12206.02351811835;12398.070144739;12435.93782031084;12560.623181304576;12571.434285456993;12594.181378210387;12786.296753678636;12793.488260469478;7175.425965922609;7202.279772022755;8436.789080273042;8579.65681372738;8615.956920215609;10364.326318789255;10539.26225164231;10646.467676616294;10652.147828173882;10653;8714.064177502158;8735.43219690718;8737.344699147463;8879.733607991771;8977.910220897707;8536.487810731376;8543.316534677087;8595.09751476111;8608.440451370641;8637.956810215908;7737.806554836174;7804.141544429995;7944.324732397579;7948.8807667886185;7959.204079591995;5933.080372542263;6002.219711437485;6071.392860713893;6072.453479186895;6109;5728.398518155534;5890.087036509348;6008.24896887889;6035.9094613579955;6105.023196288573 08:45:05 INFO - PROCESS | 1646 | |4;prototype.html;318.4792863667903;372.0772484239087;379.44979779319993;381.7556763671251;383.20676200265444;4297.785110744466;4331.963976930841;4851.63612729045;4897.338859253995;4918.409790825097;4797.376341075664;4869.4887036861155;4871.196252618313;4871.537203965627;4884.096442158194;3896.7272290939572;3913.493305077551;3957.35769655594;3988.660963818079;4031.3751368537924;3293.851776670044;3611.2665920358113;3929.9978505481063;4023.7786921719294;4057.3711074783455;3898.961010389902;4012.157446936132;4044.8179831907637;4060.9086320544793;4076.32740597801;3448.9310213795834;3522.6477352264824;3869.32286849803;4094.6928980326447;4111.239420707164;3106.673799251069;3547.609762926076;3722.7394082414244;3751.4372844073337;3798.2023775007283;4297.205017071852;4382.877823536753;4785.976070119627;4826.951730482685;4829.932992549756;4480.655803259009;4729.219678753002;4740.739259340735;4788.377510923592;4817.470078291385;4874.805007799684;4896.534829191221;5021.5229553192385;5208.739563021872;5280.735963201863;3919.7256192066566;4227.365895115758;4233.428487154226;4263.509696384894;4278.72188307759;5069.580517455119;5242.580593552545;5335.9466405336225;5542.362628297757;5552.555795536387;3620.891373258754;3901.258760835489;4306.74159550428;4306.956930430718;4347.673924455678;3906.570277269498;4265;4424.7123936944;4432.229856339788;4443.134178454879;4079.551249362568;4638.698484598558;4749.572538471554;4756.669232076327;4768.356271903318;4144.854930077433;4516.570925762047;5103.770330335144;5283.471652834686;5334.253204551366;1316.7827308494184;1491.8955673102778;1492.6865358274667;1519.9240037998056;1529.0061460051056;1082.86464191976;1122.9943850280697;1139.5954436175039;1142.8971392574708;1157.9942100289445;4467.168460931002;4891.608671306287;4942.233953737176;4946.554810067111;4976.825811096594;4968.453470118284;5419.620626556182;5471.23402723619;5473.890522189534;5496.47162305336;4108.096218831853;4534.877914814973;4640.303954406799;4893.755312234374;4930.359053323117;2449.534588428193;2489.514544663773;2640.603909413603;2716.858919253918;2796.4267325198284;4675.368825208621;5050.368703912011;5454.045542030129;5567.109262517978;5581.6930068846605;4087.570805065485;5107.67200527858;5251.4485978972425;5335.653182543122;5374.464301769184;5265.894682106336;5485.780568777284;5487.6981766002455;5503.7798488061635;5660.433956604306;4797.968436786107;5189.431231540411;5404.945950540601;5418.02008895114;5431.83704488866;4584.441289961429;4928.457869634409;5040.697558146523;5112.539871411442;5347.5721942243745;5462.644928079662;5534.363548192009;5560.2493663356545;5570.805021824217;5601.551875849841;4288.828446862215;4327.805248763751;4333.631641310524;4389.912201756011;4392.913366151052;4426.269665505156;4440.289553671397;4491.439879268785;5024.6231532634465;5060.797568097235;4273.358996150602;4713.363695901009;4962;5216.452272511484;5221.869453263699;4491.833257553351;5138.871528211825;5172.482751724798;5199.66202196856;5218.634695571273;4065.8780236592947;4503.581371867851;4885.7801398937845;5072.619553533426;5086.491350864884;4712.599429048432;4973.51853702417;5180.430152683277;5203.661761985459;5205.843824685266;4346.6088052075465;4510.50384457716;4861.222204447272;5019.992003198604;5069.493050694901 08:45:05 INFO - PROCESS | 1646 | |5;yui.html;673.7473447457204;714.1715609892526;736.0982796074805;784.882267659851;833.9249467547921;15240.695186096285;15971.281292341844;16079.437219697313;16125.838741612595;16179.75730364044;12214.511419543207;13993.720125597481;14890;14895.404183832634;14909.92545037276;917.289100946765;926.735880274122;950.6150009246267;950.9572069256866;952.6570434643522;920.7974245665943;939.1829108675462;945.5508633399149;948.1135138645354;960.6397600899662;998.1266391907081;1000.9199264058894;1000.9949950250239;1002.959881604735;1003.7540802503397;995.6963126246492;998.0418797953973;1000.6647772996018;1000.7348052766023;1002.5939494504664;741.7366834773632;741.9406447484188;742.0464702856857;742.1057625561186;742.6954948471155;15307.770383444256;15725.213739313103;15740.291686874118;16056;16248.75626865598;11622.244554103956;12025.458854351575;14302.92848535761;14383.856161438356;14405.279736013263;11315;11606.709832254177;11624.128190385754;12083.637490875288;12464.252144871336;3656.117617742337;3717.237966216946;3728.0493474164186;3818.6563209311016;3840.9807950960067;90499.09500904972;98188;104877;105172.47413762883;107361.46319268354;10974.341539507655;10983.780324393467;11042.723931901606;11650.359230242419;11704.590339338083;21695.674564881225;21883.12467501314;22156.781377024417;22315.218967336066;22347.882605869643;7836.725714599962;7907.248811363026;7988.560629165451;8063.879041814377;8081.23228293323;4180.209956246691;4224.640905523065;4294.82820687169;4298;4370.672199585044;3370.898873033813;3429.879954201641;3440.1571614953996;3470.73969452287;3477.51314815926;603.0110618585524;604.5586721693101;619.9938000619936;624.0483263023834;624.9093881387173;660.3693472733528;668.5654324688991;683.4054372695787;688.5145972089765;727.3708242370311;9807.754806129904;9908.554115064839;10070.748231294276;10277.331973421704;10700.625478108228;558.6536347464516;585.1369230385147;609.5123900879279;651.00396393518;665.7802925034727;4635.466921304026;5093.414257360451;5097.643164978416;5101.846944591668;5102.617303702237;97490.02509974952;99016;99103.50448247713;100384.49807751061;101792.98207017835;89471.55264223638;89562.55218723865;91404;91802;92038.61942070874;75073.24926750772;75329;76876.61561692155;77070.6146469264;77932;9753.366031207948;9793.951030244803;9803.264755143251;9808.705738827846;9816.80366392654;33775;38325.4251186238;49483.50516494933;49575.50424495709;50573.98852023012;60007.399926001926;61115.38884611097;61241.69379153076;61808.07287890595;62143.06785398132;12781.872181278068;12805.615831525069;13115.344232788513;13221;13270.469181232642;14295.57113286603;14539.20034398076;14733.116013039253;15023.549293521211;15048.097114173184;13822.017583900339;14131.64670883236;14142.154556305984;14277.28613569338;14527;13736.519221827188;14059.00194091857;14087.295635217994;14360.85639143637;14366.209858457885;13157.210567365988;13221.867781322064;13690.315484225948;13806.17162970225;14145.151290922578;9661.323707340418;10194.490275486047;10295.382277063101;10350.327228730108;10421.166306695597;9104;9285.582148803454;10778.407187604756;11503.252288601549;11736.589219377282 08:45:05 INFO - PROCESS | 1646 | __end_tp_report 08:45:05 INFO - PROCESS | 1646 | __start_cc_report 08:45:05 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2047 08:45:05 INFO - PROCESS | 1646 | __end_cc_report 08:45:05 INFO - PROCESS | 1646 | __startTimestamp1491147905269__endTimestamp 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | ------- Summary: start ------- 08:45:05 INFO - PROCESS | 1646 | Number of tests: 6 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5884.93 Median:6134.88 stddev:661.05 (10.8%) stddev-sans-first:633.54 08:45:05 INFO - PROCESS | 1646 | Values: 3394.0 3397.4 3404.3 3414.8 3451.1 5552.4 5749.7 5916.6 5928.1 5942.3 5856.4 5889.6 5946.5 5951.4 5953.0 4407.9 5322.4 5364.9 5425.8 5483.7 5291.4 5294.5 5320.3 5405.8 5470.7 5429.1 5468.8 5469.2 5473.6 5510.4 5439.0 5445.7 5467.4 5470.8 5471.5 5213.2 5224.4 5315.1 5426.3 5440.5 5770.5 5784.0 5787.9 5795.5 5809.1 6290.1 6353.1 6360.3 6378.7 6380.7 5987.3 6428.6 6445.5 6450.3 6450.4 5813.0 6029.3 6124.4 6133.6 6134.9 6343.0 6369.7 6411.3 6447.4 6478.9 6297.8 6360.4 6364.0 6371.3 6372.3 6408.0 6418.7 6424.9 6451.8 6459.4 5901.6 6192.9 6264.9 6268.3 6374.9 6345.0 6350.2 6362.8 6363.4 6367.3 5088.6 5089.5 5091.9 5094.9 5098.9 4500.3 4515.0 4551.8 4556.7 4566.8 4804.8 5674.6 5718.8 5790.1 5800.4 6293.2 6331.0 6357.6 6363.5 6406.8 5935.9 5942.3 5948.6 5956.7 5987.8 5569.9 5618.9 5626.6 5643.4 5651.9 6299.7 6321.5 6367.0 6552.4 6584.4 6296.2 6374.3 6382.5 6398.8 6400.6 6473.5 6533.3 6549.5 6554.9 6568.2 5518.8 6239.8 6386.4 6387.7 6401.5 6139.1 6211.5 6311.2 6352.7 6375.7 6299.9 6309.3 6312.1 6317.1 6333.6 6223.0 6228.8 6294.4 6297.9 6326.7 5940.7 5948.9 5953.7 5980.7 5985.1 6188.1 6223.8 6236.6 6341.7 6346.9 6202.3 6206.2 6210.7 6214.9 6254.5 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:55698.16 Median:180267.18 stddev:111509.74 (61.9%) stddev-sans-first:111746.35 08:45:05 INFO - PROCESS | 1646 | Values: 789.4 816.1 873.4 897.5 899.1 39569.0 40773.8 40960.2 40993.0 43568.0 42790.8 42907.4 43002.4 43018.6 43047.8 7413.1 9268.1 9438.2 9460.3 9468.4 7533.7 10910.0 11140.8 11298.8 11312.5 11163.6 11164.4 11166.8 11168.1 11170.9 7302.3 11109.2 11113.3 11122.7 11146.5 7506.2 7527.7 7544.1 7545.5 10745.3 33454.5 40730.8 40854.6 40855.4 40880.4 3798.1 3828.7 3842.6 3866.4 3938.3 23376.2 28803.6 29143.6 29203.9 29604.3 3079.4 3123.3 3157.2 3160.0 3170.0 328322.0 330958.0 331121.0 331954.0 332637.0 42709.4 43317.8 53847.9 53904.5 53956.5 46490.5 46544.0 46633.8 46668.8 46688.5 14360.6 14874.5 15255.3 15363.0 15371.6 12887.9 12919.7 12922.4 12924.6 12944.5 13103.7 13126.3 13150.8 13202.1 13286.9 4721.5 5561.5 5640.3 5647.8 5656.6 973.6 1079.3 1111.5 1124.8 1175.3 23277.3 25080.7 27287.6 27578.7 27664.3 968.7 1067.3 1105.2 1160.4 1191.7 14014.4 14041.4 14177.0 14291.5 14396.1 495943.0 496264.0 497288.0 497362.0 497467.0 59892.4 60014.7 60114.5 60123.4 60237.0 1407.4 1460.9 1461.6 1469.7 1473.7 26060.0 26335.3 26427.7 26681.6 26866.6 50040.2 50078.0 50093.7 50121.0 50137.0 413924.0 414875.8 415894.0 418113.0 418375.0 27228.2 27661.0 30921.4 32927.8 33206.8 43393.8 44605.7 45895.6 46267.1 46270.3 29346.6 30284.0 30343.0 30789.0 31955.7 30690.2 30816.0 31244.5 31900.0 32212.4 29861.9 36890.6 37597.8 37621.6 37665.8 30159.7 30260.4 30327.5 31234.2 31342.8 23719.6 24775.5 24926.6 25544.9 25818.0 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:42016.45 Median:24102.82 stddev:122239.43 (507.2%) stddev-sans-first:122542.39 08:45:05 INFO - PROCESS | 1646 | Values: 390.7 411.9 412.5 430.6 437.5 13042.4 14809.7 21014.5 21078.9 21558.0 21782.2 22163.7 22246.7 22523.7 22704.9 6505.1 6619.8 6724.0 6784.2 6796.7 5589.4 6423.2 6745.9 6748.9 6827.7 6819.3 6825.0 6830.0 6839.0 6848.2 6570.7 6724.1 6746.4 6807.5 6817.1 6600.0 6605.1 6610.4 6627.8 6671.6 25500.7 26060.9 26104.5 26300.1 26338.7 2894.2 2914.4 2944.8 2967.3 2975.8 7243.9 7367.9 10801.5 14530.5 16087.0 1979.3 2006.2 2010.6 2035.7 2036.1 136130.0 139504.3 162646.0 162879.0 165546.0 19670.9 20405.0 20571.8 20574.8 20651.7 31692.8 32277.0 32383.5 32418.0 32471.5 10198.2 10283.2 10547.7 10548.7 10651.5 8787.9 8788.4 8842.6 8966.9 8976.0 7677.5 7734.7 9327.0 9327.6 9477.7 3378.9 3942.3 3997.1 4048.6 4057.3 820.8 846.6 880.5 886.5 897.9 20241.5 21170.2 21171.0 21214.9 21276.5 915.3 941.6 944.7 946.4 964.7 8684.0 10605.7 11067.4 11074.2 11079.4 720350.0 721602.0 728245.0 743499.0 755819.0 84443.0 117609.0 146686.0 147427.0 152338.2 1246.2 1269.3 1286.2 1289.8 1290.1 17886.7 18569.2 19170.2 21169.0 21213.5 66718.3 66843.7 67447.0 68686.7 69034.0 89946.0 90966.1 91508.0 92977.1 93628.5 11221.7 11704.4 11839.0 11899.1 12065.6 12910.7 12918.3 12937.4 13292.2 13329.3 10814.8 11122.9 11134.3 11258.7 11361.6 10316.6 10413.0 10450.0 10639.8 10650.0 10668.3 11388.8 11394.0 11521.7 11772.8 11701.7 11775.5 11815.7 11974.6 12039.0 10947.6 10963.3 11160.3 11276.3 11291.0 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:6691.35 Median:2417.61 stddev:4193.37 (173.5%) stddev-sans-first:4187.26 08:45:05 INFO - PROCESS | 1646 | Values: 1537.8 1544.5 1566.8 1589.2 1595.3 10478.3 11094.4 11133.1 11138.9 11162.3 10661.4 10856.7 10991.0 11168.2 11184.2 2396.9 2435.8 2436.0 2436.8 2439.2 2317.6 2414.8 2420.4 2427.6 2429.7 1978.6 1982.8 2398.5 2412.9 2426.6 1956.6 2070.4 2283.5 2389.5 2396.8 2386.1 2391.6 2391.8 2394.7 2396.4 11109.7 11184.0 11194.4 11212.6 11276.1 5601.2 5708.4 5907.9 5920.6 5923.1 3395.0 3619.1 3642.1 3699.6 3703.6 1121.7 1185.5 1192.1 1198.4 1218.9 13685.7 14031.2 14309.3 15657.5 15685.4 4563.8 4711.2 4734.4 4737.4 4762.3 11951.0 11965.8 11972.7 11981.2 12010.2 4811.0 4998.1 5403.3 5773.7 5784.9 4622.4 5065.5 5225.3 5225.3 5229.6 3667.6 3830.8 3855.6 3898.8 3908.1 1014.9 1016.5 1017.2 1032.9 1035.5 853.3 923.9 944.0 954.3 955.6 6582.0 6658.7 6707.3 6837.1 6843.5 1006.0 1039.9 1041.9 1060.9 1086.9 4206.3 4214.9 4220.5 4334.2 4346.3 13084.3 13647.0 13678.0 13690.1 13700.3 13094.9 13259.7 13581.9 13607.8 13704.7 8578.9 10082.9 10087.3 10270.9 10311.0 6532.2 6547.4 6577.6 6665.5 6706.2 12183.1 12201.7 12206.0 12398.1 12435.9 12560.6 12571.4 12594.2 12786.3 12793.5 7175.4 7202.3 8436.8 8579.7 8616.0 10364.3 10539.3 10646.5 10652.1 10653.0 8714.1 8735.4 8737.3 8879.7 8977.9 8536.5 8543.3 8595.1 8608.4 8638.0 7737.8 7804.1 7944.3 7948.9 7959.2 5933.1 6002.2 6071.4 6072.5 6109.0 5728.4 5890.1 6008.2 6035.9 6105.0 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4332.02 Median:4712.98 stddev:1203.63 (25.5%) stddev-sans-first:1168.70 08:45:05 INFO - PROCESS | 1646 | Values: 318.5 372.1 379.4 381.8 383.2 4297.8 4332.0 4851.6 4897.3 4918.4 4797.4 4869.5 4871.2 4871.5 4884.1 3896.7 3913.5 3957.4 3988.7 4031.4 3293.9 3611.3 3930.0 4023.8 4057.4 3899.0 4012.2 4044.8 4060.9 4076.3 3448.9 3522.6 3869.3 4094.7 4111.2 3106.7 3547.6 3722.7 3751.4 3798.2 4297.2 4382.9 4786.0 4827.0 4829.9 4480.7 4729.2 4740.7 4788.4 4817.5 4874.8 4896.5 5021.5 5208.7 5280.7 3919.7 4227.4 4233.4 4263.5 4278.7 5069.6 5242.6 5335.9 5542.4 5552.6 3620.9 3901.3 4306.7 4307.0 4347.7 3906.6 4265.0 4424.7 4432.2 4443.1 4079.6 4638.7 4749.6 4756.7 4768.4 4144.9 4516.6 5103.8 5283.5 5334.3 1316.8 1491.9 1492.7 1519.9 1529.0 1082.9 1123.0 1139.6 1142.9 1158.0 4467.2 4891.6 4942.2 4946.6 4976.8 4968.5 5419.6 5471.2 5473.9 5496.5 4108.1 4534.9 4640.3 4893.8 4930.4 2449.5 2489.5 2640.6 2716.9 2796.4 4675.4 5050.4 5454.0 5567.1 5581.7 4087.6 5107.7 5251.4 5335.7 5374.5 5265.9 5485.8 5487.7 5503.8 5660.4 4798.0 5189.4 5404.9 5418.0 5431.8 4584.4 4928.5 5040.7 5112.5 5347.6 5462.6 5534.4 5560.2 5570.8 5601.6 4288.8 4327.8 4333.6 4389.9 4392.9 4426.3 4440.3 4491.4 5024.6 5060.8 4273.4 4713.4 4962.0 5216.5 5221.9 4491.8 5138.9 5172.5 5199.7 5218.6 4065.9 4503.6 4885.8 5072.6 5086.5 4712.6 4973.5 5180.4 5203.7 5205.8 4346.6 4510.5 4861.2 5020.0 5069.5 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20004.27 Median:3773.35 stddev:28377.21 (752.0%) stddev-sans-first:28419.69 08:45:05 INFO - PROCESS | 1646 | Values: 673.7 714.2 736.1 784.9 833.9 15240.7 15971.3 16079.4 16125.8 16179.8 12214.5 13993.7 14890.0 14895.4 14909.9 917.3 926.7 950.6 951.0 952.7 920.8 939.2 945.6 948.1 960.6 998.1 1000.9 1001.0 1003.0 1003.8 995.7 998.0 1000.7 1000.7 1002.6 741.7 741.9 742.0 742.1 742.7 15307.8 15725.2 15740.3 16056.0 16248.8 11622.2 12025.5 14302.9 14383.9 14405.3 11315.0 11606.7 11624.1 12083.6 12464.3 3656.1 3717.2 3728.0 3818.7 3841.0 90499.1 98188.0 104877.0 105172.5 107361.5 10974.3 10983.8 11042.7 11650.4 11704.6 21695.7 21883.1 22156.8 22315.2 22347.9 7836.7 7907.2 7988.6 8063.9 8081.2 4180.2 4224.6 4294.8 4298.0 4370.7 3370.9 3429.9 3440.2 3470.7 3477.5 603.0 604.6 620.0 624.0 624.9 660.4 668.6 683.4 688.5 727.4 9807.8 9908.6 10070.7 10277.3 10700.6 558.7 585.1 609.5 651.0 665.8 4635.5 5093.4 5097.6 5101.8 5102.6 97490.0 99016.0 99103.5 100384.5 101793.0 89471.6 89562.6 91404.0 91802.0 92038.6 75073.2 75329.0 76876.6 77070.6 77932.0 9753.4 9794.0 9803.3 9808.7 9816.8 33775.0 38325.4 49483.5 49575.5 50574.0 60007.4 61115.4 61241.7 61808.1 62143.1 12781.9 12805.6 13115.3 13221.0 13270.5 14295.6 14539.2 14733.1 15023.5 15048.1 13822.0 14131.6 14142.2 14277.3 14527.0 13736.5 14059.0 14087.3 14360.9 14366.2 13157.2 13221.9 13690.3 13806.2 14145.2 9661.3 10194.5 10295.4 10350.3 10421.2 9104.0 9285.6 10778.4 11503.3 11736.6 08:45:05 INFO - PROCESS | 1646 | -------- Summary: end -------- 08:45:05 INFO - PROCESS | 1646 | 08:45:05 INFO - TEST-INFO | 1646: exit 0 08:45:05 INFO - TEST-OK | dromaeo_css | took 1120125ms 08:45:05 INFO - TEST-START | kraken 08:45:05 INFO - operating with platform_type : mac_ 08:45:05 INFO - Initialising browser for kraken test... 08:45:05 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpMoRH0P/profile http://localhost:49241/getInfo.html) 08:45:08 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 08:45:08 INFO - PROCESS | 1655 | colorDepth:24 08:45:08 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 08:45:08 INFO - PROCESS | 1655 | __metrics 08:45:08 INFO - PROCESS | 1655 | 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" 08:45:08 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:09 INFO - TEST-INFO | 1655: exit 0 08:45:09 INFO - Browser initialized. 08:45:09 INFO - Running cycle 1/1 for kraken test... 08:45:09 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpMoRH0P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:21 INFO - PROCESS | 1656 | RSS: Main: 214921216 08:45:21 INFO - PROCESS | 1656 | 08:45:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:45:25 INFO - PROCESS | 1656 | RSS: Main: 267665408 08:45:25 INFO - PROCESS | 1656 | 08:45:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:45:28 INFO - PROCESS | 1656 | RSS: Main: 278949888 08:45:28 INFO - PROCESS | 1656 | 08:45:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:45:32 INFO - PROCESS | 1656 | RSS: Main: 377090048 08:45:32 INFO - PROCESS | 1656 | 08:45:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:45:34 INFO - PROCESS | 1656 | RSS: Main: 277831680 08:45:34 INFO - PROCESS | 1656 | 08:45:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:45:37 INFO - PROCESS | 1656 | RSS: Main: 279126016 08:45:37 INFO - PROCESS | 1656 | 08:45:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:45:41 INFO - PROCESS | 1656 | RSS: Main: 318361600 08:45:41 INFO - PROCESS | 1656 | 08:45:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:45:44 INFO - PROCESS | 1656 | RSS: Main: 318267392 08:45:44 INFO - PROCESS | 1656 | 08:45:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:45:48 INFO - PROCESS | 1656 | RSS: Main: 318464000 08:45:48 INFO - PROCESS | 1656 | 08:45:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:50 INFO - PROCESS | 1656 | RSS: Main: 294920192 08:45:50 INFO - PROCESS | 1656 | 08:45:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:52 INFO - PROCESS | 1656 | RSS: Main: 295563264 08:45:52 INFO - PROCESS | 1656 | 08:45:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:55 INFO - PROCESS | 1656 | RSS: Main: 301330432 08:45:55 INFO - PROCESS | 1656 | 08:45:58 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:59 INFO - PROCESS | 1656 | RSS: Main: 310353920 08:45:59 INFO - PROCESS | 1656 | 08:46:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:46:02 INFO - PROCESS | 1656 | RSS: Main: 311390208 08:46:02 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:46:04 INFO - PROCESS | 1656 | RSS: Main: 355917824 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | __start_tp_report 08:46:04 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 08:46:04 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 08:46:04 INFO - PROCESS | 1656 | |i|pagename|runs| 08:46:04 INFO - PROCESS | 1656 | |0;ai-astar;117;115;114;114;125;171;148;114;115;112 08:46:04 INFO - PROCESS | 1656 | |1;audio-beat-detection;173;95;122;176;141;109;111;108;128;110 08:46:04 INFO - PROCESS | 1656 | |2;audio-dft;186;183;183;184;183;185;182;186;184;181 08:46:04 INFO - PROCESS | 1656 | |3;audio-fft;82;60;63;91;64;60;63;61;76;60 08:46:04 INFO - PROCESS | 1656 | |4;audio-oscillator;89;71;89;70;69;68;82;68;68;84 08:46:04 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;86;85;86;85;87;86;86;87;87;86 08:46:04 INFO - PROCESS | 1656 | |6;imaging-darkroom;93;94;95;98;94;94;95;98;93;94 08:46:04 INFO - PROCESS | 1656 | |7;imaging-desaturate;84;85;82;83;85;84;86;85;86;86 08:46:04 INFO - PROCESS | 1656 | |8;json-parse-financial;64;60;59;60;61;63;63;64;64;64 08:46:04 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;65;64;57;53;55;69;81;82;82;57 08:46:04 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;85;91;99;84;87;85;88;82;90;108 08:46:04 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;144;123;136;137;140;142;147;152;155;139 08:46:04 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;169;166;165;167;163;164;163;164;161;220 08:46:04 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;65;65;68;66;66;67;65;66;64;64 08:46:04 INFO - PROCESS | 1656 | __end_tp_report 08:46:04 INFO - PROCESS | 1656 | __start_cc_report 08:46:04 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2079 08:46:04 INFO - PROCESS | 1656 | __end_cc_report 08:46:04 INFO - PROCESS | 1656 | __startTimestamp1491147964939__endTimestamp 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | ------- Summary: start ------- 08:46:04 INFO - PROCESS | 1656 | Number of tests: 14 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:124.50 Median:116.00 stddev:19.55 (16.9%) stddev-sans-first:20.54 08:46:04 INFO - PROCESS | 1656 | Values: 117.0 115.0 114.0 114.0 125.0 171.0 148.0 114.0 115.0 112.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:134.50 stddev:27.87 (20.7%) stddev-sans-first:24.16 08:46:04 INFO - PROCESS | 1656 | Values: 173.0 95.0 122.0 176.0 141.0 109.0 111.0 108.0 128.0 110.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.64 (0.9%) stddev-sans-first:1.51 08:46:04 INFO - PROCESS | 1656 | Values: 186.0 183.0 183.0 184.0 183.0 185.0 182.0 186.0 184.0 181.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:68.00 Median:63.50 stddev:11.04 (17.4%) stddev-sans-first:10.48 08:46:04 INFO - PROCESS | 1656 | Values: 82.0 60.0 63.0 91.0 64.0 60.0 63.0 61.0 76.0 60.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:76.50 stddev:9.07 (11.8%) stddev-sans-first:8.26 08:46:04 INFO - PROCESS | 1656 | Values: 89.0 71.0 89.0 70.0 69.0 68.0 82.0 68.0 68.0 84.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 08:46:04 INFO - PROCESS | 1656 | Values: 86.0 85.0 86.0 85.0 87.0 86.0 86.0 87.0 87.0 86.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:94.50 stddev:1.81 (1.9%) stddev-sans-first:1.80 08:46:04 INFO - PROCESS | 1656 | Values: 93.0 94.0 95.0 98.0 94.0 94.0 95.0 98.0 93.0 94.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 08:46:04 INFO - PROCESS | 1656 | Values: 84.0 85.0 82.0 83.0 85.0 84.0 86.0 85.0 86.0 86.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:63.50 stddev:1.99 (3.1%) stddev-sans-first:2.00 08:46:04 INFO - PROCESS | 1656 | Values: 64.0 60.0 59.0 60.0 61.0 63.0 63.0 64.0 64.0 64.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:11.55 (17.2%) stddev-sans-first:12.24 08:46:04 INFO - PROCESS | 1656 | Values: 65.0 64.0 57.0 53.0 55.0 69.0 81.0 82.0 82.0 57.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:87.50 stddev:7.95 (9.1%) stddev-sans-first:8.23 08:46:04 INFO - PROCESS | 1656 | Values: 85.0 91.0 99.0 84.0 87.0 85.0 88.0 82.0 90.0 108.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:143.00 stddev:9.01 (6.3%) stddev-sans-first:9.51 08:46:04 INFO - PROCESS | 1656 | Values: 144.0 123.0 136.0 137.0 140.0 142.0 147.0 152.0 155.0 139.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:165.50 stddev:17.64 (10.7%) stddev-sans-first:18.71 08:46:04 INFO - PROCESS | 1656 | Values: 169.0 166.0 165.0 167.0 163.0 164.0 163.0 164.0 161.0 220.0 08:46:04 INFO - PROCESS | 1656 | 08:46:04 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 08:46:04 INFO - PROCESS | 1656 | Values: 65.0 65.0 68.0 66.0 66.0 67.0 65.0 66.0 64.0 64.0 08:46:04 INFO - PROCESS | 1656 | -------- Summary: end -------- 08:46:04 INFO - PROCESS | 1656 | 08:46:05 INFO - TEST-INFO | 1656: exit 0 08:46:05 INFO - TEST-OK | kraken | took 59910ms 08:46:05 INFO - SUITE-END | took 1180s 08:46:06 INFO - Completed test suite (00:19:40) 08:46:06 INFO - javascript benchmark 08:46:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7590.518802478624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3394.049666093494, 3397.4394224952885, 3404.3021180657965, 3414.829258537073, 3451.102713294543, 5552.361478429982, 5749.683767392792, 5916.55625828063, 5928.05151175812, 5942.316633587139, 5856.414358564141, 5889.646621202731, 5946.5242780577555, 5951.404859514047, 5953.0, 4407.889802754925, 5322.414534401213, 5364.865878353034, 5425.810096646618, 5483.725813709319, 5291.3650361956425, 5294.52349288564, 5320.308359913206, 5405.810796622119, 5470.671759694411, 5429.077056900317, 5468.835934921959, 5469.206964990074, 5473.589480788937, 5510.448955104497, 5438.972805135989, 5445.700486473243, 5467.425920278373, 5470.8085217017215, 5471.50756431923, 5213.191955246943, 5224.373075230958, 5315.123004704219, 5426.31419323725, 5440.483154100354, 5770.451807078321, 5784.045632470637, 5787.855303617401, 5795.478406943354, 5809.070548712186, 6290.056491526262, 6353.078803573502, 6360.268569114564, 6378.712957916859, 6380.744770209186, 5987.341392446828, 6428.582142160744, 6445.51658625605, 6450.258220304678, 6450.419462248373, 5812.970935145382, 6029.336772954972, 6124.35694252106, 6133.6319820810895, 6134.877302453926, 6343.0, 6369.71336289868, 6411.326810684905, 6447.3552644735155, 6478.902816457757, 6297.811065668037, 6360.395762402564, 6364.045393190966, 6371.33101024395, 6372.299047104815, 6408.0, 6418.679066046772, 6424.903626445607, 6451.806445806634, 6459.354064593503, 5901.616394934402, 6192.8761424771255, 6264.906026409608, 6268.341824108494, 6374.872502549923, 6345.0, 6350.237971443364, 6362.840928976812, 6363.427291543783, 6367.299597044322, 5088.592912566985, 5089.51649593288, 5091.872703182376, 5094.872628184251, 5098.923516147261, 4500.302453119772, 4515.0, 4551.772411379484, 4556.70381425213, 4566.771661416916, 4804.759762011955, 5674.602777805597, 5718.799842005593, 5790.073588225948, 5800.39095894925, 6293.181886354744, 6331.0, 6357.618542887441, 6363.459105975951, 6406.807795766134, 5935.910961335583, 5942.286925568959, 5948.583599148104, 5956.702164891738, 5987.760489580455, 5569.944300556943, 5618.887622247532, 5626.634268772516, 5643.40744221859, 5651.886962260814, 6299.748010079546, 6321.5258855586935, 6367.044943258548, 6552.3775241352, 6584.374484423972, 6296.181496405438, 6374.330695276929, 6382.457491113121, 6398.808035758934, 6400.615963042233, 6473.546851720334, 6533.314002029909, 6549.508786840911, 6554.868902622016, 6568.244651865097, 5518.834434966958, 6239.845628558731, 6386.361363863576, 6387.744490220525, 6401.487880969418, 6139.1098290746695, 6211.534134939988, 6311.179546658905, 6352.714127864349, 6375.6812159392775, 6299.86602411552, 6309.305976342691, 6312.116303717575, 6317.084022816574, 6333.619982801047, 6222.968885155546, 6228.844278892882, 6294.402031806971, 6297.937020629735, 6326.6520341381665, 5940.702964851826, 5948.8810223796145, 5953.702314884152, 5980.700964951648, 5985.0723137911955, 6188.102725104744, 6223.813285601439, 6236.594621349598, 6341.714622841891, 6346.904796427965, 6202.2867370253, 6206.193194884636, 6210.658413787285, 6214.9067763984485, 6254.499640028877], "value": 5842.327976974854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.4473868292196, 816.1226681317585, 873.4453621950064, 897.4929165021758, 899.1233547291388, 39569.0, 40773.79613101934, 40960.18079638409, 40993.0, 43568.0, 42790.78604606973, 42907.3563896541, 43002.35496467556, 43018.569814301845, 43047.78476107615, 7413.073365829271, 9268.07319268073, 9438.197753190987, 9460.290478214127, 9468.384555003937, 7533.698652053911, 10910.0, 11140.777184456307, 11298.830517542243, 11312.547498100066, 11163.553457861717, 11164.385958772264, 11166.832497512503, 11168.106551475903, 11170.888291117066, 7302.269773022708, 11109.166812489095, 11113.277636953571, 11122.666320010332, 11146.498407571638, 7506.211847756016, 7527.698892044312, 7544.0569928758905, 7545.547267163988, 10745.301555398873, 33454.498182527284, 40730.796346018375, 40854.591454085676, 40855.38716919249, 40880.38679419811, 3798.1264309209037, 3828.7319887607878, 3842.5773164951834, 3866.4393662919, 3938.2911076006308, 23376.18183363591, 28803.56794648082, 29143.562846557317, 29203.85398073017, 29604.259893502618, 3079.414911166871, 3123.2660324823646, 3157.2106973256687, 3160.0, 3170.0, 328322.0, 330958.0, 331121.0, 331954.0, 332637.0, 42709.35935960963, 43317.78341108337, 53847.92304153895, 53904.46095539073, 53956.46043539593, 46490.53509464862, 46544.0, 46633.76683116631, 46668.7666561665, 46688.533114669095, 14360.56918292453, 14874.479393221185, 15255.313510892036, 15363.0, 15371.615709607126, 12887.871121288854, 12919.677008074874, 12922.41849116792, 12924.612261632166, 12944.546940857024, 13103.737925241632, 13126.343682815821, 13150.802737958938, 13202.141860779018, 13286.867131328563, 4721.457032441244, 5561.499465048084, 5640.32316122068, 5647.774089036392, 5656.575756818255, 973.59595767757, 1079.266099052636, 1111.5498223219608, 1124.8368986496912, 1175.341808587194, 23277.3016809496, 25080.749192508207, 27287.590686139723, 27578.724212758018, 27664.308392290353, 968.7190714692802, 1067.2849191042021, 1105.1545567640762, 1160.4081918221768, 1191.7020744813797, 14014.439422423193, 14041.438342466392, 14177.015217869506, 14291.499797507038, 14396.064255823547, 495943.0, 496264.0, 497288.0, 497362.0, 497467.0, 59892.401075989554, 60014.699926500085, 60114.49713757104, 60123.39876601265, 60237.0, 1407.3596513586294, 1460.9123452592878, 1461.5834487171105, 1469.6619777451247, 1473.6978919321514, 26060.0, 26335.34161645974, 26427.735722642527, 26681.599776003764, 26866.59700104461, 50040.249396258354, 50077.998440030264, 50093.74953125211, 50121.0, 50137.0, 413924.0, 414875.7768633533, 415894.0, 418113.0, 418375.0, 27228.183154505397, 27661.031863885473, 30921.381572368875, 32927.83536082304, 33206.83396583002, 43393.78303108464, 44605.661830145145, 45895.623131306114, 46267.074658507314, 46270.30594541152, 29346.55980160342, 30284.0, 30343.0, 30789.0, 31955.68044319527, 30690.23274418068, 30816.0, 31244.531332029583, 31900.0, 32212.35575288434, 29861.850690746407, 36890.63109368872, 37597.81201093977, 37621.62378376291, 37665.81167094257, 30159.69840301569, 30260.394792103594, 30327.545086824157, 31234.21914452157, 31342.843285784336, 23719.644205337278, 24775.50448991046, 24926.626100608144, 25544.872275638503, 25818.0], "value": 18802.16438414544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.67769090500343, 411.88995656705174, 412.5358971157448, 430.63396113303685, 437.549324196078, 13042.413091410886, 14809.703805923875, 21014.474638134034, 21078.89460552695, 21558.029888655008, 21782.237621683245, 22163.667544986798, 22246.666300005512, 22523.662145067836, 22704.88647556764, 6505.056766768816, 6619.834504137399, 6723.966380168093, 6784.151981002375, 6796.694148763293, 5589.35722391924, 6423.197100362455, 6745.898811517831, 6748.865022699543, 6827.726890924357, 6819.283975182609, 6824.965875170617, 6829.965850170767, 6839.0425340452375, 6848.246692863781, 6570.704318305688, 6724.092247546568, 6746.359095885883, 6807.523473356867, 6817.113775209215, 6599.967000164968, 6605.141331626905, 6610.438112760373, 6627.768028118992, 6671.633060181688, 25500.744992550022, 26060.86969565159, 26104.47589575421, 26300.079497217695, 26338.736612634013, 2894.2185609885423, 2914.4316858212655, 2944.764418846487, 2967.317516971087, 2975.8096761295437, 7243.89134162988, 7367.852642947111, 10801.459927003618, 14530.491432799907, 16087.0, 1979.3171355882341, 2006.2476571285767, 2010.6280338137344, 2035.6946458031266, 2036.134642776814, 136130.0, 139504.30247848696, 162646.0, 162879.0, 165546.0, 19670.901645491682, 20405.0, 20571.794282057286, 20574.794252057287, 20651.69022464664, 31692.841535792635, 32277.0, 32383.51424728584, 32418.02745917626, 32471.51292730611, 10198.235132365102, 10283.177345812317, 10547.683569492927, 10548.736281593021, 10651.467426628638, 8787.868181977148, 8788.428752131218, 8842.602082906285, 8966.910330896739, 8976.012638609878, 7677.500962437535, 7734.690612375442, 9327.0, 9327.647491113887, 9477.668281610111, 3378.9324213515592, 3942.2903877301787, 3997.137802866168, 4048.595140485928, 4057.3102572562734, 820.8440396324679, 846.552395403854, 880.5157163560017, 886.5301390263171, 897.8563429851192, 20241.49396265076, 21170.153193872073, 21171.047302871408, 21214.893925530272, 21276.468088297916, 915.3180880244261, 941.6421759731259, 944.6835310171169, 946.4132238012339, 964.6527250189926, 8684.0, 10605.681829545127, 11067.391293478775, 11074.224804263624, 11079.390633515233, 720350.0, 721602.0, 728245.0, 743499.0, 755819.0, 84443.0, 117608.99999999828, 146686.0, 147427.0, 152338.23830880775, 1246.2273390497949, 1269.270169652435, 1286.2411177405377, 1289.8065290206544, 1290.1356091418772, 17886.731699024785, 18569.16438760232, 19170.233190672774, 21169.0, 21213.469663258544, 66718.33281667315, 66843.66578167077, 67447.0, 68686.65656671685, 69034.0, 89946.0, 90966.05329949375, 91508.0, 92977.07022929683, 93628.53185734028, 11221.719457013314, 11704.414779260833, 11839.0, 11899.107566932342, 12065.638030859089, 12910.741785164431, 12918.289494077915, 12937.353132343533, 13292.202467851574, 13329.266890320738, 10814.783704325711, 11122.944385278022, 11134.27627204229, 11258.718532036764, 11361.602343917923, 10316.587336506756, 10413.0, 10450.0, 10639.840402394126, 10650.0, 10668.30656007357, 11388.772224555629, 11394.0, 11521.711957201138, 11772.764544709229, 11701.654309754147, 11775.470103845519, 11815.70460738454, 11974.64076077719, 12039.0, 10947.56209751633, 10963.287386319864, 11160.274582152135, 11276.32342059479, 11291.0], "value": 11325.252209513023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.7847101405805, 1544.5289186798022, 1566.8354822743604, 1589.2133393969982, 1595.3379347570763, 10478.318909270893, 11094.445277736111, 11133.1093512519, 11138.944305278472, 11162.274452160624, 10661.413622250773, 10856.674299771019, 10991.0, 11168.162387820905, 11184.217104802667, 2396.8561886286834, 2435.7929575986063, 2436.049940523197, 2436.8294219404647, 2439.1706819681303, 2317.582835089683, 2414.7826695597482, 2420.4311986683115, 2427.5751743444916, 2429.6962879640046, 1978.584497255578, 1982.8215460608542, 2398.5083057973075, 2412.9396765080837, 2426.648136020276, 1956.5891162855817, 2070.3995841206033, 2283.5432913417385, 2389.462370966536, 2396.8082553395775, 2386.05750728463, 2391.6128645385634, 2391.8086553075887, 2394.7485514021128, 2396.352984694123, 11109.72225694356, 11184.049355804766, 11194.38430886301, 11212.607558735486, 11276.097912167006, 5601.215829783833, 5708.372079071299, 5907.881842363128, 5920.585559010871, 5923.141144534018, 3394.96605033949, 3619.0771353305004, 3642.1440961374055, 3699.648533389324, 3703.6111208323277, 1121.7419993401481, 1185.5080141741253, 1192.0880526397314, 1198.3888217009387, 1218.9085818563553, 13685.726285474235, 14031.228282444461, 14309.28453577317, 15657.451989180325, 15685.372585096582, 4563.817447302071, 4711.222648263067, 4734.431868175772, 4737.431508219036, 4762.261849413347, 11951.04391648666, 11965.820512692317, 11972.700682483008, 11981.221220620806, 12010.219335743148, 4810.965642386904, 4998.075356059141, 5403.324584426947, 5773.6824474654295, 5784.913226301609, 4622.422197225347, 5065.468125846733, 5225.268462415265, 5225.3207083079715, 5229.607779416559, 3667.5965643779164, 3830.8467661293794, 3855.556610989716, 3898.766074035567, 3908.0620651043546, 1014.9238807089498, 1016.5476363018386, 1017.1862509991977, 1032.948352582368, 1035.4770840725537, 853.2832420766586, 923.8845144356956, 943.9669611563562, 954.3271993244746, 955.6225291010151, 6581.967090164614, 6658.667066646745, 6707.295733947963, 6837.111175547247, 6843.520953533205, 1005.9990309641806, 1039.8544203811473, 1041.8958104189671, 1060.8620879285643, 1086.9293495922739, 4206.26390381682, 4214.915701685949, 4220.514640816284, 4334.219840428753, 4346.304591265445, 13084.280364579849, 13647.0, 13678.0, 13690.110142840882, 13700.314984250748, 13094.934525327313, 13259.734805304033, 13581.932090339682, 13607.795883061763, 13704.65738356549, 8578.871316930252, 10082.949585252027, 10087.293889427816, 10270.870204277524, 10310.96890310963, 6532.216134063943, 6547.410733033859, 6577.638229897401, 6665.533412661067, 6706.161729783777, 12183.147179697336, 12201.69495762613, 12206.02351811835, 12398.070144739, 12435.93782031084, 12560.623181304576, 12571.434285456993, 12594.181378210387, 12786.296753678636, 12793.488260469478, 7175.425965922609, 7202.279772022755, 8436.789080273042, 8579.65681372738, 8615.956920215609, 10364.326318789255, 10539.26225164231, 10646.467676616294, 10652.147828173882, 10653.0, 8714.064177502158, 8735.43219690718, 8737.344699147463, 8879.733607991771, 8977.910220897707, 8536.487810731376, 8543.316534677087, 8595.09751476111, 8608.440451370641, 8637.956810215908, 7737.806554836174, 7804.141544429995, 7944.324732397579, 7948.8807667886185, 7959.204079591995, 5933.080372542263, 6002.219711437485, 6071.392860713893, 6072.453479186895, 6109.0, 5728.398518155534, 5890.087036509348, 6008.24896887889, 6035.9094613579955, 6105.023196288573], "value": 5101.608513856675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.4792863667903, 372.0772484239087, 379.44979779319993, 381.7556763671251, 383.20676200265444, 4297.785110744466, 4331.963976930841, 4851.63612729045, 4897.338859253995, 4918.409790825097, 4797.376341075664, 4869.4887036861155, 4871.196252618313, 4871.537203965627, 4884.096442158194, 3896.7272290939572, 3913.493305077551, 3957.35769655594, 3988.660963818079, 4031.3751368537924, 3293.851776670044, 3611.2665920358113, 3929.9978505481063, 4023.7786921719294, 4057.3711074783455, 3898.961010389902, 4012.157446936132, 4044.8179831907637, 4060.9086320544793, 4076.32740597801, 3448.9310213795834, 3522.6477352264824, 3869.32286849803, 4094.6928980326447, 4111.239420707164, 3106.673799251069, 3547.609762926076, 3722.7394082414244, 3751.4372844073337, 3798.2023775007283, 4297.205017071852, 4382.877823536753, 4785.976070119627, 4826.951730482685, 4829.932992549756, 4480.655803259009, 4729.219678753002, 4740.739259340735, 4788.377510923592, 4817.470078291385, 4874.805007799684, 4896.534829191221, 5021.5229553192385, 5208.739563021872, 5280.735963201863, 3919.7256192066566, 4227.365895115758, 4233.428487154226, 4263.509696384894, 4278.72188307759, 5069.580517455119, 5242.580593552545, 5335.9466405336225, 5542.362628297757, 5552.555795536387, 3620.891373258754, 3901.258760835489, 4306.74159550428, 4306.956930430718, 4347.673924455678, 3906.570277269498, 4265.0, 4424.7123936944, 4432.229856339788, 4443.134178454879, 4079.551249362568, 4638.698484598558, 4749.572538471554, 4756.669232076327, 4768.356271903318, 4144.854930077433, 4516.570925762047, 5103.770330335144, 5283.471652834686, 5334.253204551366, 1316.7827308494184, 1491.8955673102778, 1492.6865358274667, 1519.9240037998056, 1529.0061460051056, 1082.86464191976, 1122.9943850280697, 1139.5954436175039, 1142.8971392574708, 1157.9942100289445, 4467.168460931002, 4891.608671306287, 4942.233953737176, 4946.554810067111, 4976.825811096594, 4968.453470118284, 5419.620626556182, 5471.23402723619, 5473.890522189534, 5496.47162305336, 4108.096218831853, 4534.877914814973, 4640.303954406799, 4893.755312234374, 4930.359053323117, 2449.534588428193, 2489.514544663773, 2640.603909413603, 2716.858919253918, 2796.4267325198284, 4675.368825208621, 5050.368703912011, 5454.045542030129, 5567.109262517978, 5581.6930068846605, 4087.570805065485, 5107.67200527858, 5251.4485978972425, 5335.653182543122, 5374.464301769184, 5265.894682106336, 5485.780568777284, 5487.6981766002455, 5503.7798488061635, 5660.433956604306, 4797.968436786107, 5189.431231540411, 5404.945950540601, 5418.02008895114, 5431.83704488866, 4584.441289961429, 4928.457869634409, 5040.697558146523, 5112.539871411442, 5347.5721942243745, 5462.644928079662, 5534.363548192009, 5560.2493663356545, 5570.805021824217, 5601.551875849841, 4288.828446862215, 4327.805248763751, 4333.631641310524, 4389.912201756011, 4392.913366151052, 4426.269665505156, 4440.289553671397, 4491.439879268785, 5024.6231532634465, 5060.797568097235, 4273.358996150602, 4713.363695901009, 4962.0, 5216.452272511484, 5221.869453263699, 4491.833257553351, 5138.871528211825, 5172.482751724798, 5199.66202196856, 5218.634695571273, 4065.8780236592947, 4503.581371867851, 4885.7801398937845, 5072.619553533426, 5086.491350864884, 4712.599429048432, 4973.51853702417, 5180.430152683277, 5203.661761985459, 5205.843824685266, 4346.6088052075465, 4510.50384457716, 4861.222204447272, 5019.992003198604, 5069.493050694901], "value": 3986.7723853176117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.7473447457204, 714.1715609892526, 736.0982796074805, 784.882267659851, 833.9249467547921, 15240.695186096285, 15971.281292341844, 16079.437219697313, 16125.838741612595, 16179.75730364044, 12214.511419543207, 13993.720125597481, 14890.0, 14895.404183832634, 14909.92545037276, 917.289100946765, 926.735880274122, 950.6150009246267, 950.9572069256866, 952.6570434643522, 920.7974245665943, 939.1829108675462, 945.5508633399149, 948.1135138645354, 960.6397600899662, 998.1266391907081, 1000.9199264058894, 1000.9949950250239, 1002.959881604735, 1003.7540802503397, 995.6963126246492, 998.0418797953973, 1000.6647772996018, 1000.7348052766023, 1002.5939494504664, 741.7366834773632, 741.9406447484188, 742.0464702856857, 742.1057625561186, 742.6954948471155, 15307.770383444256, 15725.213739313103, 15740.291686874118, 16056.0, 16248.75626865598, 11622.244554103956, 12025.458854351575, 14302.92848535761, 14383.856161438356, 14405.279736013263, 11315.0, 11606.709832254177, 11624.128190385754, 12083.637490875288, 12464.252144871336, 3656.117617742337, 3717.237966216946, 3728.0493474164186, 3818.6563209311016, 3840.9807950960067, 90499.09500904972, 98188.0, 104877.0, 105172.47413762883, 107361.46319268354, 10974.341539507655, 10983.780324393467, 11042.723931901606, 11650.359230242419, 11704.590339338083, 21695.674564881225, 21883.12467501314, 22156.781377024417, 22315.218967336066, 22347.882605869643, 7836.725714599962, 7907.248811363026, 7988.560629165451, 8063.879041814377, 8081.23228293323, 4180.209956246691, 4224.640905523065, 4294.82820687169, 4298.0, 4370.672199585044, 3370.898873033813, 3429.879954201641, 3440.1571614953996, 3470.73969452287, 3477.51314815926, 603.0110618585524, 604.5586721693101, 619.9938000619936, 624.0483263023834, 624.9093881387173, 660.3693472733528, 668.5654324688991, 683.4054372695787, 688.5145972089765, 727.3708242370311, 9807.754806129904, 9908.554115064839, 10070.748231294276, 10277.331973421704, 10700.625478108228, 558.6536347464516, 585.1369230385147, 609.5123900879279, 651.00396393518, 665.7802925034727, 4635.466921304026, 5093.414257360451, 5097.643164978416, 5101.846944591668, 5102.617303702237, 97490.02509974952, 99016.0, 99103.50448247713, 100384.49807751061, 101792.98207017835, 89471.55264223638, 89562.55218723865, 91404.0, 91802.0, 92038.61942070874, 75073.24926750772, 75329.0, 76876.61561692155, 77070.6146469264, 77932.0, 9753.366031207948, 9793.951030244803, 9803.264755143251, 9808.705738827846, 9816.80366392654, 33775.0, 38325.4251186238, 49483.50516494933, 49575.50424495709, 50573.98852023012, 60007.399926001926, 61115.38884611097, 61241.69379153076, 61808.07287890595, 62143.06785398132, 12781.872181278068, 12805.615831525069, 13115.344232788513, 13221.0, 13270.469181232642, 14295.57113286603, 14539.20034398076, 14733.116013039253, 15023.549293521211, 15048.097114173184, 13822.017583900339, 14131.64670883236, 14142.154556305984, 14277.28613569338, 14527.0, 13736.519221827188, 14059.00194091857, 14087.295635217994, 14360.85639143637, 14366.209858457885, 13157.210567365988, 13221.867781322064, 13690.315484225948, 13806.17162970225, 14145.151290922578, 9661.323707340418, 10194.490275486047, 10295.382277063101, 10350.327228730108, 10421.166306695597, 9104.0, 9285.582148803454, 10778.407187604756, 11503.252288601549, 11736.589219377282], "value": 7558.133004253474, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 114.0, 114.0, 125.0, 171.0, 148.0, 114.0, 115.0, 112.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 95.0, 122.0, 176.0, 141.0, 109.0, 111.0, 108.0, 128.0, 110.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 183.0, 184.0, 183.0, 185.0, 182.0, 186.0, 184.0, 181.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 63.0, 91.0, 64.0, 60.0, 63.0, 61.0, 76.0, 60.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 89.0, 70.0, 69.0, 68.0, 82.0, 68.0, 68.0, 84.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 87.0, 86.0, 86.0, 87.0, 87.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 98.0, 94.0, 94.0, 95.0, 98.0, 93.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 83.0, 85.0, 84.0, 86.0, 85.0, 86.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 59.0, 60.0, 61.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 57.0, 53.0, 55.0, 69.0, 81.0, 82.0, 82.0, 57.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 99.0, 84.0, 87.0, 85.0, 88.0, 82.0, 90.0, 108.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 136.0, 137.0, 140.0, 142.0, 147.0, 152.0, 155.0, 139.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 165.0, 167.0, 163.0, 164.0, 163.0, 164.0, 161.0, 220.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 68.0, 66.0, 66.0, 67.0, 65.0, 66.0, 64.0, 64.0], "value": 65.6, "unit": "score"}]}]} 08:46:06 INFO - Return code: 0 08:46:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:46:06 ERROR - # TBPL SUCCESS # 08:46:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:46:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:46:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:46:06 INFO - 2017-04-02 08:46:06.280 screenresolution[1660:14202] starting screenresolution argv=screenresolution get 08:46:06 INFO - 2017-04-02 08:46:06.283 screenresolution[1660:14202] Display 0: 1600x1200x32@60 08:46:06 INFO - 2017-04-02 08:46:06.290 screenresolution[1661:14204] starting screenresolution argv=screenresolution list 08:46:06 INFO - Available Modes on Display 0 08:46:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:46:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:46:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:46:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:06 INFO - Intel Iris: 08:46:06 INFO - Chipset Model: Intel Iris 08:46:06 INFO - Type: GPU 08:46:06 INFO - Bus: Built-In 08:46:06 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:06 INFO - Vendor: Intel (0x8086) 08:46:06 INFO - Device ID: 0x0a2e 08:46:06 INFO - Revision ID: 0x0009 08:46:06 INFO - Displays: 08:46:06 INFO - Display: 08:46:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:06 INFO - Display Serial Number: 1600x1200 60 08:46:06 INFO - Main Display: Yes 08:46:06 INFO - Mirror: Off 08:46:06 INFO - Online: Yes 08:46:06 INFO - Rotation: Supported 08:46:06 INFO - Return code: 0 08:46:06 INFO - Running post-action listener: _resource_record_post_action 08:46:06 INFO - [mozharness: 2017-04-02 15:46:06.531802Z] Finished run-tests step (success) 08:46:06 INFO - Running post-run listener: _resource_record_post_run 08:46:06 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 45076480; Write bytes: 521089024; Read time: 465; Write time: 1930 08:46:06 INFO - TinderboxPrint: CPU usage
53.7% 08:46:06 INFO - TinderboxPrint: I/O read bytes / time
45,076,480 / 465 08:46:06 INFO - TinderboxPrint: I/O write bytes / time
521,089,024 / 1,930 08:46:06 INFO - TinderboxPrint: CPU idle
2,226.7 (46.3%) 08:46:06 INFO - TinderboxPrint: CPU system
955.5 (19.9%) 08:46:06 INFO - TinderboxPrint: CPU user
1,623.6 (33.8%) 08:46:06 INFO - TinderboxPrint: Swap in / out
241,831,936 / 0 08:46:06 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203725312; Write bytes: 199192576; Read time: 15617; Write time: 390 08:46:06 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 43106304; Write bytes: 311054336; Read time: 444; Write time: 1511 08:46:07 INFO - Running post-run listener: _upload_blobber_files 08:46:07 INFO - Blob upload gear active. 08:46:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:46:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:46:07 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'] 08:46:07 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 08:46:07 INFO - (blobuploader) - INFO - Open directory for files ... 08:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:08 INFO - (blobuploader) - INFO - Done attempting. 08:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:09 INFO - (blobuploader) - INFO - Done attempting. 08:46:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:46:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:46:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:10 INFO - (blobuploader) - INFO - Done attempting. 08:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:12 INFO - (blobuploader) - INFO - Done attempting. 08:46:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:46:12 INFO - Return code: 0 08:46:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:46:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:46:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e69d3acba442c37a3110bf264d920676750f55856474395e9480f0f87a3cea90cc4853e7f704f1b1698be5c0fa60b363513504ba2d2b63040e2132fd2b7c0212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73dd3e284dbb85ef4bdc91923a890d6cf76ca1940d2b14783609ef51b5c1587a384a55d961e7e53b7e68e025c67d9081382c41cab5bfbe8bd1ebf70d75f87659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645bad29d5c50f2354a20e0729c06d282ee1a73bb3e36720a8037e3486d59f46529afcad4513bbc9e44e94735c20ba28c5f802cb26397ba0978fa291e6899d19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21d6326592f9002181a4da619ac74b5f54eed966ba61885fd4f9ad54612f4a558badd2f5fbe046dcbadb655ab95a9b4939e4a05ca9ad39aa989827cea1ae1d47"} 08:46:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:46:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:46:12 INFO - Contents: 08:46:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e69d3acba442c37a3110bf264d920676750f55856474395e9480f0f87a3cea90cc4853e7f704f1b1698be5c0fa60b363513504ba2d2b63040e2132fd2b7c0212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73dd3e284dbb85ef4bdc91923a890d6cf76ca1940d2b14783609ef51b5c1587a384a55d961e7e53b7e68e025c67d9081382c41cab5bfbe8bd1ebf70d75f87659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645bad29d5c50f2354a20e0729c06d282ee1a73bb3e36720a8037e3486d59f46529afcad4513bbc9e44e94735c20ba28c5f802cb26397ba0978fa291e6899d19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21d6326592f9002181a4da619ac74b5f54eed966ba61885fd4f9ad54612f4a558badd2f5fbe046dcbadb655ab95a9b4939e4a05ca9ad39aa989827cea1ae1d47"} 08:46:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:46:12 INFO - Copying logs to upload dir... 08:46:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:46:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.243902 ========= master_lag: 2.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-02 08:46:14.261428) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 08:46:14.265365) ========= 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.fMTYcvyy8s/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.1IGYGVubxy/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/e69d3acba442c37a3110bf264d920676750f55856474395e9480f0f87a3cea90cc4853e7f704f1b1698be5c0fa60b363513504ba2d2b63040e2132fd2b7c0212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73dd3e284dbb85ef4bdc91923a890d6cf76ca1940d2b14783609ef51b5c1587a384a55d961e7e53b7e68e025c67d9081382c41cab5bfbe8bd1ebf70d75f87659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645bad29d5c50f2354a20e0729c06d282ee1a73bb3e36720a8037e3486d59f46529afcad4513bbc9e44e94735c20ba28c5f802cb26397ba0978fa291e6899d19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21d6326592f9002181a4da619ac74b5f54eed966ba61885fd4f9ad54612f4a558badd2f5fbe046dcbadb655ab95a9b4939e4a05ca9ad39aa989827cea1ae1d47"} build_url:https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/LIlxERyZQPerly5uhTgdPQ/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/e69d3acba442c37a3110bf264d920676750f55856474395e9480f0f87a3cea90cc4853e7f704f1b1698be5c0fa60b363513504ba2d2b63040e2132fd2b7c0212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73dd3e284dbb85ef4bdc91923a890d6cf76ca1940d2b14783609ef51b5c1587a384a55d961e7e53b7e68e025c67d9081382c41cab5bfbe8bd1ebf70d75f87659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645bad29d5c50f2354a20e0729c06d282ee1a73bb3e36720a8037e3486d59f46529afcad4513bbc9e44e94735c20ba28c5f802cb26397ba0978fa291e6899d19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21d6326592f9002181a4da619ac74b5f54eed966ba61885fd4f9ad54612f4a558badd2f5fbe046dcbadb655ab95a9b4939e4a05ca9ad39aa989827cea1ae1d47"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 08:46:14.305134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:46:14.305518) ========= 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.fMTYcvyy8s/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.1IGYGVubxy/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005121 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 08:46:14.353964) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 08:46:14.354280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 08:46:14.354602) ========= ========= Total master_lag: 2.24 =========