builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0097 starttime: 1485467881.1 results: success (0) buildid: 20170126131020 builduid: c7f6bc7d5e574cc7b762a8165d91fded revision: e35c1d17cc9ba97e680551fe291909fa0e2da96f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.098304) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.098787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.099094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.127129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.127541) ========= 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.cckyULmSGd/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.H6ehmMLhJ7/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-01-26 13:58:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.5M=0.001s 2017-01-26 13:58:01 (22.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128344 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.284362) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.284892) ========= 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.cckyULmSGd/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.H6ehmMLhJ7/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.026894 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.335619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:01.336134) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e35c1d17cc9ba97e680551fe291909fa0e2da96f --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 e35c1d17cc9ba97e680551fe291909fa0e2da96f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cckyULmSGd/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.H6ehmMLhJ7/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-01-26 13:58:01,438 truncating revision to first 12 chars 2017-01-26 13:58:01,438 Setting DEBUG logging. 2017-01-26 13:58:01,438 attempt 1/10 2017-01-26 13:58:01,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e35c1d17cc9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 13:58:02,050 unpacking tar archive at: mozilla-aurora-e35c1d17cc9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.875540 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:02.237405) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:02.237957) ========= script_repo_revision: e35c1d17cc9ba97e680551fe291909fa0e2da96f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:02.238590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:02.239071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 13:58:02.262041) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-26 13:58:02.262514) ========= /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.cckyULmSGd/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.H6ehmMLhJ7/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:02 INFO - MultiFileLogger online at 20170126 13:58:02 in /builds/slave/test 13:58:02 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 13:58:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:58:02 INFO - {'append_to_log': False, 13:58:02 INFO - 'base_work_dir': '/builds/slave/test', 13:58:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:58:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:58:02 INFO - 'branch': 'Mozilla-Aurora', 13:58:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:02 INFO - 'config_files': ('talos/mac_config.py',), 13:58:02 INFO - 'default_actions': ('clobber', 13:58:02 INFO - 'read-buildbot-config', 13:58:02 INFO - 'download-and-extract', 13:58:02 INFO - 'populate-webroot', 13:58:02 INFO - 'create-virtualenv', 13:58:02 INFO - 'install', 13:58:02 INFO - 'run-tests'), 13:58:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:02 INFO - 'download_minidump_stackwalk': True, 13:58:02 INFO - 'download_symbols': 'ondemand', 13:58:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:02 INFO - 'installer_path': 'installer.exe', 13:58:02 INFO - 'log_level': 'info', 13:58:02 INFO - 'log_name': 'talos', 13:58:02 INFO - 'log_to_console': True, 13:58:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:58:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:58:02 INFO - 'opt_config_files': (), 13:58:02 INFO - 'pip_index': False, 13:58:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:02 INFO - 'cmd': ('bash', 13:58:02 INFO - '-c', 13:58:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:02 INFO - 'enabled': True, 13:58:02 INFO - 'halt_on_failure': False, 13:58:02 INFO - 'name': 'check_screen_resolution'},), 13:58:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:02 INFO - 'cmd': ('bash', 13:58:02 INFO - '-c', 13:58:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:02 INFO - 'enabled': True, 13:58:02 INFO - 'halt_on_failure': False, 13:58:02 INFO - 'name': 'check_screen_resolution'},), 13:58:02 INFO - 'run_cmd_checks_enabled': True, 13:58:02 INFO - 'sps_profile': False, 13:58:02 INFO - 'sps_profile_interval': 0, 13:58:02 INFO - 'suite': 'dromaeojs', 13:58:02 INFO - 'system_bits': '32', 13:58:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:02 INFO - 'title': 't-yosemite-r7-0097', 13:58:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:02 INFO - 'use_talos_json': True, 13:58:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:58:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:02 INFO - 'work_dir': 'build'} 13:58:02 INFO - [mozharness: 2017-01-26 21:58:02.473647Z] Running clobber step. 13:58:02 INFO - Running pre-action listener: _resource_record_pre_action 13:58:02 INFO - Running main action method: clobber 13:58:02 INFO - rmtree: /builds/slave/test/build 13:58:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:58:04 INFO - Running post-action listener: _resource_record_post_action 13:58:04 INFO - [mozharness: 2017-01-26 21:58:04.990891Z] Finished clobber step (success) 13:58:04 INFO - [mozharness: 2017-01-26 21:58:04.991003Z] Running read-buildbot-config step. 13:58:04 INFO - Running pre-action listener: _resource_record_pre_action 13:58:04 INFO - Running main action method: read_buildbot_config 13:58:04 INFO - Using buildbot properties: 13:58:04 INFO - { 13:58:04 INFO - "project": "", 13:58:04 INFO - "product": "firefox", 13:58:04 INFO - "script_repo_revision": "production", 13:58:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:58:04 INFO - "repository": "", 13:58:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:58:04 INFO - "buildid": "20170126131020", 13:58:04 INFO - "pgo_build": "False", 13:58:04 INFO - "basedir": "/builds/slave/test", 13:58:04 INFO - "buildnumber": 47, 13:58:04 INFO - "slavename": "t-yosemite-r7-0097", 13:58:04 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:58:04 INFO - "platform": "yosemite_r7", 13:58:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:58:04 INFO - "branch": "mozilla-aurora", 13:58:04 INFO - "repo_path": "releases/mozilla-aurora", 13:58:04 INFO - "revision": "e35c1d17cc9ba97e680551fe291909fa0e2da96f", 13:58:04 INFO - "stage_platform": "macosx64", 13:58:04 INFO - "builduid": "c7f6bc7d5e574cc7b762a8165d91fded", 13:58:04 INFO - "slavebuilddir": "test" 13:58:04 INFO - } 13:58:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 13:58:04 INFO - Running post-action listener: _resource_record_post_action 13:58:04 INFO - [mozharness: 2017-01-26 21:58:04.994014Z] Finished read-buildbot-config step (success) 13:58:04 INFO - [mozharness: 2017-01-26 21:58:04.994147Z] Running download-and-extract step. 13:58:04 INFO - Running pre-action listener: _resource_record_pre_action 13:58:04 INFO - Running main action method: download_and_extract 13:58:04 INFO - mkdir: /builds/slave/test/build/tests 13:58: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')]} 13:58:04 INFO - trying https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 13:58:04 INFO - Downloading https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 13:58:06 INFO - Downloaded 1199 bytes. 13:58:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:58:06 INFO - Using the following test package requirements: 13:58:06 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:58:06 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 13:58:06 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 13:58:06 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'jsshell-mac.zip'], 13:58:06 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 13:58:06 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:58:06 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 13:58:06 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 13:58:06 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 13:58:06 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:58:06 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 13:58:06 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:58:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:58:06 INFO - Fetch https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:58:07 INFO - Expected file size: 16350001 13:58:07 INFO - Obtained file size: 16350001 13:58:13 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:58:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:58:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:58:13 INFO - Fetch https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:58:14 INFO - Expected file size: 16350001 13:58:14 INFO - Obtained file size: 16350001 13:58:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 13:58:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:58:21 INFO - Fetch https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 13:58:21 INFO - Expected file size: 14403485 13:58:21 INFO - Obtained file size: 14403485 13:58:22 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')]} 13:58:22 INFO - trying https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:58:22 INFO - Downloading https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 13:58:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 13:58:24 INFO - Downloaded 73895970 bytes. 13:58:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:58:24 INFO - mkdir: /builds/slave/test/properties 13:58:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:58:24 INFO - Writing to file /builds/slave/test/properties/build_url 13:58:24 INFO - Contents: 13:58:24 INFO - build_url:https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:58:25 INFO - Running post-action listener: _resource_record_post_action 13:58:25 INFO - Running post-action listener: set_extra_try_arguments 13:58:25 INFO - [mozharness: 2017-01-26 21:58:25.061803Z] Finished download-and-extract step (success) 13:58:25 INFO - [mozharness: 2017-01-26 21:58:25.061949Z] Running populate-webroot step. 13:58:25 INFO - Running pre-action listener: _resource_record_pre_action 13:58:25 INFO - Running main action method: populate_webroot 13:58:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:25 INFO - '--tppagecycles', 13:58:25 INFO - '7'], 13:58:25 INFO - 'tests': ['tsvgm']}}, 13:58:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:58:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:58:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:58:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:58:25 INFO - 'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:58:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:58:25 INFO - 'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['damp', 'tps']}, 13:58:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:58:25 INFO - 'tests': ['damp', 'tps']}, 13:58:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['dromaeo_dom']}, 13:58:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['basic_compositor_video']}, 13:58:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:58:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['a11yr', 13:58:25 INFO - 'ts_paint', 13:58:25 INFO - 'tpaint', 13:58:25 INFO - 'sessionrestore', 13:58:25 INFO - 'sessionrestore_no_auto_restore', 13:58:25 INFO - 'tabpaint']}, 13:58:25 INFO - 'other-e10s': {'tests': ['a11yr', 13:58:25 INFO - 'ts_paint', 13:58:25 INFO - 'tpaint', 13:58:25 INFO - 'sessionrestore', 13:58:25 INFO - 'sessionrestore_no_auto_restore', 13:58:25 INFO - 'tabpaint']}, 13:58:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:58:25 INFO - 'ts_paint', 13:58:25 INFO - 'tpaint', 13:58:25 INFO - 'sessionrestore', 13:58:25 INFO - 'sessionrestore_no_auto_restore', 13:58:25 INFO - 'tabpaint']}, 13:58:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:58:25 INFO - 'ts_paint', 13:58:25 INFO - 'tpaint', 13:58:25 INFO - 'sessionrestore', 13:58:25 INFO - 'sessionrestore_no_auto_restore', 13:58:25 INFO - 'tabpaint']}, 13:58:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['a11yr', 13:58:25 INFO - 'ts_paint', 13:58:25 INFO - 'tpaint', 13:58:25 INFO - 'sessionrestore', 13:58:25 INFO - 'sessionrestore_no_auto_restore', 13:58:25 INFO - 'tabpaint']}, 13:58:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['a11yr', 13:58:25 INFO - 'ts_paint', 13:58:25 INFO - 'tpaint', 13:58:25 INFO - 'sessionrestore', 13:58:25 INFO - 'sessionrestore_no_auto_restore', 13:58:25 INFO - 'tabpaint']}, 13:58:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['tsvgx', 13:58:25 INFO - 'tsvgr_opacity', 13:58:25 INFO - 'tart', 13:58:25 INFO - 'tscrollx', 13:58:25 INFO - 'cart', 13:58:25 INFO - 'tsvg_static']}, 13:58:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:58:25 INFO - 'tsvgr_opacity', 13:58:25 INFO - 'tart', 13:58:25 INFO - 'tscrollx', 13:58:25 INFO - 'cart', 13:58:25 INFO - 'tsvg_static']}, 13:58:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:58:25 INFO - 'talos_options': ['--disable-e10s'], 13:58:25 INFO - 'tests': ['tp5o']}, 13:58:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:58:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:58:25 INFO - 'talos_options': ['--disable-e10s', 13:58:25 INFO - '--xperf_path', 13:58:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:25 INFO - 'tests': ['tp5n']}, 13:58:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:58:25 INFO - 'talos_options': ['--xperf_path', 13:58:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:25 INFO - 'tests': ['tp5n']}}, 13:58:25 INFO - 'talos.zip': {'path': '', 13:58:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:25 INFO - Running post-action listener: _resource_record_post_action 13:58:25 INFO - [mozharness: 2017-01-26 21:58:25.080361Z] Finished populate-webroot step (success) 13:58:25 INFO - [mozharness: 2017-01-26 21:58:25.080479Z] Running create-virtualenv step. 13:58:25 INFO - Running pre-action listener: _resource_record_pre_action 13:58:25 INFO - Running main action method: create_virtualenv 13:58:25 INFO - Creating virtualenv /builds/slave/test/build/venv 13:58:25 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 13:58:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:58:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:25 INFO - Using real prefix '/tools/python27' 13:58:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:58:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:28 INFO - Installing pip.................done. 13:58:28 INFO - Return code: 0 13:58:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:58:29 INFO - Reading from file tmpfile_stdout 13:58:29 INFO - Output received: 13:58:29 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) 13:58:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:29 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 13:58:29 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 13:58:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:29 INFO - 'HOME': '/Users/cltbld', 13:58:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:29 INFO - 'LOGNAME': 'cltbld', 13:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:29 INFO - 'MOZ_NO_REMOTE': '1', 13:58:29 INFO - 'NO_EM_RESTART': '1', 13:58:29 INFO - 'PAGER': '/bin/cat', 13:58:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:29 INFO - 'PWD': '/builds/slave/test', 13:58:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:29 INFO - 'SHELL': '/bin/bash', 13:58:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:29 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:29 INFO - 'USER': 'cltbld', 13:58:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:29 INFO - 'XPC_FLAGS': '0x0', 13:58:29 INFO - 'XPC_SERVICE_NAME': '0', 13:58:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:29 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 13:58:29 INFO - Cleaning up... 13:58:29 INFO - Return code: 0 13:58:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:29 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 13:58:29 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 13:58:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:29 INFO - 'HOME': '/Users/cltbld', 13:58:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:29 INFO - 'LOGNAME': 'cltbld', 13:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:29 INFO - 'MOZ_NO_REMOTE': '1', 13:58:29 INFO - 'NO_EM_RESTART': '1', 13:58:29 INFO - 'PAGER': '/bin/cat', 13:58:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:29 INFO - 'PWD': '/builds/slave/test', 13:58:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:29 INFO - 'SHELL': '/bin/bash', 13:58:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:29 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:29 INFO - 'USER': 'cltbld', 13:58:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:29 INFO - 'XPC_FLAGS': '0x0', 13:58:29 INFO - 'XPC_SERVICE_NAME': '0', 13:58:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:29 INFO - Downloading/unpacking psutil>=3.1.1 13:58:29 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 13:58:29 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 13:58:29 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 13:58:29 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 13:58:29 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 13:58:29 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 13:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:58:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:33 INFO - Installing collected packages: psutil 13:58:33 INFO - Running setup.py install for psutil 13:58:33 INFO - building 'psutil._psutil_osx' extension 13:58:33 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 13:58:33 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 13:58:33 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 13:58:34 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 13:58:34 INFO - building 'psutil._psutil_posix' extension 13:58:34 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 13:58:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:58:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:58:34 INFO - ^ 13:58:34 INFO - 1 warning generated. 13:58:34 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 13:58:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:34 INFO - Successfully installed psutil 13:58:34 INFO - Cleaning up... 13:58:34 INFO - Return code: 0 13:58:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:34 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:34 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 13:58:34 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 13:58:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:34 INFO - 'HOME': '/Users/cltbld', 13:58:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:34 INFO - 'LOGNAME': 'cltbld', 13:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:34 INFO - 'MOZ_NO_REMOTE': '1', 13:58:34 INFO - 'NO_EM_RESTART': '1', 13:58:34 INFO - 'PAGER': '/bin/cat', 13:58:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:34 INFO - 'PWD': '/builds/slave/test', 13:58:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:34 INFO - 'SHELL': '/bin/bash', 13:58:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:34 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:34 INFO - 'USER': 'cltbld', 13:58:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:34 INFO - 'XPC_FLAGS': '0x0', 13:58:34 INFO - 'XPC_SERVICE_NAME': '0', 13:58:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:58:34 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 13:58:34 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 13:58:34 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 13:58:34 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 13:58:34 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 13:58:34 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 13:58:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:58:37 INFO - Installing collected packages: mozsystemmonitor 13:58:37 INFO - Running setup.py install for mozsystemmonitor 13:58:37 INFO - Successfully installed mozsystemmonitor 13:58:37 INFO - Cleaning up... 13:58:37 INFO - Return code: 0 13:58:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:58:37 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')]} 13:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:37 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')]} 13:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:37 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:37 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 13:58:37 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 13:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:37 INFO - 'HOME': '/Users/cltbld', 13:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:37 INFO - 'LOGNAME': 'cltbld', 13:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:37 INFO - 'MOZ_NO_REMOTE': '1', 13:58:37 INFO - 'NO_EM_RESTART': '1', 13:58:37 INFO - 'PAGER': '/bin/cat', 13:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:37 INFO - 'PWD': '/builds/slave/test', 13:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:37 INFO - 'SHELL': '/bin/bash', 13:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:37 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:37 INFO - 'USER': 'cltbld', 13:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:37 INFO - 'XPC_FLAGS': '0x0', 13:58:37 INFO - 'XPC_SERVICE_NAME': '0', 13:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:37 INFO - Downloading/unpacking jsonschema==2.5.1 13:58:37 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 13:58:37 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 13:58:37 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 13:58:37 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 13:58:37 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 13:58:37 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 13:58:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:58:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:58:40 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 13:58:40 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 13:58:40 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 13:58:40 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 13:58:40 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 13:58:40 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 13:58:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:58:40 INFO - warning: no files found matching '*.txt' 13:58:40 INFO - no previously-included directories found matching 'build' 13:58:40 INFO - no previously-included directories found matching 'dist' 13:58:40 INFO - no previously-included directories found matching '.git*' 13:58:40 INFO - Installing collected packages: jsonschema, functools32 13:58:41 INFO - Running setup.py install for functools32 13:58:41 INFO - warning: no files found matching '*.txt' 13:58:41 INFO - no previously-included directories found matching 'build' 13:58:41 INFO - no previously-included directories found matching 'dist' 13:58:41 INFO - no previously-included directories found matching '.git*' 13:58:41 INFO - Successfully installed jsonschema functools32 13:58:41 INFO - Cleaning up... 13:58:41 INFO - Return code: 0 13:58:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:58: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')]} 13:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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')]} 13:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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', '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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:58: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 functools32==3.2.3-2 13:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:41 INFO - 'HOME': '/Users/cltbld', 13:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:41 INFO - 'LOGNAME': 'cltbld', 13:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:41 INFO - 'MOZ_NO_REMOTE': '1', 13:58:41 INFO - 'NO_EM_RESTART': '1', 13:58:41 INFO - 'PAGER': '/bin/cat', 13:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:41 INFO - 'PWD': '/builds/slave/test', 13:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:41 INFO - 'SHELL': '/bin/bash', 13:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:41 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:41 INFO - 'USER': 'cltbld', 13:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:41 INFO - 'XPC_FLAGS': '0x0', 13:58:41 INFO - 'XPC_SERVICE_NAME': '0', 13:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:58:41 INFO - Cleaning up... 13:58:41 INFO - Return code: 0 13:58:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:58: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')]} 13:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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')]} 13:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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', '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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:58: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 blobuploader==1.2.4 13:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:41 INFO - 'HOME': '/Users/cltbld', 13:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:41 INFO - 'LOGNAME': 'cltbld', 13:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:41 INFO - 'MOZ_NO_REMOTE': '1', 13:58:41 INFO - 'NO_EM_RESTART': '1', 13:58:41 INFO - 'PAGER': '/bin/cat', 13:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:41 INFO - 'PWD': '/builds/slave/test', 13:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:41 INFO - 'SHELL': '/bin/bash', 13:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:41 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:41 INFO - 'USER': 'cltbld', 13:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:41 INFO - 'XPC_FLAGS': '0x0', 13:58:41 INFO - 'XPC_SERVICE_NAME': '0', 13:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:44 INFO - Downloading blobuploader-1.2.4.tar.gz 13:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:58:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:58:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58:45 INFO - Downloading docopt-0.6.1.tar.gz 13:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:58:45 INFO - Installing collected packages: blobuploader, requests, docopt 13:58:45 INFO - Running setup.py install for blobuploader 13:58:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:58:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:58:45 INFO - Running setup.py install for requests 13:58:46 INFO - Running setup.py install for docopt 13:58:46 INFO - Successfully installed blobuploader requests docopt 13:58:46 INFO - Cleaning up... 13:58:46 INFO - Return code: 0 13:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:46 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:46 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 13:58:46 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 13:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:46 INFO - 'HOME': '/Users/cltbld', 13:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:46 INFO - 'LOGNAME': 'cltbld', 13:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:46 INFO - 'MOZ_NO_REMOTE': '1', 13:58:46 INFO - 'NO_EM_RESTART': '1', 13:58:46 INFO - 'PAGER': '/bin/cat', 13:58:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:46 INFO - 'PWD': '/builds/slave/test', 13:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:46 INFO - 'SHELL': '/bin/bash', 13:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:46 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:46 INFO - 'USER': 'cltbld', 13:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:46 INFO - 'XPC_FLAGS': '0x0', 13:58:46 INFO - 'XPC_SERVICE_NAME': '0', 13:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:46 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-S0kOP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FtwB9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-3gHAvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-W9BqOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Rp3jLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Bku5UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-vUranx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-NopOQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1ldzpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-yUPXoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:47 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-U_maS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:48 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-gnC4bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:48 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Rf6Mik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:48 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-yZAIKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:48 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-GK2CLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:48 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FwExkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:48 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-NkfB24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:48 INFO - Running setup.py install for manifestparser 13:58:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:58:48 INFO - Running setup.py install for mozcrash 13:58:48 INFO - Running setup.py install for mozdebug 13:58:49 INFO - Running setup.py install for mozdevice 13:58:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Running setup.py install for mozfile 13:58:49 INFO - Running setup.py install for mozhttpd 13:58:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Running setup.py install for mozinfo 13:58:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Running setup.py install for mozInstall 13:58:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:58:49 INFO - Running setup.py install for mozleak 13:58:50 INFO - Running setup.py install for mozlog 13:58:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:58:50 INFO - Running setup.py install for moznetwork 13:58:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:58:50 INFO - Running setup.py install for mozprocess 13:58:50 INFO - Running setup.py install for mozprofile 13:58:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:58:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:58:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:58:50 INFO - Running setup.py install for mozrunner 13:58:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:58:50 INFO - Running setup.py install for mozscreenshot 13:58:50 INFO - Running setup.py install for moztest 13:58:51 INFO - Running setup.py install for mozversion 13:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:51 INFO - Cleaning up... 13:58:51 INFO - Return code: 0 13:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:51 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')]} 13:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:51 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')]} 13:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:51 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:51 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 13:58:51 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 13:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:51 INFO - 'HOME': '/Users/cltbld', 13:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:51 INFO - 'LOGNAME': 'cltbld', 13:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:51 INFO - 'MOZ_NO_REMOTE': '1', 13:58:51 INFO - 'NO_EM_RESTART': '1', 13:58:51 INFO - 'PAGER': '/bin/cat', 13:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:51 INFO - 'PWD': '/builds/slave/test', 13:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:51 INFO - 'SHELL': '/bin/bash', 13:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:51 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:51 INFO - 'USER': 'cltbld', 13:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:51 INFO - 'XPC_FLAGS': '0x0', 13:58:51 INFO - 'XPC_SERVICE_NAME': '0', 13:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:51 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FOROEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:51 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)) 13:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:51 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QUKAJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:51 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)) 13:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:51 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-upuUkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:51 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)) 13:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:51 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-tYnRIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:51 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)) 13:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-a3yHvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-crV3AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-x97H65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-c6_jxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-OiOLbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-WMaBe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-msriOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-jYcwDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-pBuitU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:52 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)) 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:52 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-LU9Dyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:53 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)) 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:53 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-P9OJmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:53 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)) 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:53 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-qKkotU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:53 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)) 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:53 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-RnRNgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:53 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)) 13:58:53 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)) 13:58:53 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)) 13:58:53 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)) 13:58:53 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)) 13:58:53 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)) 13:58:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:55 INFO - Downloading blessings-1.6.tar.gz 13:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:56 INFO - Installing collected packages: blessings 13:58:56 INFO - Running setup.py install for blessings 13:58:56 INFO - Successfully installed blessings 13:58:56 INFO - Cleaning up... 13:58:56 INFO - Return code: 0 13:58:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:56 INFO - Reading from file tmpfile_stdout 13:58:56 INFO - Current package versions: 13:58:56 INFO - blessings == 1.6 13:58:56 INFO - blobuploader == 1.2.4 13:58:56 INFO - docopt == 0.6.1 13:58:56 INFO - functools32 == 3.2.3-2 13:58:56 INFO - jsonschema == 2.5.1 13:58:56 INFO - manifestparser == 1.1 13:58:56 INFO - mozInstall == 1.12 13:58:56 INFO - mozcrash == 1.0 13:58:56 INFO - mozdebug == 0.1 13:58:56 INFO - mozdevice == 0.49 13:58:56 INFO - mozfile == 1.2 13:58:56 INFO - mozhttpd == 0.7 13:58:56 INFO - mozinfo == 0.9 13:58:56 INFO - mozleak == 0.1 13:58:56 INFO - mozlog == 3.4 13:58:56 INFO - moznetwork == 0.27 13:58:56 INFO - mozprocess == 0.24 13:58:56 INFO - mozprofile == 0.28 13:58:56 INFO - mozrunner == 6.13 13:58:56 INFO - mozscreenshot == 0.1 13:58:56 INFO - mozsystemmonitor == 0.3 13:58:56 INFO - moztest == 0.8 13:58:56 INFO - mozversion == 1.4 13:58:56 INFO - psutil == 3.1.1 13:58:56 INFO - requests == 1.2.3 13:58:56 INFO - wsgiref == 0.1.2 13:58:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:56 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')]} 13:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:56 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')]} 13:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:57 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:57 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 13:58:57 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 13:58:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:57 INFO - 'HOME': '/Users/cltbld', 13:58:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:57 INFO - 'LOGNAME': 'cltbld', 13:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:57 INFO - 'MOZ_NO_REMOTE': '1', 13:58:57 INFO - 'NO_EM_RESTART': '1', 13:58:57 INFO - 'PAGER': '/bin/cat', 13:58:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:57 INFO - 'PWD': '/builds/slave/test', 13:58:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:57 INFO - 'SHELL': '/bin/bash', 13:58:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:57 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:57 INFO - 'USER': 'cltbld', 13:58:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:57 INFO - 'XPC_FLAGS': '0x0', 13:58:57 INFO - 'XPC_SERVICE_NAME': '0', 13:58:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 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)) 13:58:57 INFO - Cleaning up... 13:58:57 INFO - Return code: 0 13:58:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:58 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 0x1028e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd914c14c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, '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.cckyULmSGd/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.H6ehmMLhJ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 13:58:58 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 13:58:58 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 13:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:58 INFO - 'HOME': '/Users/cltbld', 13:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:58 INFO - 'LOGNAME': 'cltbld', 13:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:58 INFO - 'MOZ_NO_REMOTE': '1', 13:58:58 INFO - 'NO_EM_RESTART': '1', 13:58:58 INFO - 'PAGER': '/bin/cat', 13:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:58 INFO - 'PWD': '/builds/slave/test', 13:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:58 INFO - 'SHELL': '/bin/bash', 13:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:58:58 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:58 INFO - 'USER': 'cltbld', 13:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:58 INFO - 'XPC_FLAGS': '0x0', 13:58:58 INFO - 'XPC_SERVICE_NAME': '0', 13:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:58:58 INFO - Cleaning up... 13:58:58 INFO - Return code: 0 13:58:58 INFO - Running post-action listener: _resource_record_post_action 13:58:58 INFO - Running post-action listener: _start_resource_monitoring 13:58:58 INFO - Starting resource monitoring. 13:58:58 INFO - [mozharness: 2017-01-26 21:58:58.386158Z] Finished create-virtualenv step (success) 13:58:58 INFO - [mozharness: 2017-01-26 21:58:58.387113Z] Running install step. 13:58:58 INFO - Running pre-action listener: _resource_record_pre_action 13:58:58 INFO - Running main action method: install 13:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:58 INFO - Reading from file tmpfile_stdout 13:58:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:58:58 INFO - Reading from file tmpfile_stdout 13:58:58 INFO - Output received: 13:58:58 INFO - Usage: mozinstall [options] installer 13:58:58 INFO - Options: 13:58:58 INFO - -h, --help show this help message and exit 13:58:58 INFO - -d DEST, --destination=DEST 13:58:58 INFO - Directory to install application into. [default: 13:58:58 INFO - "/builds/slave/test"] 13:58:58 INFO - --app=APP Application being installed. [default: firefox] 13:58:58 INFO - mkdir: /builds/slave/test/build/application 13:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:59:18 INFO - Reading from file tmpfile_stdout 13:59:18 INFO - Output received: 13:59:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:59:18 INFO - Running post-action listener: _resource_record_post_action 13:59:18 INFO - [mozharness: 2017-01-26 21:59:18.648346Z] Finished install step (success) 13:59:18 INFO - [mozharness: 2017-01-26 21:59:18.648466Z] Running run-tests step. 13:59:18 INFO - Running pre-action listener: _resource_record_pre_action 13:59:18 INFO - Running main action method: run_tests 13:59:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:59:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:59:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:59:18 INFO - 2017-01-26 13:59:18.663 screenresolution[1622:7289] starting screenresolution argv=screenresolution get 13:59:18 INFO - 2017-01-26 13:59:18.665 screenresolution[1622:7289] Display 0: 1600x1200x32@60 13:59:18 INFO - 2017-01-26 13:59:18.671 screenresolution[1623:7292] starting screenresolution argv=screenresolution list 13:59:18 INFO - Available Modes on Display 0 13:59:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:59:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:59:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:59:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:59:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:59:18 INFO - Intel Iris: 13:59:18 INFO - Chipset Model: Intel Iris 13:59:18 INFO - Type: GPU 13:59:18 INFO - Bus: Built-In 13:59:18 INFO - VRAM (Dynamic, Max): 1536 MB 13:59:18 INFO - Vendor: Intel (0x8086) 13:59:18 INFO - Device ID: 0x0a2e 13:59:18 INFO - Revision ID: 0x0009 13:59:18 INFO - Displays: 13:59:18 INFO - Display: 13:59:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:59:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:59:18 INFO - Display Serial Number: 1600x1200 60 13:59:18 INFO - Main Display: Yes 13:59:18 INFO - Mirror: Off 13:59:18 INFO - Online: Yes 13:59:18 INFO - Rotation: Supported 13:59:18 INFO - Return code: 0 13:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:59:18 INFO - Python 2.7.3 13:59:18 INFO - Return code: 0 13:59:18 INFO - grabbing minidump binary from tooltool 13:59:18 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')]} 13:59:18 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 0x1026c0d30>, '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 0x1025e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:59:18 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 13:59:18 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 13:59:18 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 13:59:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:19 INFO - Return code: 0 13:59:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:59:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:59:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:59:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:59:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:59:19 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/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 13:59:19 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/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --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 13:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cckyULmSGd/Render', 13:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:19 INFO - 'HOME': '/Users/cltbld', 13:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:19 INFO - 'LOGNAME': 'cltbld', 13:59:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:59:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:19 INFO - 'MOZ_NO_REMOTE': '1', 13:59:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:59:19 INFO - 'NO_EM_RESTART': '1', 13:59:19 INFO - 'PAGER': '/bin/cat', 13:59:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:19 INFO - 'PWD': '/builds/slave/test', 13:59:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:19 INFO - 'SHELL': '/bin/bash', 13:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6ehmMLhJ7/Listeners', 13:59:19 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 13:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:19 INFO - 'USER': 'cltbld', 13:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:19 INFO - 'XPC_FLAGS': '0x0', 13:59:19 INFO - 'XPC_SERVICE_NAME': '0', 13:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:19 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/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 13:59:19 INFO - mozversion application_buildid: 20170126131020 13:59:19 INFO - mozversion application_changeset: e35c1d17cc9ba97e680551fe291909fa0e2da96f 13:59:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:59:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:19 INFO - mozversion application_name: Firefox 13:59:19 INFO - mozversion application_remotingname: firefox-dev 13:59:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:59:19 INFO - mozversion application_vendor: Mozilla 13:59:19 INFO - mozversion application_version: 53.0a2 13:59:19 INFO - mozversion platform_buildid: 20170126131020 13:59:19 INFO - mozversion platform_changeset: e35c1d17cc9ba97e680551fe291909fa0e2da96f 13:59:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:59:19 INFO - mozversion platform_version: 53.0a2 13:59:19 INFO - using testdate: 1485467959 13:59:19 INFO - actual date: 1485467959 13:59:19 INFO - starting webserver on 'localhost:49237' 13:59:19 INFO - SUITE-START | Running 2 tests 13:59:19 INFO - TEST-START | dromaeo_css 13:59:19 INFO - operating with platform_type : mac_ 13:59:19 INFO - Initialising browser for dromaeo_css test... 13:59:19 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpfV_DGH/profile http://localhost:49237/getInfo.html) 13:59:21 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 13:59:21 INFO - PROCESS | 1633 | colorDepth:24 13:59:21 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 13:59:21 INFO - PROCESS | 1633 | __metrics 13:59:21 INFO - PROCESS | 1633 | 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" 13:59:21 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:59:22 INFO - TEST-INFO | 1633: exit 0 13:59:22 INFO - Browser initialized. 13:59:22 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:22 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpfV_DGH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:34 INFO - PROCESS | 1635 | RSS: Main: 212705280 13:59:34 INFO - PROCESS | 1635 | 14:02:38 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 14:02:39 INFO - PROCESS | 1635 | RSS: Main: 345952256 14:02:39 INFO - PROCESS | 1635 | 14:04:23 INFO - PROCESS | 1635 | ************************* 14:04:23 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 14:04:23 INFO - PROCESS | 1635 | 14:04:23 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:04:23 INFO - PROCESS | 1635 | Full stack: 14:04:23 INFO - PROCESS | 1635 | ************************* 14:05:42 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 14:05:43 INFO - PROCESS | 1635 | RSS: Main: 347590656 14:05:43 INFO - PROCESS | 1635 | 14:08:45 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 14:08:46 INFO - PROCESS | 1635 | RSS: Main: 347205632 14:08:46 INFO - PROCESS | 1635 | 14:11:48 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 14:11:49 INFO - PROCESS | 1635 | RSS: Main: 319479808 14:11:49 INFO - PROCESS | 1635 | 14:14:52 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 14:14:53 INFO - PROCESS | 1635 | RSS: Main: 318369792 14:14:53 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 14:17:56 INFO - PROCESS | 1635 | RSS: Main: 480325632 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | __start_tp_report 14:17:56 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 14:17:56 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 14:17:56 INFO - PROCESS | 1635 | |i|pagename|runs| 14:17:56 INFO - PROCESS | 1635 | |0;dojo.html;3306.9007929762106;3321.0368992992017;3323.6842499962504;3344.331133773246;3381.983090084549;5604.271444712187;5607.915881261774;5627.043402621559;5627.268455100836;5644.6613203207835;5567.49892509674;5642.210090587311;5654.632448890819;5661.4621610947;5682.602217844742;5085.923711144335;5118.206677964912;5130.358705161855;5167.9483205168035;5211.42674305826;5035.672681275723;5060.7722652480725;5066.949330506703;5072.8731781705565;5224.92162617561;5099.0821652102795;5157.277981082651;5169.638125331228;5196.480351964792;5231.450697676746;5179.87050323743;5200.661956972823;5209.6874187548865;5214.270002199676;5250.396204436501;5081.74591270435;5139.486051394868;5163.432022477525;5172.818951336685;5173.120569503193;5485.122380419114;5507.173923911405;5532.336119665666;5535.972320138414;5566.415526369754;6145.692715364258;6175.258968923713;6182.629042257479;6183;6200.286966998808;6280.309165991737;6288.151099601587;6295.653739044396;6315.8736825263695;6330;4990.4510503844185;5577.581681373913;5692.316921969307;5712.80005199816;5742.397048309909;5201.45384734605;6269.498440124779;6324.367563243639;6334.873302534015;6342.23893132827;6114.336601941268;6127.244336464665;6137.754489820447;6139.386061393825;6160.014397696347;6144.631322120687;6262.530310226751;6263.96868015657;6272.090546870678;6283.214598175228;5988.850278742979;6054.212952316171;6059.48494377974;6120.112583675342;6176.907346389808;6147.385261473817;6184.041473571604;6211.81364559064;6214.347493513206;6214.689265536705;4841.378282364061;4868.050730107666;4872.3909511311085;4876.21980483121;4883.389576302962;4316.805743741539;4325.545817689161;4367.061081867414;4386.495553011381;4391.6486681065435;5618.325800903917;5630.155476678449;5651.406602306781;5651.717414129277;5750.654960702288;6099.3900609938655;6110.771402862501;6126.823043872739;6134.375358695247;6311.905321420182;5665.915011274834;5688.8862222755315;5703.258576385127;5717.828465146053;5748.597598168088;5284.445133261029;5285.788568457218;5347.51872331492;5350.357957045179;5357;6239.781607643801;6283.905741413791;6288.339724328879;6296.181496405621;6318.557700960889;6270;6284.057391391328;6290.056491526308;6295.653739044396;6310.990241561328;5015.2978582997675;6019.0369540875;6289.947342987898;6325.96837015812;6329.240491141092;6030.698465076641;6086.6652334122045;6123.6631985239455;6133.824358647991;6189.319174890668;6244.937550624436;6273.404026617464;6307.558470907176;6315.55791094619;6322.968385158045;6052.818415447544;6107.4197951194565;6140;6150.538709596887;6153.353897840662;4666.323383109362;5935.169076329231;5981.970090149522;6122.816315510542;6142.232220972379;5882.764689412375;5910.113482977587;5948.464638182584;5977.133315669291;5994.220751302303;6040.75836966534;6051.334353221054;6063.423974722395;6086.239220097488;6092.177556029879;4814.494478079751;5657.094864821609;5668.433156684298;5752.942470575408;5912.497437717842 14:17:56 INFO - PROCESS | 1635 | |1;ext.html;450.51344547888283;493.64950884871763;496.2531390257662;509.08873117120356;509.44872862134787;31863.84068079659;41142.38286425706;42693.14613707728;43180;44817.32774008392;43715.78142109293;44141;44204.336934946004;44232.557674423246;44267.33598996018;8321.16788321169;8522.360822938273;9259;9444.81110377792;9466.100720431548;11132.276402033882;11404;11429.657110286664;11591.710207244843;11620.709482262926;11401.885981140165;11450.942745286262;11456.599019034335;11461.885381146207;11518.539258429653;11289.379084150369;11367.829482557727;11442;11445.198836081478;11475.770484590303;11330.660080197607;11391.943040284745;11400.315981041163;11402;11417.714557136054;40563;40889.591104088875;41076.1784764306;41082.79458602718;41104.588954110375;3999.9800000999808;4004.581765169655;4070.8371665133654;4157.97921010393;4215.241256573816;29984.700152998626;30825;31008;31103.533446998314;31597;3173.1591128351006;3185.3074824299288;3287.7698561100733;3302.256992176765;3354.1782263345394;491020;491822;493199;493838.53080734727;494006;62874.68562657249;63211.68394158;63317.68341158265;63385.68307158527;63507.047394289126;63533.04700429405;63622.36377636164;63689.681551591944;63705.72588548203;66391.00413493802;14002.719945601031;16355.100469474293;16944.49166525006;17006.129325774156;17075.829241707674;11736.88263117358;12025.458854351575;12045.63863084109;13141.211527308202;13225.669358266121;14645.633859153606;14788.559887618423;14808.185549794865;16285.837141628668;16482.093484858207;7613.619319034026;7668.80827979305;7705.653245603961;7720.729774457867;7724.459287849797;810.3193317613233;861.2205953611991;870.5386145342978;881.3566096749408;900.230303090861;26148.86925565398;30887;30934.22664433407;31331;31428.214294642818;1074.3339129739454;1079.4440862955585;1083.7832433513172;1088.7931293054294;1228.3735294999435;15246.695066098617;15433.382664693287;15683.137427441372;15885;15996;618160;619642;626847.8657606683;629600;630076;51898;52442;52532.68668283247;52580.47419525756;52587.474125259025;1226.6626677663535;1494.588988028301;1509.7810817431412;1513.1072667126448;1519.1948267418286;30249.282595134122;31904.36191276208;32020.6797932027;32225.838870806434;32274.677253227168;54383;55220.72389638187;55268.44731552633;55271.72364138153;55493.167602485184;604905.9754701199;606576;611545;612246;612828;38560.61439385683;38951.415728763524;39047;41248.79375603103;43063.56936430596;32884.67115328816;42057.57942420537;42267.154656906074;42652;43703.34444983264;35611.82194089117;36074.819625901706;36247;36287;36301.27397452089;35392.76125335601;35435.29129417449;35614.64385356113;36293;36325.636743632225;34173.14567135841;34699;35198.824005879804;35449.82275088608;35773.821130894175;29492.262693432836;31075.68924310728;31154;31163;31240.375192496478;20049.699254511484;23797.52404951926;23982.880085600158;24206.878965605058;24249.030038798956 14:17:56 INFO - PROCESS | 1635 | |2;jquery.html;369.890882189754;387.6782270715305;393.8621482481131;398.9501312335958;419.50707918196133;14906.925465372686;15864.810139239546;18909.338173163942;21311.893440532815;21768.238111666094;21713.348599541998;21871.562568748617;22490.66264006037;22544.774552254472;22745;5848.356680765112;5991.46076853082;6113.449789518942;6177.196964394622;6220.502359811204;3945.80270986451;6136.877262454748;6188.597741146811;6193.380661933816;6196.69016549173;4104.261232978063;4172.853950111747;6688.699008544603;6773.221079575863;6780.084688567054;6115.755369785204;6341.556091073627;6748.291429399916;6764.797056088325;6765.32346765322;6027.9095813562835;6032;6037.4566289033755;6039.516838652898;6040.184575082351;13244.735105297936;13611.52359667407;13649.249291288976;13801.447942082305;13878.028538002243;2676.384431580728;2679.0623281851194;2699.5680691089333;2712.715164907696;2714.1586108306487;9949.154321882648;10041.393377059709;10113.64602238918;10422.739431514272;10489.318194317346;1798.5323815807853;1806.2955447375534;1829.923037352601;1856.155449270592;1866.7586055273227;140506;143194;144875;145450;145579.27210363987;11939.820902686466;11941.283522988475;12071.094667899943;12076.939615301868;12240.57263966091;16002.199890005453;16024.439144630116;16030;16036.278367473258;16060.598485037968;8692.652293908173;8867.201951824367;8910.732678019669;8918.464892106495;8986.046139698512;8655.264302534355;8682.86975695365;8692.652293908173;8868.689595864244;8879.33404994628;4709.835155769531;4716.811327546929;4743.5967942724565;4744.810207591727;4787.928181077286;1975.0914579293685;2022.5535111151034;2028.5942811437476;2036.328011756117;2043.6832290994919;984.5569493727851;1015.2690063154517;1019.8419245016886;1032.3289861590026;1035.7565971996576;21033.263835765676;21859.781402186094;22197.667034994487;22288.331350059525;22337.553248935255;1042.8528618519567;1044.1698849414734;1052.315994603514;1055.2824079625927;1057.7831544533353;10772;11532.25040372373;11597.76804463906;11618.302901825917;11654.53381864716;702770;746597;768945;769741;789139;97903.51048244713;110989.56588690051;124040.37979810043;129251.70748292585;139833;965.9565319560637;973.8052389521982;1017.8371460566274;1021.9693409197736;1023.053675350298;16053.578072677663;17479.650406991535;20309.390718278475;20949.89525052426;21107.683384748932;48476.7576162117;55920.92434915956;55983.72008139933;57241.42758572527;61072;63922;82050.17949820663;84207.5789621048;85049.1495085066;85781;7401.815709486456;8110.432269741062;8458.492490450593;8555.443896146731;8584.141585841366;8563.272121869712;10207.897921020694;12460.937695311466;13246.006549508633;13536.187828730308;11433.828492572451;11629.825552616549;11752.294862308288;11894.583689571169;11982.340971246316;11450;11534.480948357512;11580.131490138105;11860.40697965081;11886.465109069939;11617.535298587962;11874.525018999144;11905.52377904874;12087.335196564274;12093.57672481459;8230.588470576327;8353.916460835557;8572.3999320047;8737.694180703646;8804.251638610789;9370.484623345781;11576.884231157917;11617.128715346214;11656;11936.701582460508 14:17:56 INFO - PROCESS | 1635 | |3;mootools.html;1249.8437695288087;1260.4832018872262;1426.6290764401253;1433.6630891740447;1433.8637829406202;8068.878966815495;8527.019392769833;8534.274586660142;8546.615402306896;8556.27271681907;7466.440016998733;7756.689732410697;7774.37804975602;8123.959380203106;8159.428839981204;2294.9770502295014;2330.6154484510034;2333.53329334133;2341.3444235614056;2342.320726989171;2324.0471406723245;2356.8350215484925;2362.2676970139228;2368.692070030894;2372.78644921957;2026.7871873453296;2103.7791031941656;2108.4728817795553;2110.3246960972497;2293.392251053472;1654.454030170041;2086.2593779208314;2098.4544018555134;2098.7271654684946;2105.0632468551503;2300.298408985259;2315.895784689693;2373.2761507740133;2375.608024675944;2386.6300723387903;8316;8417.621207045697;8418.368622353286;8423.915760842436;8430.367722420782;5104.2088476286235;5249.160134378481;5250.474952504757;5266;5271.182966640138;3404.9489257661153;3440.518327434161;3459.39460594395;3479.043263102667;3549.201429678302;1075.231209685071;1194.6535504703625;1200.7358381156132;1232.6795033291319;1246.6073186946082;10672.946635266851;10757.031867131996;10758.300710453874;10859.83710244347;10887.727806804814;4216.430781844473;4489.5959363656775;4651.348811166439;4730.195866702668;4731.266653668687;9573.569189386495;9578.808423831624;9587.760305992266;9608.615655373707;9611.951940240255;5035.521625445577;5066.392032956069;5070.315507406527;5070.543651071422;5081.060003899291;4209.642180414699;4350.129974005212;4532.864014079583;4580.221362368406;4683.344331793552;3397.94663654263;3763.6800871926193;3808.6000969898314;3908.882733517999;3948.9210215796097;1236.1038247270837;1261.3314943080181;1261.5710658376013;1273.5860845225338;1273.6370134511806;915.3638221436038;915.8076803871129;918.5269586163131;928.1924725488868;954.9140577348072;5590.552755779528;5783.797567085132;5832.3292821326095;5955.880882382415;6118.908216376758;845.2730651639584;893.8748575199477;953.3850666320185;997.0278977996395;1020.9744756381001;3481.56480439945;3857.691384689218;3898.8245528951265;4044.2315959967514;4080.7755573443746;9892.950535247277;10091.747706307255;10094.949525252474;10098.242631802645;10128.645497407555;9759.12167904892;9786.266030047775;10032.44821534808;10058.949705251573;10092.990700929848;7749.4575379724;7982.1618730032515;7985.560794156261;7991.480553763987;8036.83926321482;5294.841154765363;5498.972505137449;5550.222968784293;5626.2967129108865;5783.884322313615;8988.191062804379;9359.625614975324;9365.625374984924;9430.52847357643;9481.76295592588;9170.908290917005;9319.207867331354;9453.054694530492;9589.856152157863;9592.520373981133;7146.428285737233;7203.747868824566;7214.2064372917885;7285.526440781332;7331.74338898136;7851;7927.365810735243;7928.207179282025;7941.920580794118;7949.165337639464;6883.8967415487805;7066.540674856118;7190.820229494305;7225.24134965821;7292.197858235696;6803.897941530782;6846.281140480178;6915.273896240822;6968.9546568013175;7003.124609423822;6411;6432.195975503062;6526.510511711545;6528.804135875931;6542.967285163544;5010.749462526932;5053.29253904461;5058.570021548209;5068.949310506848;5093.363329583802;4936.160852655129;4964.156093464192;4975.925361119514;5065.645404821775;5136.845894623168 14:17:56 INFO - PROCESS | 1635 | |4;prototype.html;352.5381749907621;362.9004117523902;367.7903594950877;370.60160327647753;370.87575662153176;4376.452943382077;4572.725636461811;4911.631627627924;5216.374035115787;5222.373315202181;4950.678205916622;4969.577585905203;5183.611229157809;5228.0850851101095;5294.311739473873;2999.4151140527606;3992.8602498912614;4061.547684468193;4156.446238466098;4156.521999969997;3590.9711013277547;4089.7546147231114;4103.953491859572;4118.414410451983;4161.417401563784;3608.899285717855;3612.4761909523104;3751.0809851586264;4026.5369482509445;4125.752454852718;3911.550171730245;3932.1152740633415;4028.8992775180855;4061.6547593454593;4151.398047283157;3586.5696116466193;3660.1764602964386;3662.450632405134;3684.1342284563107;3700.481932529448;4181.749095054276;4341.696081274312;5025.648204625678;5212.270282160501;5213;4637.884052898671;4672.486026537078;4705.998763141621;4785.593224575915;4796.376471058775;5485.341758988907;5506.421825708283;5531.446855314477;5536.972315138399;5623.887522249532;4037.707933461264;4044.1911617676287;4060.553339132693;4080.897977550585;4086.9795651021554;5051.823186188466;5173.473825221568;5357.196420536911;5701.458361455738;5776.220210271602;3844.5386553613744;4117.2588933992165;4124.422580838685;4141.5237247716295;4158.045718512294;4152.671145233497;4187.581241875849;4197.769122698281;4216.9578304217175;4223.957760422418;4486.68593198473;4707.811687532529;4753.500882407367;4768.642351823627;4782.33047373368;4662.461387742037;4905.583025442806;5585.944140558542;5595.4124816894455;5680.914786278209;1117.4692021289984;1192.6362459449776;1231.8789901189875;1270.7077372204444;1337.4650139944101;735.8270806360501;920.7790130368797;953.7234202081457;957.2963871554402;977.8924318324979;4737.668363214542;4843.190949249427;4850.393700787402;4857.546938795886;4867.975660121677;5151.407588127413;5239.921401178985;5290.92063619046;5398.838034858961;5432.782688692487;4078.286299897506;4596.414237088199;4747.881302967454;4832.51674832521;4842.903141937141;2360.8347415680737;2498.5502609530095;2606.614947323216;2813.338865366637;2821.8730157142977;4643.049919034014;4672.486026537078;5505.504504594605;5537.5569954404355;5565.526930210896;4647.95352046482;5407.83776486706;5571.860703482445;5583.259216325072;5639.3232812062;4975.477574854588;5246.3704355477585;5872.530197584183;5912.925278854971;5948.650283138223;4766.711978250529;5666.744996475251;5728.341240757366;5744;5749.798757043483;4702.412198475191;5262.500062494057;5556.888862222814;5576.525995290446;5583.162525621189;5148.510891465305;5340.863654538216;5596.636218645775;5625;5797.608399086582;3728.4407338898295;3805.771653700787;3830.463735077036;3855.267499175148;3868.2456920900154;4773.474917759113;5286.97356513215;5362.329708786402;5676.460736230051;5705.860302386605;4393.29707246839;4887.3117293486885;4936.901261974668;5516.586256030894;5573.554115670818;5020.949790502194;5302.9659216453965;5557.972210138923;5581.5813813963305;5671.206031155724;4453.465584129925;4508;5457.345118585795;5458.808941687022;5476.946145195551;4925.5715842406735;5385.299911011543;5523.226748255328;5554.944450555605;5601.579881508985;4791.592714619296;5470.945290547043;5478.45215478449;5482.862928426821;5501 14:17:56 INFO - PROCESS | 1635 | |5;yui.html;671.5634837355718;711.190021395548;727.3344889426176;811.1077814404156;812.8618134917064;14860.851391486081;15403.460878869242;15432.382704691827;15842.999999999985;15872.444464443746;14325.785113223284;14508.274586270698;14521.12873227607;14534.273286335667;14546.981711280214;677.5460441504204;697.8708938846304;700.0933790741003;858.1375717404031;871.5032431514039;858.2318824651933;875.374107513128;878.9340799440035;891.8617614269799;893.0266010049045;903.9774005649879;906.084854297158;906.8458362078429;921.1847514949285;951.6621599332241;715.889037199235;739.6043116932469;939.2392162348519;940.196132306878;945.1588086602928;670.2325836916704;677.5663575311804;685.3215316836346;694.2987582541618;697.1425147069133;14725.484608038774;15451.690966180726;15502.147381893992;15511.844881551153;15537.689246215126;10977.780444391148;13543.39054742539;13561.389737461837;13588.59234222975;13603.455861765517;12396.566120185751;12523;12568.30874301913;13015.609531714064;13042.347882605927;4377.102693947733;4397.362382454558;4433.889152771174;4459.955400446019;4556.316552517116;94035;96298;101442.49278753632;101488;102513;10171.898281017244;10248.538815753309;10360.119389851947;10529;10604.310719803188;19832;19923;20055.59888802216;20161.899190503955;20218.191272349235;7611.4291428143115;7730.188330225358;7732.226777322223;7736.9342585064505;7836.686532538749;4261.4673165854265;4346.1090476452255;4386.298192289219;4432.202203603382;4462.973516091252;3488.4418493040994;3599.1002249437643;3599.1721903962234;3599.3341231872187;3604.711623070148;632.9461995730322;641.2657507154282;646.8447572582546;650.7754824585511;659.0378048049805;644.7936660268763;650.5413683353224;651.7621068310033;658.713459645056;675.4461341699857;9423.670171543963;9956.352837065568;10112.191024718006;10114.645987390406;10200.4389758564;510.9642325037286;593.5044238061267;612.8039027511154;628.9276733175652;655.9737610495622;4633.189191891405;4926.975365123151;4959.330490383752;4959.553640172329;4970.701757894538;93990;96154;102579.487102564;105983;106382;70119;85927.70361481901;89511.55244223737;90042.54978725064;92496;60481;61069;75459.62270188723;78337.60831195922;79483;9355.953220233856;9519.90480095218;9553.474558899326;9557.52212389364;9557.808843823224;49876.00247995093;53201.7339913298;55772.442275578345;57212.14181787193;57861.13208301963;63235.6838215806;66518;69226;69771.651141746;72432;13143.802842957555;13373.39819708096;13458.52895148665;13632.863671363159;13657.180569165881;14336.856631433553;14393.064450810663;15129.621759456102;15311.464098756936;15536.378544858078;13396;13451.663708407368;13629.522966696119;13996.300184990507;14456.710865782836;13133.605991819879;13173.47306107745;13908.791368129689;13956.651083722989;14098.50655227062;12789.488420463449;13278.734425311246;13605.183688978694;14275.500357487437;14290.499832505813;10914.598832806267;10941.781164376827;11094;11529.020033296929;11698.590549330733;8649.610767515604;9316.860247096163;11002.449877506253;11106.555737770399;11208.327500350006 14:17:56 INFO - PROCESS | 1635 | __end_tp_report 14:17:56 INFO - PROCESS | 1635 | __start_cc_report 14:17:56 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1365 14:17:56 INFO - PROCESS | 1635 | __end_cc_report 14:17:56 INFO - PROCESS | 1635 | __startTimestamp1485469076632__endTimestamp 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | ------- Summary: start ------- 14:17:56 INFO - PROCESS | 1635 | Number of tests: 6 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5671.85 Median:5882.76 stddev:660.95 (11.2%) stddev-sans-first:636.41 14:17:56 INFO - PROCESS | 1635 | Values: 3306.9 3321.0 3323.7 3344.3 3382.0 5604.3 5607.9 5627.0 5627.3 5644.7 5567.5 5642.2 5654.6 5661.5 5682.6 5085.9 5118.2 5130.4 5167.9 5211.4 5035.7 5060.8 5066.9 5072.9 5224.9 5099.1 5157.3 5169.6 5196.5 5231.5 5179.9 5200.7 5209.7 5214.3 5250.4 5081.7 5139.5 5163.4 5172.8 5173.1 5485.1 5507.2 5532.3 5536.0 5566.4 6145.7 6175.3 6182.6 6183.0 6200.3 6280.3 6288.2 6295.7 6315.9 6330.0 4990.5 5577.6 5692.3 5712.8 5742.4 5201.5 6269.5 6324.4 6334.9 6342.2 6114.3 6127.2 6137.8 6139.4 6160.0 6144.6 6262.5 6264.0 6272.1 6283.2 5988.9 6054.2 6059.5 6120.1 6176.9 6147.4 6184.0 6211.8 6214.3 6214.7 4841.4 4868.1 4872.4 4876.2 4883.4 4316.8 4325.5 4367.1 4386.5 4391.6 5618.3 5630.2 5651.4 5651.7 5750.7 6099.4 6110.8 6126.8 6134.4 6311.9 5665.9 5688.9 5703.3 5717.8 5748.6 5284.4 5285.8 5347.5 5350.4 5357.0 6239.8 6283.9 6288.3 6296.2 6318.6 6270.0 6284.1 6290.1 6295.7 6311.0 5015.3 6019.0 6289.9 6326.0 6329.2 6030.7 6086.7 6123.7 6133.8 6189.3 6244.9 6273.4 6307.6 6315.6 6323.0 6052.8 6107.4 6140.0 6150.5 6153.4 4666.3 5935.2 5982.0 6122.8 6142.2 5882.8 5910.1 5948.5 5977.1 5994.2 6040.8 6051.3 6063.4 6086.2 6092.2 4814.5 5657.1 5668.4 5752.9 5912.5 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:71004.96 Median:35924.32 stddev:154607.46 (430.4%) stddev-sans-first:154950.42 14:17:56 INFO - PROCESS | 1635 | Values: 450.5 493.6 496.3 509.1 509.4 31863.8 41142.4 42693.1 43180.0 44817.3 43715.8 44141.0 44204.3 44232.6 44267.3 8321.2 8522.4 9259.0 9444.8 9466.1 11132.3 11404.0 11429.7 11591.7 11620.7 11401.9 11450.9 11456.6 11461.9 11518.5 11289.4 11367.8 11442.0 11445.2 11475.8 11330.7 11391.9 11400.3 11402.0 11417.7 40563.0 40889.6 41076.2 41082.8 41104.6 4000.0 4004.6 4070.8 4158.0 4215.2 29984.7 30825.0 31008.0 31103.5 31597.0 3173.2 3185.3 3287.8 3302.3 3354.2 491020.0 491822.0 493199.0 493838.5 494006.0 62874.7 63211.7 63317.7 63385.7 63507.0 63533.0 63622.4 63689.7 63705.7 66391.0 14002.7 16355.1 16944.5 17006.1 17075.8 11736.9 12025.5 12045.6 13141.2 13225.7 14645.6 14788.6 14808.2 16285.8 16482.1 7613.6 7668.8 7705.7 7720.7 7724.5 810.3 861.2 870.5 881.4 900.2 26148.9 30887.0 30934.2 31331.0 31428.2 1074.3 1079.4 1083.8 1088.8 1228.4 15246.7 15433.4 15683.1 15885.0 15996.0 618160.0 619642.0 626847.9 629600.0 630076.0 51898.0 52442.0 52532.7 52580.5 52587.5 1226.7 1494.6 1509.8 1513.1 1519.2 30249.3 31904.4 32020.7 32225.8 32274.7 54383.0 55220.7 55268.4 55271.7 55493.2 604906.0 606576.0 611545.0 612246.0 612828.0 38560.6 38951.4 39047.0 41248.8 43063.6 32884.7 42057.6 42267.2 42652.0 43703.3 35611.8 36074.8 36247.0 36287.0 36301.3 35392.8 35435.3 35614.6 36293.0 36325.6 34173.1 34699.0 35198.8 35449.8 35773.8 29492.3 31075.7 31154.0 31163.0 31240.4 20049.7 23797.5 23982.9 24206.9 24249.0 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:39955.47 Median:21865.67 stddev:125389.67 (573.5%) stddev-sans-first:125706.18 14:17:56 INFO - PROCESS | 1635 | Values: 369.9 387.7 393.9 399.0 419.5 14906.9 15864.8 18909.3 21311.9 21768.2 21713.3 21871.6 22490.7 22544.8 22745.0 5848.4 5991.5 6113.4 6177.2 6220.5 3945.8 6136.9 6188.6 6193.4 6196.7 4104.3 4172.9 6688.7 6773.2 6780.1 6115.8 6341.6 6748.3 6764.8 6765.3 6027.9 6032.0 6037.5 6039.5 6040.2 13244.7 13611.5 13649.2 13801.4 13878.0 2676.4 2679.1 2699.6 2712.7 2714.2 9949.2 10041.4 10113.6 10422.7 10489.3 1798.5 1806.3 1829.9 1856.2 1866.8 140506.0 143194.0 144875.0 145450.0 145579.3 11939.8 11941.3 12071.1 12076.9 12240.6 16002.2 16024.4 16030.0 16036.3 16060.6 8692.7 8867.2 8910.7 8918.5 8986.0 8655.3 8682.9 8692.7 8868.7 8879.3 4709.8 4716.8 4743.6 4744.8 4787.9 1975.1 2022.6 2028.6 2036.3 2043.7 984.6 1015.3 1019.8 1032.3 1035.8 21033.3 21859.8 22197.7 22288.3 22337.6 1042.9 1044.2 1052.3 1055.3 1057.8 10772.0 11532.3 11597.8 11618.3 11654.5 702770.0 746597.0 768945.0 769741.0 789139.0 97903.5 110989.6 124040.4 129251.7 139833.0 966.0 973.8 1017.8 1022.0 1023.1 16053.6 17479.7 20309.4 20949.9 21107.7 48476.8 55920.9 55983.7 57241.4 61072.0 63922.0 82050.2 84207.6 85049.1 85781.0 7401.8 8110.4 8458.5 8555.4 8584.1 8563.3 10207.9 12460.9 13246.0 13536.2 11433.8 11629.8 11752.3 11894.6 11982.3 11450.0 11534.5 11580.1 11860.4 11886.5 11617.5 11874.5 11905.5 12087.3 12093.6 8230.6 8353.9 8572.4 8737.7 8804.3 9370.5 11576.9 11617.1 11656.0 11936.7 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5451.11 Median:5087.21 stddev:2990.72 (58.8%) stddev-sans-first:2982.43 14:17:56 INFO - PROCESS | 1635 | Values: 1249.8 1260.5 1426.6 1433.7 1433.9 8068.9 8527.0 8534.3 8546.6 8556.3 7466.4 7756.7 7774.4 8124.0 8159.4 2295.0 2330.6 2333.5 2341.3 2342.3 2324.0 2356.8 2362.3 2368.7 2372.8 2026.8 2103.8 2108.5 2110.3 2293.4 1654.5 2086.3 2098.5 2098.7 2105.1 2300.3 2315.9 2373.3 2375.6 2386.6 8316.0 8417.6 8418.4 8423.9 8430.4 5104.2 5249.2 5250.5 5266.0 5271.2 3404.9 3440.5 3459.4 3479.0 3549.2 1075.2 1194.7 1200.7 1232.7 1246.6 10672.9 10757.0 10758.3 10859.8 10887.7 4216.4 4489.6 4651.3 4730.2 4731.3 9573.6 9578.8 9587.8 9608.6 9612.0 5035.5 5066.4 5070.3 5070.5 5081.1 4209.6 4350.1 4532.9 4580.2 4683.3 3397.9 3763.7 3808.6 3908.9 3948.9 1236.1 1261.3 1261.6 1273.6 1273.6 915.4 915.8 918.5 928.2 954.9 5590.6 5783.8 5832.3 5955.9 6118.9 845.3 893.9 953.4 997.0 1021.0 3481.6 3857.7 3898.8 4044.2 4080.8 9893.0 10091.7 10094.9 10098.2 10128.6 9759.1 9786.3 10032.4 10058.9 10093.0 7749.5 7982.2 7985.6 7991.5 8036.8 5294.8 5499.0 5550.2 5626.3 5783.9 8988.2 9359.6 9365.6 9430.5 9481.8 9170.9 9319.2 9453.1 9589.9 9592.5 7146.4 7203.7 7214.2 7285.5 7331.7 7851.0 7927.4 7928.2 7941.9 7949.2 6883.9 7066.5 7190.8 7225.2 7292.2 6803.9 6846.3 6915.3 6969.0 7003.1 6411.0 6432.2 6526.5 6528.8 6543.0 5010.7 5053.3 5058.6 5068.9 5093.4 4936.2 4964.2 4975.9 5065.6 5136.8 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4445.30 Median:4843.05 stddev:1322.23 (27.3%) stddev-sans-first:1289.76 14:17:56 INFO - PROCESS | 1635 | Values: 352.5 362.9 367.8 370.6 370.9 4376.5 4572.7 4911.6 5216.4 5222.4 4950.7 4969.6 5183.6 5228.1 5294.3 2999.4 3992.9 4061.5 4156.4 4156.5 3591.0 4089.8 4104.0 4118.4 4161.4 3608.9 3612.5 3751.1 4026.5 4125.8 3911.6 3932.1 4028.9 4061.7 4151.4 3586.6 3660.2 3662.5 3684.1 3700.5 4181.7 4341.7 5025.6 5212.3 5213.0 4637.9 4672.5 4706.0 4785.6 4796.4 5485.3 5506.4 5531.4 5537.0 5623.9 4037.7 4044.2 4060.6 4080.9 4087.0 5051.8 5173.5 5357.2 5701.5 5776.2 3844.5 4117.3 4124.4 4141.5 4158.0 4152.7 4187.6 4197.8 4217.0 4224.0 4486.7 4707.8 4753.5 4768.6 4782.3 4662.5 4905.6 5585.9 5595.4 5680.9 1117.5 1192.6 1231.9 1270.7 1337.5 735.8 920.8 953.7 957.3 977.9 4737.7 4843.2 4850.4 4857.5 4868.0 5151.4 5239.9 5290.9 5398.8 5432.8 4078.3 4596.4 4747.9 4832.5 4842.9 2360.8 2498.6 2606.6 2813.3 2821.9 4643.0 4672.5 5505.5 5537.6 5565.5 4648.0 5407.8 5571.9 5583.3 5639.3 4975.5 5246.4 5872.5 5912.9 5948.7 4766.7 5666.7 5728.3 5744.0 5749.8 4702.4 5262.5 5556.9 5576.5 5583.2 5148.5 5340.9 5596.6 5625.0 5797.6 3728.4 3805.8 3830.5 3855.3 3868.2 4773.5 5287.0 5362.3 5676.5 5705.9 4393.3 4887.3 4936.9 5516.6 5573.6 5020.9 5303.0 5558.0 5581.6 5671.2 4453.5 4508.0 5457.3 5458.8 5476.9 4925.6 5385.3 5523.2 5554.9 5601.6 4791.6 5470.9 5478.5 5482.9 5501.0 14:17:56 INFO - PROCESS | 1635 | 14:17:56 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:20097.09 Median:4509.65 stddev:28348.53 (628.6%) stddev-sans-first:28390.53 14:17:56 INFO - PROCESS | 1635 | Values: 671.6 711.2 727.3 811.1 812.9 14860.9 15403.5 15432.4 15843.0 15872.4 14325.8 14508.3 14521.1 14534.3 14547.0 677.5 697.9 700.1 858.1 871.5 858.2 875.4 878.9 891.9 893.0 904.0 906.1 906.8 921.2 951.7 715.9 739.6 939.2 940.2 945.2 670.2 677.6 685.3 694.3 697.1 14725.5 15451.7 15502.1 15511.8 15537.7 10977.8 13543.4 13561.4 13588.6 13603.5 12396.6 12523.0 12568.3 13015.6 13042.3 4377.1 4397.4 4433.9 4460.0 4556.3 94035.0 96298.0 101442.5 101488.0 102513.0 10171.9 10248.5 10360.1 10529.0 10604.3 19832.0 19923.0 20055.6 20161.9 20218.2 7611.4 7730.2 7732.2 7736.9 7836.7 4261.5 4346.1 4386.3 4432.2 4463.0 3488.4 3599.1 3599.2 3599.3 3604.7 632.9 641.3 646.8 650.8 659.0 644.8 650.5 651.8 658.7 675.4 9423.7 9956.4 10112.2 10114.6 10200.4 511.0 593.5 612.8 628.9 656.0 4633.2 4927.0 4959.3 4959.6 4970.7 93990.0 96154.0 102579.5 105983.0 106382.0 70119.0 85927.7 89511.6 90042.5 92496.0 60481.0 61069.0 75459.6 78337.6 79483.0 9356.0 9519.9 9553.5 9557.5 9557.8 49876.0 53201.7 55772.4 57212.1 57861.1 63235.7 66518.0 69226.0 69771.7 72432.0 13143.8 13373.4 13458.5 13632.9 13657.2 14336.9 14393.1 15129.6 15311.5 15536.4 13396.0 13451.7 13629.5 13996.3 14456.7 13133.6 13173.5 13908.8 13956.7 14098.5 12789.5 13278.7 13605.2 14275.5 14290.5 10914.6 10941.8 11094.0 11529.0 11698.6 8649.6 9316.9 11002.4 11106.6 11208.3 14:17:56 INFO - PROCESS | 1635 | -------- Summary: end -------- 14:17:56 INFO - PROCESS | 1635 | 14:17:57 INFO - TEST-INFO | 1635: exit 0 14:17:57 INFO - TEST-OK | dromaeo_css | took 1118031ms 14:17:57 INFO - TEST-START | kraken 14:17:57 INFO - operating with platform_type : mac_ 14:17:57 INFO - Initialising browser for kraken test... 14:17:57 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpGp4Em7/profile http://localhost:49237/getInfo.html) 14:17:59 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 14:17:59 INFO - PROCESS | 1645 | colorDepth:24 14:17:59 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 14:17:59 INFO - PROCESS | 1645 | __metrics 14:17:59 INFO - PROCESS | 1645 | 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" 14:17:59 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:00 INFO - TEST-INFO | 1645: exit 0 14:18:00 INFO - Browser initialized. 14:18:00 INFO - Running cycle 1/1 for kraken test... 14:18:00 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpGp4Em7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:12 INFO - PROCESS | 1646 | RSS: Main: 212725760 14:18:12 INFO - PROCESS | 1646 | 14:18:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:16 INFO - PROCESS | 1646 | RSS: Main: 263733248 14:18:16 INFO - PROCESS | 1646 | 14:18:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 14:18:19 INFO - PROCESS | 1646 | RSS: Main: 276504576 14:18:19 INFO - PROCESS | 1646 | 14:18:22 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 14:18:23 INFO - PROCESS | 1646 | RSS: Main: 373555200 14:18:23 INFO - PROCESS | 1646 | 14:18:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 14:18:25 INFO - PROCESS | 1646 | RSS: Main: 277643264 14:18:25 INFO - PROCESS | 1646 | 14:18:27 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:28 INFO - PROCESS | 1646 | RSS: Main: 280006656 14:18:28 INFO - PROCESS | 1646 | 14:18:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:31 INFO - PROCESS | 1646 | RSS: Main: 319901696 14:18:31 INFO - PROCESS | 1646 | 14:18:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:35 INFO - PROCESS | 1646 | RSS: Main: 319975424 14:18:35 INFO - PROCESS | 1646 | 14:18:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 14:18:38 INFO - PROCESS | 1646 | RSS: Main: 317001728 14:18:38 INFO - PROCESS | 1646 | 14:18:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:41 INFO - PROCESS | 1646 | RSS: Main: 294506496 14:18:41 INFO - PROCESS | 1646 | 14:18:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:43 INFO - PROCESS | 1646 | RSS: Main: 297209856 14:18:43 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:46 INFO - PROCESS | 1646 | RSS: Main: 299192320 14:18:46 INFO - PROCESS | 1646 | 14:18:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:18:50 INFO - PROCESS | 1646 | RSS: Main: 316534784 14:18:50 INFO - PROCESS | 1646 | 14:18:52 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:53 INFO - PROCESS | 1646 | RSS: Main: 310734848 14:18:53 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 14:18:55 INFO - PROCESS | 1646 | RSS: Main: 355368960 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | __start_tp_report 14:18:55 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 14:18:55 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 14:18:55 INFO - PROCESS | 1646 | |i|pagename|runs| 14:18:55 INFO - PROCESS | 1646 | |0;ai-astar;111;115;114;113;113;113;114;113;114;113 14:18:55 INFO - PROCESS | 1646 | |1;audio-beat-detection;144;138;137;142;110;109;108;111;142;109 14:18:55 INFO - PROCESS | 1646 | |2;audio-dft;182;183;185;182;184;181;185;183;184;185 14:18:55 INFO - PROCESS | 1646 | |3;audio-fft;79;59;61;104;86;80;58;60;73;59 14:18:55 INFO - PROCESS | 1646 | |4;audio-oscillator;85;70;86;69;68;70;81;68;68;82 14:18:55 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;85;86;85;87;84;89;85;87;85 14:18:55 INFO - PROCESS | 1646 | |6;imaging-darkroom;93;93;94;93;93;92;94;93;94;93 14:18:55 INFO - PROCESS | 1646 | |7;imaging-desaturate;86;98;142;85;86;88;85;88;88;86 14:18:55 INFO - PROCESS | 1646 | |8;json-parse-financial;55;55;53;54;56;57;55;59;79;87 14:18:55 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;64;74;71;76;76;70;69;70;70;73 14:18:55 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;85;82;84;84;89;85;84;83;85;85 14:18:55 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;141;149;134;140;140;151;154;140;183;139 14:18:55 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;154;165;168;173;165;168;164;162;166;167 14:18:55 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;68;67;65;66;66;67;65;67;64;66 14:18:55 INFO - PROCESS | 1646 | __end_tp_report 14:18:55 INFO - PROCESS | 1646 | __start_cc_report 14:18:55 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1927 14:18:55 INFO - PROCESS | 1646 | __end_cc_report 14:18:55 INFO - PROCESS | 1646 | __startTimestamp1485469135438__endTimestamp 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | ------- Summary: start ------- 14:18:55 INFO - PROCESS | 1646 | Number of tests: 14 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:1.06 (0.9%) stddev-sans-first:0.73 14:18:55 INFO - PROCESS | 1646 | Values: 111.0 115.0 114.0 113.0 113.0 113.0 114.0 113.0 114.0 113.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:137.50 stddev:16.58 (12.1%) stddev-sans-first:16.10 14:18:55 INFO - PROCESS | 1646 | Values: 144.0 138.0 137.0 142.0 110.0 109.0 108.0 111.0 142.0 109.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.43 (0.8%) stddev-sans-first:1.42 14:18:55 INFO - PROCESS | 1646 | Values: 182.0 183.0 185.0 182.0 184.0 181.0 185.0 183.0 184.0 185.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:71.90 Median:67.00 stddev:15.39 (23.0%) stddev-sans-first:16.11 14:18:55 INFO - PROCESS | 1646 | Values: 79.0 59.0 61.0 104.0 86.0 80.0 58.0 60.0 73.0 59.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:75.50 stddev:7.73 (10.2%) stddev-sans-first:7.25 14:18:55 INFO - PROCESS | 1646 | Values: 85.0 70.0 86.0 69.0 68.0 70.0 81.0 68.0 68.0 82.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.50 stddev:1.60 (1.8%) stddev-sans-first:1.54 14:18:55 INFO - PROCESS | 1646 | Values: 88.0 85.0 86.0 85.0 87.0 84.0 89.0 85.0 87.0 85.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:18:55 INFO - PROCESS | 1646 | Values: 93.0 93.0 94.0 93.0 93.0 92.0 94.0 93.0 94.0 93.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:87.00 stddev:17.56 (20.2%) stddev-sans-first:18.43 14:18:55 INFO - PROCESS | 1646 | Values: 86.0 98.0 142.0 85.0 86.0 88.0 85.0 88.0 88.0 86.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:56.50 stddev:11.86 (21.0%) stddev-sans-first:12.38 14:18:55 INFO - PROCESS | 1646 | Values: 55.0 55.0 53.0 54.0 56.0 57.0 55.0 59.0 79.0 87.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:3.62 (5.0%) stddev-sans-first:2.71 14:18:55 INFO - PROCESS | 1646 | Values: 64.0 74.0 71.0 76.0 76.0 70.0 69.0 70.0 70.0 73.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.84 (2.2%) stddev-sans-first:1.94 14:18:55 INFO - PROCESS | 1646 | Values: 85.0 82.0 84.0 84.0 89.0 85.0 84.0 83.0 85.0 85.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:145.00 stddev:14.07 (9.7%) stddev-sans-first:14.75 14:18:55 INFO - PROCESS | 1646 | Values: 141.0 149.0 134.0 140.0 140.0 151.0 154.0 140.0 183.0 139.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.50 stddev:4.92 (3.0%) stddev-sans-first:3.13 14:18:55 INFO - PROCESS | 1646 | Values: 154.0 165.0 168.0 173.0 165.0 168.0 164.0 162.0 166.0 167.0 14:18:55 INFO - PROCESS | 1646 | 14:18:55 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.05 14:18:55 INFO - PROCESS | 1646 | Values: 68.0 67.0 65.0 66.0 66.0 67.0 65.0 67.0 64.0 66.0 14:18:55 INFO - PROCESS | 1646 | -------- Summary: end -------- 14:18:55 INFO - PROCESS | 1646 | 14:18:56 INFO - TEST-INFO | 1646: exit 0 14:18:56 INFO - TEST-OK | kraken | took 59126ms 14:18:56 INFO - SUITE-END | took 1177s 14:18:56 INFO - Completed test suite (00:19:37) 14:18:56 INFO - javascript benchmark 14:18:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.9007929762106, 3321.0368992992017, 3323.6842499962504, 3344.331133773246, 3381.983090084549, 5604.271444712187, 5607.915881261774, 5627.043402621559, 5627.268455100836, 5644.6613203207835, 5567.49892509674, 5642.210090587311, 5654.632448890819, 5661.4621610947, 5682.602217844742, 5085.923711144335, 5118.206677964912, 5130.358705161855, 5167.9483205168035, 5211.42674305826, 5035.672681275723, 5060.7722652480725, 5066.949330506703, 5072.8731781705565, 5224.92162617561, 5099.0821652102795, 5157.277981082651, 5169.638125331228, 5196.480351964792, 5231.450697676746, 5179.87050323743, 5200.661956972823, 5209.6874187548865, 5214.270002199676, 5250.396204436501, 5081.74591270435, 5139.486051394868, 5163.432022477525, 5172.818951336685, 5173.120569503193, 5485.122380419114, 5507.173923911405, 5532.336119665666, 5535.972320138414, 5566.415526369754, 6145.692715364258, 6175.258968923713, 6182.629042257479, 6183.0, 6200.286966998808, 6280.309165991737, 6288.151099601587, 6295.653739044396, 6315.8736825263695, 6330.0, 4990.4510503844185, 5577.581681373913, 5692.316921969307, 5712.80005199816, 5742.397048309909, 5201.45384734605, 6269.498440124779, 6324.367563243639, 6334.873302534015, 6342.23893132827, 6114.336601941268, 6127.244336464665, 6137.754489820447, 6139.386061393825, 6160.014397696347, 6144.631322120687, 6262.530310226751, 6263.96868015657, 6272.090546870678, 6283.214598175228, 5988.850278742979, 6054.212952316171, 6059.48494377974, 6120.112583675342, 6176.907346389808, 6147.385261473817, 6184.041473571604, 6211.81364559064, 6214.347493513206, 6214.689265536705, 4841.378282364061, 4868.050730107666, 4872.3909511311085, 4876.21980483121, 4883.389576302962, 4316.805743741539, 4325.545817689161, 4367.061081867414, 4386.495553011381, 4391.6486681065435, 5618.325800903917, 5630.155476678449, 5651.406602306781, 5651.717414129277, 5750.654960702288, 6099.3900609938655, 6110.771402862501, 6126.823043872739, 6134.375358695247, 6311.905321420182, 5665.915011274834, 5688.8862222755315, 5703.258576385127, 5717.828465146053, 5748.597598168088, 5284.445133261029, 5285.788568457218, 5347.51872331492, 5350.357957045179, 5357.0, 6239.781607643801, 6283.905741413791, 6288.339724328879, 6296.181496405621, 6318.557700960889, 6270.0, 6284.057391391328, 6290.056491526308, 6295.653739044396, 6310.990241561328, 5015.2978582997675, 6019.0369540875, 6289.947342987898, 6325.96837015812, 6329.240491141092, 6030.698465076641, 6086.6652334122045, 6123.6631985239455, 6133.824358647991, 6189.319174890668, 6244.937550624436, 6273.404026617464, 6307.558470907176, 6315.55791094619, 6322.968385158045, 6052.818415447544, 6107.4197951194565, 6140.0, 6150.538709596887, 6153.353897840662, 4666.323383109362, 5935.169076329231, 5981.970090149522, 6122.816315510542, 6142.232220972379, 5882.764689412375, 5910.113482977587, 5948.464638182584, 5977.133315669291, 5994.220751302303, 6040.75836966534, 6051.334353221054, 6063.423974722395, 6086.239220097488, 6092.177556029879, 4814.494478079751, 5657.094864821609, 5668.433156684298, 5752.942470575408, 5912.497437717842], "value": 5629.931581957416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.51344547888283, 493.64950884871763, 496.2531390257662, 509.08873117120356, 509.44872862134787, 31863.84068079659, 41142.38286425706, 42693.14613707728, 43180.0, 44817.32774008392, 43715.78142109293, 44141.0, 44204.336934946004, 44232.557674423246, 44267.33598996018, 8321.16788321169, 8522.360822938273, 9259.0, 9444.81110377792, 9466.100720431548, 11132.276402033882, 11404.0, 11429.657110286664, 11591.710207244843, 11620.709482262926, 11401.885981140165, 11450.942745286262, 11456.599019034335, 11461.885381146207, 11518.539258429653, 11289.379084150369, 11367.829482557727, 11442.0, 11445.198836081478, 11475.770484590303, 11330.660080197607, 11391.943040284745, 11400.315981041163, 11402.0, 11417.714557136054, 40563.0, 40889.591104088875, 41076.1784764306, 41082.79458602718, 41104.588954110375, 3999.9800000999808, 4004.581765169655, 4070.8371665133654, 4157.97921010393, 4215.241256573816, 29984.700152998626, 30825.0, 31008.0, 31103.533446998314, 31597.0, 3173.1591128351006, 3185.3074824299288, 3287.7698561100733, 3302.256992176765, 3354.1782263345394, 491020.0, 491822.0, 493199.0, 493838.53080734727, 494006.0, 62874.68562657249, 63211.68394158, 63317.68341158265, 63385.68307158527, 63507.047394289126, 63533.04700429405, 63622.36377636164, 63689.681551591944, 63705.72588548203, 66391.00413493802, 14002.719945601031, 16355.100469474293, 16944.49166525006, 17006.129325774156, 17075.829241707674, 11736.88263117358, 12025.458854351575, 12045.63863084109, 13141.211527308202, 13225.669358266121, 14645.633859153606, 14788.559887618423, 14808.185549794865, 16285.837141628668, 16482.093484858207, 7613.619319034026, 7668.80827979305, 7705.653245603961, 7720.729774457867, 7724.459287849797, 810.3193317613233, 861.2205953611991, 870.5386145342978, 881.3566096749408, 900.230303090861, 26148.86925565398, 30887.0, 30934.22664433407, 31331.0, 31428.214294642818, 1074.3339129739454, 1079.4440862955585, 1083.7832433513172, 1088.7931293054294, 1228.3735294999435, 15246.695066098617, 15433.382664693287, 15683.137427441372, 15885.0, 15996.0, 618160.0, 619642.0, 626847.8657606683, 629600.0, 630076.0, 51898.0, 52442.0, 52532.68668283247, 52580.47419525756, 52587.474125259025, 1226.6626677663535, 1494.588988028301, 1509.7810817431412, 1513.1072667126448, 1519.1948267418286, 30249.282595134122, 31904.36191276208, 32020.6797932027, 32225.838870806434, 32274.677253227168, 54383.0, 55220.72389638187, 55268.44731552633, 55271.72364138153, 55493.167602485184, 604905.9754701199, 606576.0, 611545.0, 612246.0, 612828.0, 38560.61439385683, 38951.415728763524, 39047.0, 41248.79375603103, 43063.56936430596, 32884.67115328816, 42057.57942420537, 42267.154656906074, 42652.0, 43703.34444983264, 35611.82194089117, 36074.819625901706, 36247.0, 36287.0, 36301.27397452089, 35392.76125335601, 35435.29129417449, 35614.64385356113, 36293.0, 36325.636743632225, 34173.14567135841, 34699.0, 35198.824005879804, 35449.82275088608, 35773.821130894175, 29492.262693432836, 31075.68924310728, 31154.0, 31163.0, 31240.375192496478, 20049.699254511484, 23797.52404951926, 23982.880085600158, 24206.878965605058, 24249.030038798956], "value": 20376.686136422773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.890882189754, 387.6782270715305, 393.8621482481131, 398.9501312335958, 419.50707918196133, 14906.925465372686, 15864.810139239546, 18909.338173163942, 21311.893440532815, 21768.238111666094, 21713.348599541998, 21871.562568748617, 22490.66264006037, 22544.774552254472, 22745.0, 5848.356680765112, 5991.46076853082, 6113.449789518942, 6177.196964394622, 6220.502359811204, 3945.80270986451, 6136.877262454748, 6188.597741146811, 6193.380661933816, 6196.69016549173, 4104.261232978063, 4172.853950111747, 6688.699008544603, 6773.221079575863, 6780.084688567054, 6115.755369785204, 6341.556091073627, 6748.291429399916, 6764.797056088325, 6765.32346765322, 6027.9095813562835, 6032.0, 6037.4566289033755, 6039.516838652898, 6040.184575082351, 13244.735105297936, 13611.52359667407, 13649.249291288976, 13801.447942082305, 13878.028538002243, 2676.384431580728, 2679.0623281851194, 2699.5680691089333, 2712.715164907696, 2714.1586108306487, 9949.154321882648, 10041.393377059709, 10113.64602238918, 10422.739431514272, 10489.318194317346, 1798.5323815807853, 1806.2955447375534, 1829.923037352601, 1856.155449270592, 1866.7586055273227, 140506.0, 143194.0, 144875.0, 145450.0, 145579.27210363987, 11939.820902686466, 11941.283522988475, 12071.094667899943, 12076.939615301868, 12240.57263966091, 16002.199890005453, 16024.439144630116, 16030.0, 16036.278367473258, 16060.598485037968, 8692.652293908173, 8867.201951824367, 8910.732678019669, 8918.464892106495, 8986.046139698512, 8655.264302534355, 8682.86975695365, 8692.652293908173, 8868.689595864244, 8879.33404994628, 4709.835155769531, 4716.811327546929, 4743.5967942724565, 4744.810207591727, 4787.928181077286, 1975.0914579293685, 2022.5535111151034, 2028.5942811437476, 2036.328011756117, 2043.6832290994919, 984.5569493727851, 1015.2690063154517, 1019.8419245016886, 1032.3289861590026, 1035.7565971996576, 21033.263835765676, 21859.781402186094, 22197.667034994487, 22288.331350059525, 22337.553248935255, 1042.8528618519567, 1044.1698849414734, 1052.315994603514, 1055.2824079625927, 1057.7831544533353, 10772.0, 11532.25040372373, 11597.76804463906, 11618.302901825917, 11654.53381864716, 702770.0, 746597.0, 768945.0, 769741.0, 789139.0, 97903.51048244713, 110989.56588690051, 124040.37979810043, 129251.70748292585, 139833.0, 965.9565319560637, 973.8052389521982, 1017.8371460566274, 1021.9693409197736, 1023.053675350298, 16053.578072677663, 17479.650406991535, 20309.390718278475, 20949.89525052426, 21107.683384748932, 48476.7576162117, 55920.92434915956, 55983.72008139933, 57241.42758572527, 61072.0, 63922.0, 82050.17949820663, 84207.5789621048, 85049.1495085066, 85781.0, 7401.815709486456, 8110.432269741062, 8458.492490450593, 8555.443896146731, 8584.141585841366, 8563.272121869712, 10207.897921020694, 12460.937695311466, 13246.006549508633, 13536.187828730308, 11433.828492572451, 11629.825552616549, 11752.294862308288, 11894.583689571169, 11982.340971246316, 11450.0, 11534.480948357512, 11580.131490138105, 11860.40697965081, 11886.465109069939, 11617.535298587962, 11874.525018999144, 11905.52377904874, 12087.335196564274, 12093.57672481459, 8230.588470576327, 8353.916460835557, 8572.3999320047, 8737.694180703646, 8804.251638610789, 9370.484623345781, 11576.884231157917, 11617.128715346214, 11656.0, 11936.701582460508], "value": 9845.454638386425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.8437695288087, 1260.4832018872262, 1426.6290764401253, 1433.6630891740447, 1433.8637829406202, 8068.878966815495, 8527.019392769833, 8534.274586660142, 8546.615402306896, 8556.27271681907, 7466.440016998733, 7756.689732410697, 7774.37804975602, 8123.959380203106, 8159.428839981204, 2294.9770502295014, 2330.6154484510034, 2333.53329334133, 2341.3444235614056, 2342.320726989171, 2324.0471406723245, 2356.8350215484925, 2362.2676970139228, 2368.692070030894, 2372.78644921957, 2026.7871873453296, 2103.7791031941656, 2108.4728817795553, 2110.3246960972497, 2293.392251053472, 1654.454030170041, 2086.2593779208314, 2098.4544018555134, 2098.7271654684946, 2105.0632468551503, 2300.298408985259, 2315.895784689693, 2373.2761507740133, 2375.608024675944, 2386.6300723387903, 8316.0, 8417.621207045697, 8418.368622353286, 8423.915760842436, 8430.367722420782, 5104.2088476286235, 5249.160134378481, 5250.474952504757, 5266.0, 5271.182966640138, 3404.9489257661153, 3440.518327434161, 3459.39460594395, 3479.043263102667, 3549.201429678302, 1075.231209685071, 1194.6535504703625, 1200.7358381156132, 1232.6795033291319, 1246.6073186946082, 10672.946635266851, 10757.031867131996, 10758.300710453874, 10859.83710244347, 10887.727806804814, 4216.430781844473, 4489.5959363656775, 4651.348811166439, 4730.195866702668, 4731.266653668687, 9573.569189386495, 9578.808423831624, 9587.760305992266, 9608.615655373707, 9611.951940240255, 5035.521625445577, 5066.392032956069, 5070.315507406527, 5070.543651071422, 5081.060003899291, 4209.642180414699, 4350.129974005212, 4532.864014079583, 4580.221362368406, 4683.344331793552, 3397.94663654263, 3763.6800871926193, 3808.6000969898314, 3908.882733517999, 3948.9210215796097, 1236.1038247270837, 1261.3314943080181, 1261.5710658376013, 1273.5860845225338, 1273.6370134511806, 915.3638221436038, 915.8076803871129, 918.5269586163131, 928.1924725488868, 954.9140577348072, 5590.552755779528, 5783.797567085132, 5832.3292821326095, 5955.880882382415, 6118.908216376758, 845.2730651639584, 893.8748575199477, 953.3850666320185, 997.0278977996395, 1020.9744756381001, 3481.56480439945, 3857.691384689218, 3898.8245528951265, 4044.2315959967514, 4080.7755573443746, 9892.950535247277, 10091.747706307255, 10094.949525252474, 10098.242631802645, 10128.645497407555, 9759.12167904892, 9786.266030047775, 10032.44821534808, 10058.949705251573, 10092.990700929848, 7749.4575379724, 7982.1618730032515, 7985.560794156261, 7991.480553763987, 8036.83926321482, 5294.841154765363, 5498.972505137449, 5550.222968784293, 5626.2967129108865, 5783.884322313615, 8988.191062804379, 9359.625614975324, 9365.625374984924, 9430.52847357643, 9481.76295592588, 9170.908290917005, 9319.207867331354, 9453.054694530492, 9589.856152157863, 9592.520373981133, 7146.428285737233, 7203.747868824566, 7214.2064372917885, 7285.526440781332, 7331.74338898136, 7851.0, 7927.365810735243, 7928.207179282025, 7941.920580794118, 7949.165337639464, 6883.8967415487805, 7066.540674856118, 7190.820229494305, 7225.24134965821, 7292.197858235696, 6803.897941530782, 6846.281140480178, 6915.273896240822, 6968.9546568013175, 7003.124609423822, 6411.0, 6432.195975503062, 6526.510511711545, 6528.804135875931, 6542.967285163544, 5010.749462526932, 5053.29253904461, 5058.570021548209, 5068.949310506848, 5093.363329583802, 4936.160852655129, 4964.156093464192, 4975.925361119514, 5065.645404821775, 5136.845894623168], "value": 4414.292156472658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.5381749907621, 362.9004117523902, 367.7903594950877, 370.60160327647753, 370.87575662153176, 4376.452943382077, 4572.725636461811, 4911.631627627924, 5216.374035115787, 5222.373315202181, 4950.678205916622, 4969.577585905203, 5183.611229157809, 5228.0850851101095, 5294.311739473873, 2999.4151140527606, 3992.8602498912614, 4061.547684468193, 4156.446238466098, 4156.521999969997, 3590.9711013277547, 4089.7546147231114, 4103.953491859572, 4118.414410451983, 4161.417401563784, 3608.899285717855, 3612.4761909523104, 3751.0809851586264, 4026.5369482509445, 4125.752454852718, 3911.550171730245, 3932.1152740633415, 4028.8992775180855, 4061.6547593454593, 4151.398047283157, 3586.5696116466193, 3660.1764602964386, 3662.450632405134, 3684.1342284563107, 3700.481932529448, 4181.749095054276, 4341.696081274312, 5025.648204625678, 5212.270282160501, 5213.0, 4637.884052898671, 4672.486026537078, 4705.998763141621, 4785.593224575915, 4796.376471058775, 5485.341758988907, 5506.421825708283, 5531.446855314477, 5536.972315138399, 5623.887522249532, 4037.707933461264, 4044.1911617676287, 4060.553339132693, 4080.897977550585, 4086.9795651021554, 5051.823186188466, 5173.473825221568, 5357.196420536911, 5701.458361455738, 5776.220210271602, 3844.5386553613744, 4117.2588933992165, 4124.422580838685, 4141.5237247716295, 4158.045718512294, 4152.671145233497, 4187.581241875849, 4197.769122698281, 4216.9578304217175, 4223.957760422418, 4486.68593198473, 4707.811687532529, 4753.500882407367, 4768.642351823627, 4782.33047373368, 4662.461387742037, 4905.583025442806, 5585.944140558542, 5595.4124816894455, 5680.914786278209, 1117.4692021289984, 1192.6362459449776, 1231.8789901189875, 1270.7077372204444, 1337.4650139944101, 735.8270806360501, 920.7790130368797, 953.7234202081457, 957.2963871554402, 977.8924318324979, 4737.668363214542, 4843.190949249427, 4850.393700787402, 4857.546938795886, 4867.975660121677, 5151.407588127413, 5239.921401178985, 5290.92063619046, 5398.838034858961, 5432.782688692487, 4078.286299897506, 4596.414237088199, 4747.881302967454, 4832.51674832521, 4842.903141937141, 2360.8347415680737, 2498.5502609530095, 2606.614947323216, 2813.338865366637, 2821.8730157142977, 4643.049919034014, 4672.486026537078, 5505.504504594605, 5537.5569954404355, 5565.526930210896, 4647.95352046482, 5407.83776486706, 5571.860703482445, 5583.259216325072, 5639.3232812062, 4975.477574854588, 5246.3704355477585, 5872.530197584183, 5912.925278854971, 5948.650283138223, 4766.711978250529, 5666.744996475251, 5728.341240757366, 5744.0, 5749.798757043483, 4702.412198475191, 5262.500062494057, 5556.888862222814, 5576.525995290446, 5583.162525621189, 5148.510891465305, 5340.863654538216, 5596.636218645775, 5625.0, 5797.608399086582, 3728.4407338898295, 3805.771653700787, 3830.463735077036, 3855.267499175148, 3868.2456920900154, 4773.474917759113, 5286.97356513215, 5362.329708786402, 5676.460736230051, 5705.860302386605, 4393.29707246839, 4887.3117293486885, 4936.901261974668, 5516.586256030894, 5573.554115670818, 5020.949790502194, 5302.9659216453965, 5557.972210138923, 5581.5813813963305, 5671.206031155724, 4453.465584129925, 4508.0, 5457.345118585795, 5458.808941687022, 5476.946145195551, 4925.5715842406735, 5385.299911011543, 5523.226748255328, 5554.944450555605, 5601.579881508985, 4791.592714619296, 5470.945290547043, 5478.45215478449, 5482.862928426821, 5501.0], "value": 4039.4580648438564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.5634837355718, 711.190021395548, 727.3344889426176, 811.1077814404156, 812.8618134917064, 14860.851391486081, 15403.460878869242, 15432.382704691827, 15842.999999999985, 15872.444464443746, 14325.785113223284, 14508.274586270698, 14521.12873227607, 14534.273286335667, 14546.981711280214, 677.5460441504204, 697.8708938846304, 700.0933790741003, 858.1375717404031, 871.5032431514039, 858.2318824651933, 875.374107513128, 878.9340799440035, 891.8617614269799, 893.0266010049045, 903.9774005649879, 906.084854297158, 906.8458362078429, 921.1847514949285, 951.6621599332241, 715.889037199235, 739.6043116932469, 939.2392162348519, 940.196132306878, 945.1588086602928, 670.2325836916704, 677.5663575311804, 685.3215316836346, 694.2987582541618, 697.1425147069133, 14725.484608038774, 15451.690966180726, 15502.147381893992, 15511.844881551153, 15537.689246215126, 10977.780444391148, 13543.39054742539, 13561.389737461837, 13588.59234222975, 13603.455861765517, 12396.566120185751, 12523.0, 12568.30874301913, 13015.609531714064, 13042.347882605927, 4377.102693947733, 4397.362382454558, 4433.889152771174, 4459.955400446019, 4556.316552517116, 94035.0, 96298.0, 101442.49278753632, 101488.0, 102513.0, 10171.898281017244, 10248.538815753309, 10360.119389851947, 10529.0, 10604.310719803188, 19832.0, 19923.0, 20055.59888802216, 20161.899190503955, 20218.191272349235, 7611.4291428143115, 7730.188330225358, 7732.226777322223, 7736.9342585064505, 7836.686532538749, 4261.4673165854265, 4346.1090476452255, 4386.298192289219, 4432.202203603382, 4462.973516091252, 3488.4418493040994, 3599.1002249437643, 3599.1721903962234, 3599.3341231872187, 3604.711623070148, 632.9461995730322, 641.2657507154282, 646.8447572582546, 650.7754824585511, 659.0378048049805, 644.7936660268763, 650.5413683353224, 651.7621068310033, 658.713459645056, 675.4461341699857, 9423.670171543963, 9956.352837065568, 10112.191024718006, 10114.645987390406, 10200.4389758564, 510.9642325037286, 593.5044238061267, 612.8039027511154, 628.9276733175652, 655.9737610495622, 4633.189191891405, 4926.975365123151, 4959.330490383752, 4959.553640172329, 4970.701757894538, 93990.0, 96154.0, 102579.487102564, 105983.0, 106382.0, 70119.0, 85927.70361481901, 89511.55244223737, 90042.54978725064, 92496.0, 60481.0, 61069.0, 75459.62270188723, 78337.60831195922, 79483.0, 9355.953220233856, 9519.90480095218, 9553.474558899326, 9557.52212389364, 9557.808843823224, 49876.00247995093, 53201.7339913298, 55772.442275578345, 57212.14181787193, 57861.13208301963, 63235.6838215806, 66518.0, 69226.0, 69771.651141746, 72432.0, 13143.802842957555, 13373.39819708096, 13458.52895148665, 13632.863671363159, 13657.180569165881, 14336.856631433553, 14393.064450810663, 15129.621759456102, 15311.464098756936, 15536.378544858078, 13396.0, 13451.663708407368, 13629.522966696119, 13996.300184990507, 14456.710865782836, 13133.605991819879, 13173.47306107745, 13908.791368129689, 13956.651083722989, 14098.50655227062, 12789.488420463449, 13278.734425311246, 13605.183688978694, 14275.500357487437, 14290.499832505813, 10914.598832806267, 10941.781164376827, 11094.0, 11529.020033296929, 11698.590549330733, 8649.610767515604, 9316.860247096163, 11002.449877506253, 11106.555737770399, 11208.327500350006], "value": 7471.7017852814015, "unit": "score"}], "name": "dromaeo_css", "value": 7293.246753050426, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 138.0, 137.0, 142.0, 110.0, 109.0, 108.0, 111.0, 142.0, 109.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 185.0, 182.0, 184.0, 181.0, 185.0, 183.0, 184.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 61.0, 104.0, 86.0, 80.0, 58.0, 60.0, 73.0, 59.0], "value": 71.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 86.0, 69.0, 68.0, 70.0, 81.0, 68.0, 68.0, 82.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 86.0, 85.0, 87.0, 84.0, 89.0, 85.0, 87.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 92.0, 94.0, 93.0, 94.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 98.0, 142.0, 85.0, 86.0, 88.0, 85.0, 88.0, 88.0, 86.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 56.0, 57.0, 55.0, 59.0, 79.0, 87.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 71.0, 76.0, 76.0, 70.0, 69.0, 70.0, 70.0, 73.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 84.0, 89.0, 85.0, 84.0, 83.0, 85.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 149.0, 134.0, 140.0, 140.0, 151.0, 154.0, 140.0, 183.0, 139.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 165.0, 168.0, 173.0, 165.0, 168.0, 164.0, 162.0, 166.0, 167.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 66.0, 66.0, 67.0, 65.0, 67.0, 64.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1436.1, "alertThreshold": 2.0}]} 14:18:56 INFO - Return code: 0 14:18:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:18:56 ERROR - # TBPL SUCCESS # 14:18:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:18:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:18:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:18:56 INFO - 2017-01-26 14:18:56.763 screenresolution[1650:9731] starting screenresolution argv=screenresolution get 14:18:56 INFO - 2017-01-26 14:18:56.765 screenresolution[1650:9731] Display 0: 1600x1200x32@60 14:18:56 INFO - 2017-01-26 14:18:56.772 screenresolution[1651:9734] starting screenresolution argv=screenresolution list 14:18:56 INFO - Available Modes on Display 0 14:18:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:18:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:18:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:18:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:18:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:18:57 INFO - Intel Iris: 14:18:57 INFO - Chipset Model: Intel Iris 14:18:57 INFO - Type: GPU 14:18:57 INFO - Bus: Built-In 14:18:57 INFO - VRAM (Dynamic, Max): 1536 MB 14:18:57 INFO - Vendor: Intel (0x8086) 14:18:57 INFO - Device ID: 0x0a2e 14:18:57 INFO - Revision ID: 0x0009 14:18:57 INFO - Displays: 14:18:57 INFO - Display: 14:18:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:18:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:18:57 INFO - Display Serial Number: 1600x1200 60 14:18:57 INFO - Main Display: Yes 14:18:57 INFO - Mirror: Off 14:18:57 INFO - Online: Yes 14:18:57 INFO - Rotation: Supported 14:18:57 INFO - Return code: 0 14:18:57 INFO - Running post-action listener: _resource_record_post_action 14:18:57 INFO - [mozharness: 2017-01-26 22:18:57.009512Z] Finished run-tests step (success) 14:18:57 INFO - Running post-run listener: _resource_record_post_run 14:18:57 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 38958080; Write bytes: 510464000; Read time: 388; Write time: 2033 14:18:57 INFO - TinderboxPrint: CPU usage
53.6% 14:18:57 INFO - TinderboxPrint: I/O read bytes / time
38,958,080 / 388 14:18:57 INFO - TinderboxPrint: I/O write bytes / time
510,464,000 / 2,033 14:18:57 INFO - TinderboxPrint: CPU idle
2,223.8 (46.4%) 14:18:57 INFO - TinderboxPrint: CPU system
961.0 (20.0%) 14:18:57 INFO - TinderboxPrint: CPU user
1,608.8 (33.6%) 14:18:57 INFO - TinderboxPrint: Swap in / out
246,525,952 / 0 14:18:57 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205275648; Write bytes: 202422272; Read time: 15566; Write time: 671 14:18:57 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34501632; Write bytes: 296949760; Read time: 351; Write time: 1323 14:18:57 INFO - Running post-run listener: _upload_blobber_files 14:18:57 INFO - Blob upload gear active. 14:18:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:18:57 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 14:18:57 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'] 14:18:57 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 14:18:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:18:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:18:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:58 INFO - (blobuploader) - INFO - Done attempting. 14:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:18:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:59 INFO - (blobuploader) - INFO - Done attempting. 14:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:19:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:00 INFO - (blobuploader) - INFO - Done attempting. 14:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:02 INFO - (blobuploader) - INFO - Done attempting. 14:19:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:19:02 INFO - Return code: 0 14:19:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:19:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:19:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f744fc3db9f7f54696880d6f5dc9f892dc7f2309405644d3c0cd82a2483929cbc6eb53bb74f79ed48c3677056937a516fd825440ca47705a084a24f3071afa25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/640ad82c0983a4426d581365d237447e0e1dc71aad32ee4b587079960bbdd4a4138bf1f2bb4ac176ada48fbebf5f214b3205c7b2a1aefb14880655c42f38a1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2deb77bd9485fe65ed43f45c82ca4fb6769c36432df89fefe609ba20a5ce12de68ac507805f3f410b6d7f76f7a457d63ae1b6f25b81672041cad6f5785bd53d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d247ef4ea55ef27f624ebb31ba909748393c114a71659b1908c0b3811e7979dca17b1c9b0929dcd862f8848c96ba8d4fe149d70989624ebb392a56d481dd2f02"} 14:19:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:19:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:19:02 INFO - Contents: 14:19:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f744fc3db9f7f54696880d6f5dc9f892dc7f2309405644d3c0cd82a2483929cbc6eb53bb74f79ed48c3677056937a516fd825440ca47705a084a24f3071afa25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/640ad82c0983a4426d581365d237447e0e1dc71aad32ee4b587079960bbdd4a4138bf1f2bb4ac176ada48fbebf5f214b3205c7b2a1aefb14880655c42f38a1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2deb77bd9485fe65ed43f45c82ca4fb6769c36432df89fefe609ba20a5ce12de68ac507805f3f410b6d7f76f7a457d63ae1b6f25b81672041cad6f5785bd53d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d247ef4ea55ef27f624ebb31ba909748393c114a71659b1908c0b3811e7979dca17b1c9b0929dcd862f8848c96ba8d4fe149d70989624ebb392a56d481dd2f02"} 14:19:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:19:02 INFO - Copying logs to upload dir... 14:19:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:19:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.524835 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-26 14:19:02.827497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 14:19:02.831116) ========= 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.cckyULmSGd/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.H6ehmMLhJ7/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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/f744fc3db9f7f54696880d6f5dc9f892dc7f2309405644d3c0cd82a2483929cbc6eb53bb74f79ed48c3677056937a516fd825440ca47705a084a24f3071afa25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/640ad82c0983a4426d581365d237447e0e1dc71aad32ee4b587079960bbdd4a4138bf1f2bb4ac176ada48fbebf5f214b3205c7b2a1aefb14880655c42f38a1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2deb77bd9485fe65ed43f45c82ca4fb6769c36432df89fefe609ba20a5ce12de68ac507805f3f410b6d7f76f7a457d63ae1b6f25b81672041cad6f5785bd53d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d247ef4ea55ef27f624ebb31ba909748393c114a71659b1908c0b3811e7979dca17b1c9b0929dcd862f8848c96ba8d4fe149d70989624ebb392a56d481dd2f02"} build_url:https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010972 build_url: 'https://queue.taskcluster.net/v1/task/NQaAxZExTNaiLK4uBxdhKw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f744fc3db9f7f54696880d6f5dc9f892dc7f2309405644d3c0cd82a2483929cbc6eb53bb74f79ed48c3677056937a516fd825440ca47705a084a24f3071afa25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/640ad82c0983a4426d581365d237447e0e1dc71aad32ee4b587079960bbdd4a4138bf1f2bb4ac176ada48fbebf5f214b3205c7b2a1aefb14880655c42f38a1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2deb77bd9485fe65ed43f45c82ca4fb6769c36432df89fefe609ba20a5ce12de68ac507805f3f410b6d7f76f7a457d63ae1b6f25b81672041cad6f5785bd53d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d247ef4ea55ef27f624ebb31ba909748393c114a71659b1908c0b3811e7979dca17b1c9b0929dcd862f8848c96ba8d4fe149d70989624ebb392a56d481dd2f02"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 14:19:02.865985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 14:19:02.866378) ========= 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.cckyULmSGd/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.H6ehmMLhJ7/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005223 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 14:19:02.915628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 14:19:02.915971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 14:19:02.916295) ========= ========= Total master_lag: 0.19 =========