builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0169 starttime: 1475246120.91 results: success (0) buildid: 20160930013320 builduid: aa5c9bca12eb4c9481f5747ff57287d7 revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.911826) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.912214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.912513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.220051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.220313) ========= 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.YGUwfemp3x/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.putTdYdWlo/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 --2016-09-30 07:35:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.3M=0s 2016-09-30 07:35:21 (29.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.572609 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.818810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.819091) ========= 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.YGUwfemp3x/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.putTdYdWlo/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.027360 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.866687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:21.867004) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --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 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YGUwfemp3x/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.putTdYdWlo/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 2016-09-30 07:35:21,936 truncating revision to first 12 chars 2016-09-30 07:35:21,936 Setting DEBUG logging. 2016-09-30 07:35:21,936 attempt 1/10 2016-09-30 07:35:21,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/805d5fc3d66c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 07:35:23,279 unpacking tar archive at: mozilla-aurora-805d5fc3d66c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:23.479809) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.480086) ========= script_repo_revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.483494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.483774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.509905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-30 07:35:23.510192) ========= /tools/buildbot/bin/python 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', '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.YGUwfemp3x/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.putTdYdWlo/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:35:23 INFO - MultiFileLogger online at 20160930 07:35:23 in /builds/slave/test 07:35:23 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 07:35:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:23 INFO - {'append_to_log': False, 07:35:23 INFO - 'base_work_dir': '/builds/slave/test', 07:35:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:35:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:23 INFO - 'branch': 'Mozilla-Aurora', 07:35:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:23 INFO - 'config_files': ('talos/mac_config.py',), 07:35:23 INFO - 'default_actions': ('clobber', 07:35:23 INFO - 'read-buildbot-config', 07:35:23 INFO - 'download-and-extract', 07:35:23 INFO - 'populate-webroot', 07:35:23 INFO - 'create-virtualenv', 07:35:23 INFO - 'install', 07:35:23 INFO - 'run-tests'), 07:35:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:23 INFO - 'download_minidump_stackwalk': True, 07:35:23 INFO - 'download_symbols': 'ondemand', 07:35:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:23 INFO - 'installer_path': 'installer.exe', 07:35:23 INFO - 'log_level': 'info', 07:35:23 INFO - 'log_name': 'talos', 07:35:23 INFO - 'log_to_console': True, 07:35:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:23 INFO - 'opt_config_files': (), 07:35:23 INFO - 'pip_index': False, 07:35:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'run_cmd_checks_enabled': True, 07:35:23 INFO - 'sps_profile': False, 07:35:23 INFO - 'sps_profile_interval': 0, 07:35:23 INFO - 'suite': 'dromaeojs', 07:35:23 INFO - 'system_bits': '32', 07:35:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:23 INFO - 'title': 't-yosemite-r7-0169', 07:35:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:23 INFO - 'use_talos_json': True, 07:35:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:23 INFO - 'work_dir': 'build'} 07:35:23 INFO - [mozharness: 2016-09-30 14:35:23.705204Z] Running clobber step. 07:35:23 INFO - Running pre-action listener: _resource_record_pre_action 07:35:23 INFO - Running main action method: clobber 07:35:23 INFO - rmtree: /builds/slave/test/build 07:35:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.836099Z] Finished clobber step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.836232Z] Running read-buildbot-config step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: read_buildbot_config 07:35:25 INFO - Using buildbot properties: 07:35:25 INFO - { 07:35:25 INFO - "project": "", 07:35:25 INFO - "product": "firefox", 07:35:25 INFO - "script_repo_revision": "production", 07:35:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:35:25 INFO - "repository": "", 07:35:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:35:25 INFO - "buildid": "20160930013320", 07:35:25 INFO - "pgo_build": "False", 07:35:25 INFO - "basedir": "/builds/slave/test", 07:35:25 INFO - "buildnumber": 61, 07:35:25 INFO - "slavename": "t-yosemite-r7-0169", 07:35:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:35:25 INFO - "platform": "yosemite_r7", 07:35:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:35:25 INFO - "branch": "mozilla-aurora", 07:35:25 INFO - "repo_path": "releases/mozilla-aurora", 07:35:25 INFO - "revision": "805d5fc3d66c4fa585a3de407b1e0b055f78eb58", 07:35:25 INFO - "stage_platform": "macosx64", 07:35:25 INFO - "builduid": "aa5c9bca12eb4c9481f5747ff57287d7", 07:35:25 INFO - "slavebuilddir": "test" 07:35:25 INFO - } 07:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.839575Z] Finished read-buildbot-config step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.839657Z] Running download-and-extract step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: download_and_extract 07:35:25 INFO - mkdir: /builds/slave/test/build/tests 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:25 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:35:26 INFO - Downloaded 1199 bytes. 07:35:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:26 INFO - Using the following test package requirements: 07:35:26 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:35:26 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:35:26 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'jsshell-mac.zip'], 07:35:26 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:35:26 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:35:26 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:35:26 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:35:26 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:35:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:35:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:27 INFO - Expected file size: 16433807 07:35:34 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:35:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:35 INFO - Expected file size: 16433807 07:35:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:35:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:35:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:35:42 INFO - Expected file size: 14414059 07:35:43 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')]} 07:35:43 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:35:46 INFO - Downloaded 115275136 bytes. 07:35:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:46 INFO - mkdir: /builds/slave/test/properties 07:35:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:46 INFO - Contents: 07:35:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:46 INFO - Running post-action listener: _resource_record_post_action 07:35:46 INFO - Running post-action listener: set_extra_try_arguments 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.881459Z] Finished download-and-extract step (success) 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.881618Z] Running populate-webroot step. 07:35:46 INFO - Running pre-action listener: _resource_record_pre_action 07:35:46 INFO - Running main action method: populate_webroot 07:35:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:46 INFO - '--tppagecycles', 07:35:46 INFO - '7'], 07:35:46 INFO - 'tests': ['tsvgm']}}, 07:35:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['damp', 'tps']}, 07:35:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['damp', 'tps']}, 07:35:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['dromaeo_dom']}, 07:35:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['basic_compositor_video']}, 07:35:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tsvgx', 07:35:46 INFO - 'tsvgr_opacity', 07:35:46 INFO - 'tart', 07:35:46 INFO - 'tscrollx', 07:35:46 INFO - 'cart']}, 07:35:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:46 INFO - 'tsvgr_opacity', 07:35:46 INFO - 'tart', 07:35:46 INFO - 'tscrollx', 07:35:46 INFO - 'cart']}, 07:35:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tp5o']}, 07:35:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['tp5o']}, 07:35:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s', 07:35:46 INFO - '--xperf_path', 07:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:46 INFO - 'tests': ['tp5n']}, 07:35:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--xperf_path', 07:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:46 INFO - 'tests': ['tp5n']}}, 07:35:46 INFO - 'talos.zip': {'path': '', 07:35:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:46 INFO - Running post-action listener: _resource_record_post_action 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.900547Z] Finished populate-webroot step (success) 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.900658Z] Running create-virtualenv step. 07:35:46 INFO - Running pre-action listener: _resource_record_pre_action 07:35:46 INFO - Running main action method: create_virtualenv 07:35:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:46 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 07:35:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:47 INFO - Using real prefix '/tools/python27' 07:35:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:50 INFO - Installing pip.................done. 07:35:50 INFO - Return code: 0 07:35:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:35:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:50 INFO - 'HOME': '/Users/cltbld', 07:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:50 INFO - 'LOGNAME': 'cltbld', 07:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:50 INFO - 'MOZ_NO_REMOTE': '1', 07:35:50 INFO - 'NO_EM_RESTART': '1', 07:35:50 INFO - 'PAGER': '/bin/cat', 07:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:50 INFO - 'PWD': '/builds/slave/test', 07:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:50 INFO - 'SHELL': '/bin/bash', 07:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:35:50 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:50 INFO - 'USER': 'cltbld', 07:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:50 INFO - 'XPC_FLAGS': '0x0', 07:35:50 INFO - 'XPC_SERVICE_NAME': '0', 07:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:50 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 07:35:50 INFO - Cleaning up... 07:35:50 INFO - Return code: 0 07:35:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:35:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:50 INFO - 'HOME': '/Users/cltbld', 07:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:50 INFO - 'LOGNAME': 'cltbld', 07:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:50 INFO - 'MOZ_NO_REMOTE': '1', 07:35:50 INFO - 'NO_EM_RESTART': '1', 07:35:50 INFO - 'PAGER': '/bin/cat', 07:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:50 INFO - 'PWD': '/builds/slave/test', 07:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:50 INFO - 'SHELL': '/bin/bash', 07:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:35:50 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:50 INFO - 'USER': 'cltbld', 07:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:50 INFO - 'XPC_FLAGS': '0x0', 07:35:50 INFO - 'XPC_SERVICE_NAME': '0', 07:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 INFO - Downloading/unpacking psutil>=3.1.1 07:35:51 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 07:35:51 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 07:35:51 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 07:35:51 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 07:35:51 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 07:35:51 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 07:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:54 INFO - Installing collected packages: psutil 07:35:54 INFO - Running setup.py install for psutil 07:35:55 INFO - building 'psutil._psutil_osx' extension 07:35:55 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 07:35:55 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 07:35:55 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 07:35:55 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 07:35:55 INFO - building 'psutil._psutil_posix' extension 07:35:55 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 07:35:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:55 INFO - ^ 07:35:55 INFO - 1 warning generated. 07:35:55 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 07:35:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:56 INFO - Successfully installed psutil 07:35:56 INFO - Cleaning up... 07:35:56 INFO - Return code: 0 07:35:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:56 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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:35:56 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 07:35:56 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 07:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:56 INFO - 'HOME': '/Users/cltbld', 07:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:56 INFO - 'LOGNAME': 'cltbld', 07:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:56 INFO - 'MOZ_NO_REMOTE': '1', 07:35:56 INFO - 'NO_EM_RESTART': '1', 07:35:56 INFO - 'PAGER': '/bin/cat', 07:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:56 INFO - 'PWD': '/builds/slave/test', 07:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:56 INFO - 'SHELL': '/bin/bash', 07:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:35:56 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:56 INFO - 'USER': 'cltbld', 07:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:56 INFO - 'XPC_FLAGS': '0x0', 07:35:56 INFO - 'XPC_SERVICE_NAME': '0', 07:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:56 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 07:35:56 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 07:35:56 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 07:35:56 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 07:35:56 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 07:35:56 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 07:35:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:58 INFO - Installing collected packages: mozsystemmonitor 07:35:58 INFO - Running setup.py install for mozsystemmonitor 07:35:59 INFO - Successfully installed mozsystemmonitor 07:35:59 INFO - Cleaning up... 07:35:59 INFO - Return code: 0 07:35:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:35:59 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 07:35:59 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 07:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:59 INFO - 'HOME': '/Users/cltbld', 07:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:59 INFO - 'LOGNAME': 'cltbld', 07:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:59 INFO - 'MOZ_NO_REMOTE': '1', 07:35:59 INFO - 'NO_EM_RESTART': '1', 07:35:59 INFO - 'PAGER': '/bin/cat', 07:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:59 INFO - 'PWD': '/builds/slave/test', 07:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:59 INFO - 'SHELL': '/bin/bash', 07:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:35:59 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:59 INFO - 'USER': 'cltbld', 07:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:59 INFO - 'XPC_FLAGS': '0x0', 07:35:59 INFO - 'XPC_SERVICE_NAME': '0', 07:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:59 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 07:35:59 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 07:35:59 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 07:35:59 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 07:35:59 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 07:35:59 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 07:36:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:01 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 07:36:01 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 07:36:01 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 07:36:01 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 07:36:01 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 07:36:01 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 07:36:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:02 INFO - warning: no files found matching '*.txt' 07:36:02 INFO - no previously-included directories found matching 'build' 07:36:02 INFO - no previously-included directories found matching 'dist' 07:36:02 INFO - no previously-included directories found matching '.git*' 07:36:02 INFO - Installing collected packages: jsonschema, functools32 07:36:02 INFO - Running setup.py install for functools32 07:36:02 INFO - warning: no files found matching '*.txt' 07:36:02 INFO - no previously-included directories found matching 'build' 07:36:02 INFO - no previously-included directories found matching 'dist' 07:36:02 INFO - no previously-included directories found matching '.git*' 07:36:02 INFO - Successfully installed jsonschema functools32 07:36:02 INFO - Cleaning up... 07:36:02 INFO - Return code: 0 07:36:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:02 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')]} 07:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 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')]} 07:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:36:02 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 07:36:02 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 07:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:02 INFO - 'HOME': '/Users/cltbld', 07:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:02 INFO - 'LOGNAME': 'cltbld', 07:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:02 INFO - 'MOZ_NO_REMOTE': '1', 07:36:02 INFO - 'NO_EM_RESTART': '1', 07:36:02 INFO - 'PAGER': '/bin/cat', 07:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:02 INFO - 'PWD': '/builds/slave/test', 07:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:02 INFO - 'SHELL': '/bin/bash', 07:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:36:02 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:02 INFO - 'USER': 'cltbld', 07:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:02 INFO - 'XPC_FLAGS': '0x0', 07:36:02 INFO - 'XPC_SERVICE_NAME': '0', 07:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:02 INFO - Cleaning up... 07:36:02 INFO - Return code: 0 07:36:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:02 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')]} 07:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 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')]} 07:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:36:02 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 07:36:02 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 07:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:02 INFO - 'HOME': '/Users/cltbld', 07:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:02 INFO - 'LOGNAME': 'cltbld', 07:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:02 INFO - 'MOZ_NO_REMOTE': '1', 07:36:02 INFO - 'NO_EM_RESTART': '1', 07:36:02 INFO - 'PAGER': '/bin/cat', 07:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:02 INFO - 'PWD': '/builds/slave/test', 07:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:02 INFO - 'SHELL': '/bin/bash', 07:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:36:02 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:02 INFO - 'USER': 'cltbld', 07:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:02 INFO - 'XPC_FLAGS': '0x0', 07:36:02 INFO - 'XPC_SERVICE_NAME': '0', 07:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - Downloading docopt-0.6.1.tar.gz 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:06 INFO - Running setup.py install for blobuploader 07:36:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:07 INFO - Running setup.py install for requests 07:36:07 INFO - Running setup.py install for docopt 07:36:07 INFO - Successfully installed blobuploader requests docopt 07:36:07 INFO - Cleaning up... 07:36:07 INFO - Return code: 0 07:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:07 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')]} 07:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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')]} 07:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:36:07 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 07:36:07 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 07:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:07 INFO - 'HOME': '/Users/cltbld', 07:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:07 INFO - 'LOGNAME': 'cltbld', 07:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:07 INFO - 'MOZ_NO_REMOTE': '1', 07:36:07 INFO - 'NO_EM_RESTART': '1', 07:36:07 INFO - 'PAGER': '/bin/cat', 07:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:07 INFO - 'PWD': '/builds/slave/test', 07:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:07 INFO - 'SHELL': '/bin/bash', 07:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:36:07 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:07 INFO - 'USER': 'cltbld', 07:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:07 INFO - 'XPC_FLAGS': '0x0', 07:36:07 INFO - 'XPC_SERVICE_NAME': '0', 07:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-85Bg9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-O9qfFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-F0u2jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ykU6uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-DnVN4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-hfFs_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-19e67m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-HnIIgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-_n8vwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-pvakzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-XSNcJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ucMV0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-VFm2KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-iafrBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-unnv7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-WdtS5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-HnNhcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:09 INFO - Running setup.py install for manifestparser 07:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozcrash 07:36:10 INFO - Running setup.py install for mozdebug 07:36:10 INFO - Running setup.py install for mozdevice 07:36:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozfile 07:36:10 INFO - Running setup.py install for mozhttpd 07:36:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozinfo 07:36:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozInstall 07:36:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozleak 07:36:11 INFO - Running setup.py install for mozlog 07:36:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for moznetwork 07:36:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozprocess 07:36:11 INFO - Running setup.py install for mozprofile 07:36:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozrunner 07:36:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozscreenshot 07:36:12 INFO - Running setup.py install for moztest 07:36:12 INFO - Running setup.py install for mozversion 07:36:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:12 INFO - Cleaning up... 07:36:12 INFO - Return code: 0 07:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:12 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')]} 07:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:12 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')]} 07:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:12 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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:36:12 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 07:36:12 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 07:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:12 INFO - 'HOME': '/Users/cltbld', 07:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:12 INFO - 'LOGNAME': 'cltbld', 07:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:12 INFO - 'MOZ_NO_REMOTE': '1', 07:36:12 INFO - 'NO_EM_RESTART': '1', 07:36:12 INFO - 'PAGER': '/bin/cat', 07:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:12 INFO - 'PWD': '/builds/slave/test', 07:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:12 INFO - 'SHELL': '/bin/bash', 07:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:36:12 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:12 INFO - 'USER': 'cltbld', 07:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:12 INFO - 'XPC_FLAGS': '0x0', 07:36:12 INFO - 'XPC_SERVICE_NAME': '0', 07:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-l9z5QC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:12 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-QyDXfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-EUrIhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-BJN05K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-3vjKN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-DcvnnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-151YQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-gAzbk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-O0t1Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-4sHxXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-h4i3p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-U9p2b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-6c0EGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-lUSfmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-9ZuXR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-DpHzF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-IRVRpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:14 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)) 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:14 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)) 07:36:14 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:14 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:16 INFO - Downloading blessings-1.6.tar.gz 07:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:17 INFO - Installing collected packages: blessings 07:36:17 INFO - Running setup.py install for blessings 07:36:17 INFO - Successfully installed blessings 07:36:17 INFO - Cleaning up... 07:36:17 INFO - Return code: 0 07:36:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:17 INFO - Reading from file tmpfile_stdout 07:36:17 INFO - Current package versions: 07:36:17 INFO - blessings == 1.6 07:36:17 INFO - blobuploader == 1.2.4 07:36:17 INFO - docopt == 0.6.1 07:36:17 INFO - functools32 == 3.2.3-2 07:36:17 INFO - jsonschema == 2.5.1 07:36:17 INFO - manifestparser == 1.1 07:36:17 INFO - mozInstall == 1.12 07:36:17 INFO - mozcrash == 0.17 07:36:17 INFO - mozdebug == 0.1 07:36:17 INFO - mozdevice == 0.48 07:36:17 INFO - mozfile == 1.2 07:36:17 INFO - mozhttpd == 0.7 07:36:17 INFO - mozinfo == 0.9 07:36:17 INFO - mozleak == 0.1 07:36:17 INFO - mozlog == 3.4 07:36:17 INFO - moznetwork == 0.27 07:36:17 INFO - mozprocess == 0.23 07:36:17 INFO - mozprofile == 0.28 07:36:17 INFO - mozrunner == 6.12 07:36:17 INFO - mozscreenshot == 0.1 07:36:17 INFO - mozsystemmonitor == 0.3 07:36:17 INFO - moztest == 0.7 07:36:17 INFO - mozversion == 1.4 07:36:17 INFO - psutil == 3.1.1 07:36:17 INFO - requests == 1.2.3 07:36:17 INFO - wsgiref == 0.1.2 07:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:17 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 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:36:17 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 07:36:17 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 07:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:17 INFO - 'HOME': '/Users/cltbld', 07:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:17 INFO - 'LOGNAME': 'cltbld', 07:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:17 INFO - 'MOZ_NO_REMOTE': '1', 07:36:17 INFO - 'NO_EM_RESTART': '1', 07:36:17 INFO - 'PAGER': '/bin/cat', 07:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:17 INFO - 'PWD': '/builds/slave/test', 07:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:17 INFO - 'SHELL': '/bin/bash', 07:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:36:17 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:17 INFO - 'USER': 'cltbld', 07:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:17 INFO - 'XPC_FLAGS': '0x0', 07:36:17 INFO - 'XPC_SERVICE_NAME': '0', 07:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 INFO - Cleaning up... 07:36:17 INFO - Return code: 0 07:36:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10334d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032c3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8585660f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, '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.YGUwfemp3x/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.putTdYdWlo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 07:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:17 INFO - 'HOME': '/Users/cltbld', 07:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:17 INFO - 'LOGNAME': 'cltbld', 07:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:17 INFO - 'MOZ_NO_REMOTE': '1', 07:36:17 INFO - 'NO_EM_RESTART': '1', 07:36:17 INFO - 'PAGER': '/bin/cat', 07:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:17 INFO - 'PWD': '/builds/slave/test', 07:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:17 INFO - 'SHELL': '/bin/bash', 07:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:36:17 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:17 INFO - 'USER': 'cltbld', 07:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:17 INFO - 'XPC_FLAGS': '0x0', 07:36:17 INFO - 'XPC_SERVICE_NAME': '0', 07:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Running post-action listener: _resource_record_post_action 07:36:18 INFO - Running post-action listener: _start_resource_monitoring 07:36:18 INFO - Starting resource monitoring. 07:36:18 INFO - [mozharness: 2016-09-30 14:36:18.171887Z] Finished create-virtualenv step (success) 07:36:18 INFO - [mozharness: 2016-09-30 14:36:18.172845Z] Running install step. 07:36:18 INFO - Running pre-action listener: _resource_record_pre_action 07:36:18 INFO - Running main action method: install 07:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:18 INFO - Reading from file tmpfile_stdout 07:36:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:18 INFO - Reading from file tmpfile_stdout 07:36:18 INFO - Output received: 07:36:18 INFO - Usage: mozinstall [options] installer 07:36:18 INFO - Options: 07:36:18 INFO - -h, --help show this help message and exit 07:36:18 INFO - -d DEST, --destination=DEST 07:36:18 INFO - Directory to install application into. [default: 07:36:18 INFO - "/builds/slave/test"] 07:36:18 INFO - --app=APP Application being installed. [default: firefox] 07:36:18 INFO - mkdir: /builds/slave/test/build/application 07:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:36:51 INFO - Reading from file tmpfile_stdout 07:36:51 INFO - Output received: 07:36:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:36:51 INFO - Running post-action listener: _resource_record_post_action 07:36:51 INFO - [mozharness: 2016-09-30 14:36:51.053690Z] Finished install step (success) 07:36:51 INFO - [mozharness: 2016-09-30 14:36:51.053843Z] Running run-tests step. 07:36:51 INFO - Running pre-action listener: _resource_record_pre_action 07:36:51 INFO - Running main action method: run_tests 07:36:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:51 INFO - 2016-09-30 07:36:51.068 screenresolution[1648:8669] starting screenresolution argv=screenresolution get 07:36:51 INFO - 2016-09-30 07:36:51.071 screenresolution[1648:8669] Display 0: 1600x1200x32@60 07:36:51 INFO - 2016-09-30 07:36:51.075 screenresolution[1649:8671] starting screenresolution argv=screenresolution list 07:36:51 INFO - Available Modes on Display 0 07:36:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:51 INFO - Intel Iris: 07:36:51 INFO - Chipset Model: Intel Iris 07:36:51 INFO - Type: GPU 07:36:51 INFO - Bus: Built-In 07:36:51 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:51 INFO - Vendor: Intel (0x8086) 07:36:51 INFO - Device ID: 0x0a2e 07:36:51 INFO - Revision ID: 0x0009 07:36:51 INFO - Displays: 07:36:51 INFO - Display: 07:36:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:51 INFO - Display Serial Number: 1600x1200 60 07:36:51 INFO - Main Display: Yes 07:36:51 INFO - Mirror: Off 07:36:51 INFO - Online: Yes 07:36:51 INFO - Rotation: Supported 07:36:51 INFO - Return code: 0 07:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:51 INFO - Python 2.7.3 07:36:51 INFO - Return code: 0 07:36:51 INFO - grabbing minidump binary from tooltool 07:36: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')]} 07:36:51 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 0x103161d30>, '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 0x102fc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103159b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:51 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 07:36:51 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 07:36:51 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 07:36:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:51 INFO - Return code: 0 07:36:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:51 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/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 07:36:51 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/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --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 07:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YGUwfemp3x/Render', 07:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:51 INFO - 'HOME': '/Users/cltbld', 07:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:51 INFO - 'LOGNAME': 'cltbld', 07:36:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:51 INFO - 'MOZ_NO_REMOTE': '1', 07:36:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:51 INFO - 'NO_EM_RESTART': '1', 07:36:51 INFO - 'PAGER': '/bin/cat', 07:36:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:51 INFO - 'PWD': '/builds/slave/test', 07:36:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:51 INFO - 'SHELL': '/bin/bash', 07:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.putTdYdWlo/Listeners', 07:36:51 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 07:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:51 INFO - 'USER': 'cltbld', 07:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:51 INFO - 'XPC_FLAGS': '0x0', 07:36:51 INFO - 'XPC_SERVICE_NAME': '0', 07:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:51 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/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 07:36:51 INFO - mozversion application_buildid: 20160930013320 07:36:51 INFO - mozversion application_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:36:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:51 INFO - mozversion application_name: Firefox 07:36:51 INFO - mozversion application_remotingname: firefox-dev 07:36:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:51 INFO - mozversion application_vendor: Mozilla 07:36:51 INFO - mozversion application_version: 51.0a2 07:36:51 INFO - mozversion platform_buildid: 20160930013320 07:36:51 INFO - mozversion platform_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:51 INFO - mozversion platform_version: 51.0a2 07:36:51 INFO - using testdate: 1475246211 07:36:51 INFO - actual date: 1475246211 07:36:51 INFO - starting webserver on 'localhost:49278' 07:36:51 INFO - SUITE-START | Running 2 tests 07:36:51 INFO - TEST-START | dromaeo_css 07:36:51 INFO - operating with platform_type : mac_ 07:36:51 INFO - Initialising browser for dromaeo_css test... 07:36:51 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQ5c27j/profile http://localhost:49278/getInfo.html) 07:36:53 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 07:36:53 INFO - PROCESS | 1659 | colorDepth:24 07:36:53 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 07:36:53 INFO - PROCESS | 1659 | __metrics 07:36:54 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:36:54 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:54 INFO - TEST-INFO | 1659: exit 0 07:36:54 INFO - Browser initialized. 07:36:54 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:54 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQ5c27j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:06 INFO - PROCESS | 1662 | RSS: Main: 219131904 07:37:06 INFO - PROCESS | 1662 | 07:37:57 INFO - PROCESS | 1662 | 1475246277531 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:40:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 07:40:11 INFO - PROCESS | 1662 | RSS: Main: 369086464 07:40:11 INFO - PROCESS | 1662 | 07:43:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 07:43:14 INFO - PROCESS | 1662 | RSS: Main: 351199232 07:43:14 INFO - PROCESS | 1662 | 07:46:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 07:46:17 INFO - PROCESS | 1662 | RSS: Main: 342220800 07:46:17 INFO - PROCESS | 1662 | 07:49:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 07:49:20 INFO - PROCESS | 1662 | RSS: Main: 316342272 07:49:20 INFO - PROCESS | 1662 | 07:52:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 07:52:24 INFO - PROCESS | 1662 | RSS: Main: 309305344 07:52:24 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 07:55:27 INFO - PROCESS | 1662 | RSS: Main: 531296256 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | __start_tp_report 07:55:27 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 07:55:27 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 07:55:27 INFO - PROCESS | 1662 | |i|pagename|runs| 07:55:27 INFO - PROCESS | 1662 | |0;dojo.html;3292.423825830479;3309.238875058737;3339.499075138729;3356.8321583920797;3392.6776956189155;5595.8321250362505;5652.09566469365;5679.801206957757;5705.971470142648;5720.427957204282;5667.4049224831415;5698.34469036061;5722;5729.885402291951;5734.082546792514;5180.8704782380455;5185.040767458014;5208;5217.895642087175;5262.8684282892855;4181.686373521983;5146.228065790143;5283;5290.761915713802;5331.733413329337;5126.794928202868;5157.690538567679;5175.068487672217;5188.792448302063;5195;5177.663451875654;5208.921866172011;5275;5285;5319.281896943901;5152.819651312224;5205.297284866532;5234.973825130888;5243.449437809013;5244.711540865251;5559.277293951801;5604.1593760935775;5630.493255607015;5639.182318563826;5711.314642242916;6124.203853499062;6141.33846107865;6193.907091393633;6234.781782637631;6274.058891166316;6196.969015154896;6269.655168965705;6275.780347687854;6284.497240220771;6296;5603.579731520112;5647.887042259214;5649.830505084854;5728.255326807488;5773.364929857712;6197.5351848611535;6218.5647004710145;6220.937790622126;6233.594816336924;6242.469390101892;6128;6146.108814221912;6148.292946311231;6148.538859585549;6151.507879369639;6116.235470566179;6152.446279834747;6157.107219453154;6230.439260466489;6244.906326405107;5156;5872.442117998783;6104.3590423005835;6173.259208894961;6174.289956655042;6178.351273116348;6234.096056071844;6252.5935814171935;6253.937460625336;6254.437100660872;4875.293082503088;4921;4927.285543596158;4943.555080042814;4959.528844759814;4339.631131353807;4350.369196466495;4351.151525452507;4361.476622805284;4394.252976993918;4760.357351757469;5738.110592858114;5760.934227167987;5765.769369225268;5804.129380592861;5189.922151167735;6127.172831667668;6255.624662520263;6277.686115694289;6289.905651415233;5560.944390556043;5581.386047534768;5632.633878797865;5747.885042299131;5757.050086735641;5342.652727572696;5351.25082488452;5378.381486129067;5399.433059528693;5425.186222066722;6297.275813281532;6301.7164227609865;6307.36926307384;6313.526485513513;6313.684315784284;6028.547858910511;6153.2000839890525;6153.876922461615;6165.383461653799;6172.598781079216;6138.725610151984;6208.255009398901;6253.562250642593;6258.405451482102;6266.937330626635;5365.22204280385;5892.616979896293;6118.479929206067;6136.88672321611;6141.723622437091;6069.089636554552;6125.356837532173;6127.142200091902;6132.896078705876;6135.9386406137155;5961.880762384815;6009.609375390585;6048.183495228088;6058.363871793398;6071.696415179312;6111.95640283616;6121.4490695837585;6122.550631083031;6132.141360525334;6132.875646117402;5991.610545314541;5995.130706047511;6002.399760023963;6007.549433792396;6017.2779266488305;5949.464548190684;6057.969710151421;6062.484688801501;6090.2996155440915;6117.877642447215;5934.495567876779;5963.880722385441;5994.70026498682;5998.670073146019;6043.365446628217 07:55:27 INFO - PROCESS | 1662 | |1;ext.html;449.93251012348156;470.88463326485015;471.8439822435035;525.2252926932777;533.6477924569784;30396.69603303966;36963.63036369632;39996.40005399921;40950.38574421386;41104.58895411045;42890.7855460723;43166.784166079124;43182.56817431825;43281;43351.78324108383;8491.915080849205;9631.37396069255;9661.56522956465;9812.116909478145;9860.260480463958;8667.566621668922;8890.688825891095;11963;12230.938845305762;12255.019598432149;12131.968782653441;12244.448999794986;12248.632541023784;12249.142560020802;12249.326287054208;12214.32821194834;12281.508739650404;12300.446479908425;12312.507499700001;12316.69208269787;12084.154109212359;12151.817722734166;12168.51325946961;12178.26930384171;12208.145429819917;39881.60118398808;40064.99837504086;40139.39790903139;40173.995650108685;40226.19547609061;3242.789218700777;3343.414902392096;3503.632118627558;3634.854605815764;3698.204885949534;31097.689023109706;31295.37409251802;31372.529412058837;31528.527072093937;32370;3162.2410621450917;3231.4991176367703;3255.7232635226032;3293.1602441377536;3386.6791951139076;516612;517068;519091;519197.0401479911;519462;32711.83644081812;33386.16534586606;57920.71039644775;58219.8356032877;58340.416595834344;34668.653313466544;34955.82522087424;34963.951081467596;34985.82507087499;34987.82506087453;15010.624734381729;15135.394584216509;15145.318460669296;15169.08985460876;15178.696426071638;11605.6518304451;11808.232464889754;12841.48634054646;12945.676358091123;12951.481940722266;7005.579665220103;7197.172325182566;7685.269899359552;7726.7681969541;7814.492058016324;3168.8732450701714;3214.180384002111;3233.270200442752;3250.1712063423674;3251.869925203013;856.9871451928226;944.631593678466;957.5308099031564;962.7593101724569;1121.870984836738;28988.13035608935;29629.111126666234;29638.407231855243;30403.543946840815;30471.8476407621;991.3506653142204;1048.7063622185801;1052.5316234275826;1087.6682611803317;1102.8345748137845;15007.849921500863;15467.922660386626;15508.914375993572;15803.36786528526;15917;699753;1002431;1020323;1021578;1032064.8396757968;47244.5275547247;58304;58403.123953140734;58424.415755841896;58487.415125849046;1215.9878401215874;1260.3887114749157;1340.7653660609353;1355.735631551838;1386.729587730383;21288.893555532122;29245.976390826218;30068.699313007466;31003;31450.79844410961;52234.73882630563;52844.207336890744;52921.7353913228;53068.469315306356;53088.73455632697;630816;634836;636048;636852;637665;23424.414389640395;26596;26665.46669066569;27153.72846271512;27217.591736123577;36558.8172059138;38285.4257186148;40440.79779601083;44667.88330291769;45119;31586;37083.814580926926;37301.4404783923;37924;38766.4185037219;37293.81353093326;37454.25091498209;38163.61836381601;38723.41914871223;38850.2229955405;36407;36666.63333366632;36770.63229367672;37181.6281837189;37445;32422.83788581042;33459.83270083634;34243.4863477043;34248.82875585606;34292.48561271533;20875.58248835045;22490.437739056655;23110.884445577663;25259.6107214105;25771.355716106496 07:55:27 INFO - PROCESS | 1662 | |2;jquery.html;317.2671129690415;356.64870102948606;369.98150092495376;378.72353182176994;395.90300376407765;18892.149853256604;19794.802051979495;20008.29970951017;20614.48463788404;20781.584368312626;19404.902975485104;19525.804741952576;19675.114619842105;20172.59654806903;20218.797812021876;5737.598368114233;5739.110437882125;6016.7292471838655;6028.517718582503;6037.667928263943;5778.162166485857;5934.258217722785;5942.970285148568;5945.791897283596;5952.672603006833;5614.606977511556;5859.1211318302385;5865.912011319833;5872.559558033143;5875.148103524986;5735.971320143393;5784.161296611967;5789.073748200289;5789.652620842763;5801.071828507418;4867.172580661296;5036.798528058874;5040.59675225981;5070.873228169288;5098.923516147261;24842.751572484223;24855;24866;25029;25155.496890062095;2108.1778106538463;2218.1792736687366;2320.1183550250967;2325.988370058156;2372.916947906815;8769.605367758466;9187.173154416134;9348.345615806897;9639.759006024835;9728.075832795874;1865.421719267018;1889.4426144287468;1891.1206289075647;1914.4639500939759;1924.2399252295404;114398.42800785943;117329.41335293354;117742;117785;118264;9097.681581144629;11039.172062095215;11284.774304514029;11300.20898537111;11485.368304743319;14083.084599501;14114;14119.929400352932;14125.858741412454;14148.787768183485;8319.459235149696;8383.035950865607;8404.537750423786;8468.534230617375;8503.362247831437;8466.111058338909;8478.703245386381;8523.318134549345;8615.353848461391;8655.961284645757;4275.1022285319805;4292.849750258789;4302.139572085595;4310.698251122391;4369.148016136886;1840.8251216134445;1880.2197088208513;1886.3680666976716;1910.0449775112443;1927.267638297438;365.11459710202655;373.71037445979584;389.2312682452134;810.643316940556;919.7792529792802;9468.61448070506;10976.231663783617;11089.33463992163;11201;11364.431778411212;396.22340213182486;409.71468062000434;414.69727099217135;430.3029092869571;830.3772170871846;10267;11257.71855703614;11417.42912854354;11599.88400115988;11606.303621782552;605935;607505;611033.9448302819;625640;627386;102429;110513;110604.4469777646;114247;150440;855.3328403845011;919.5815006532775;943.7357539888842;984.5913945712592;989.9208063354914;14361;17906.373276935246;18151.818481815542;18382.1728022242;18977.240910363984;57972.84054318974;58015;58639;58819;59221;83361.58319208365;83706.23321950405;87797;90169.3932242703;92456.53771731368;7151.843124725445;7279.818004549928;7429.33136017761;7605.353544948742;7897.763067107996;10210.795784084128;12377.443015064524;12435.813462797883;12549.184303020274;12575;10596.258261921592;10692.62575809843;10694.786104277715;10729.9463502682;10929.726756831144;10723.30298530593;10743.140548756237;10799.298045627009;10802.405867677353;11065.225434219848;10639.521221545205;10830.079443247098;10997.285176463503;11369;11546.653600392001;6826.692798824164;7766.611669416619;7801.542514108038;7847.176046515034;8034.879476807736;10768.676939691823;10774.676759697222;10906.345619262553;11121.221514493907;11158.218924675195 07:55:27 INFO - PROCESS | 1662 | |3;mootools.html;1461.5615315405375;1492.888033397495;1637.9344826206946;1786.3479829862104;1810.1763697517622;7665.655045522958;8696.956515217424;9108.362414630978;9130.954345228265;9160.725178244664;6378.872422551546;7826.0608726952705;8139.348852091834;8761.123887611237;8764.824703505927;2329.9417514562147;2393.3657580741033;2397.436602398435;2399.8320117591775;2411.5418070566534;2151.741790985076;2333.9299821005397;2367.7987371073477;2378.6669866218745;2426.6723992260995;2090.822280106193;2161.7730138335482;2169.381726208031;2318.0959425823858;2387.3554140382175;2371;2387.057112440576;2391.70103737032;2392.4497365605835;2395.0898658509827;2367.2188177901253;2402.2793162051316;2403.327068420845;2404.8557086574688;2409.5180963807306;7153.749618763319;7199.2080871104135;8514.531700756455;8539.103394143587;8547.914520854774;5220.347456567929;5235.73821308933;5296.92054619181;5335.839924802262;5395.325584301962;3504.421770407905;3594.8382322795537;3675.6691897729065;3730.0861288984374;3772.86794962175;1104.5636973395544;1106.7343837479027;1108.695108845066;1127.7575321305876;1128.2891778179776;9855.457949812757;11726.179167458282;11896.405179741065;11901.761964760657;11936.58221962227;4673.789679464432;4674.322223277606;4875.780589873393;4876.146674331978;4908.680935739166;10201.795964080826;10215.336003159771;10217.897821021843;10229.232807539316;10240.129588985019;5331.813386531453;5395.892082158335;5402.702851343135;5421.972890135603;5424.294841670558;4745.430548334153;4885.389326334208;4929.580985616191;4936.3829521309835;4940.530649588283;3845.5193100862393;3863.36254518007;3895.104126051024;3929.4478680920874;3975.7216994810087;1183.3964678014274;1189.1854079955258;1192.4872304908972;1203.175824560179;1205.9397030148632;625.6652690810395;762.9771106866802;871.5424402188902;904.9819003619891;948.7390967483997;5647.463490968352;5874.295084589791;5875.206847075676;6031.788887388921;6074.908876366858;465.3229551003282;477.072094775658;543.8958913405793;932.4358762948455;985.2905907746411;3225.3226822367096;3789.7915614640906;3975.1180394214543;4014.0366312085475;4020.718549701493;10409.167266618653;10843.51204195813;10941.56233750657;10942.507587158598;10958.780824383468;9589.328746987643;10823.729406764895;10888.183386245904;10905;10907.072898803532;8098.473599216032;8337.541435221121;8338.24955753985;8344.415890887702;8348.749537513884;5610.747516361692;5643.858903527444;5734.971325143348;5834.591578589458;5907.143464197753;8735.868961965703;10032.548535315782;10134.543945522322;10255.794884102426;10266.691999240034;9719.805603887742;10163.644272450429;10170.135538479017;10236.744081398025;10381.273310868166;7522.924770752223;7697.88453173214;7701.730439434593;7702.075750909927;7710.961445192738;8124.837503249783;8288.627011784363;8371.790705232417;8374.120717324593;8376.32989360862;7361.374283185775;7472.850542989001;7519.43604229674;7537.472376933562;7583.620818959141;7343.3390994810725;7440.255974402517;7452.627368631655;7461.962690186514;7479.775606731807;6984.650767461708;7066.752663656747;7068.434525237866;7069.045678833291;7075.5047146699235;4889.828855990166;4948;4957.206846904478;5070.062038522885;5209.973950130225;4968;5062.544371006627;5082.390113186441;5103.5661968733075;5147.202183661539 07:55:27 INFO - PROCESS | 1662 | |4;prototype.html;294.7435730914105;296.12642704023125;304.18933542110284;308.74528513975974;308.83014342111835;4253.553376895424;4958.801647934088;5310.15037593985;5318.298144593731;5341.679499230049;4543.068670922461;4828.995966673835;4894.8286809961655;5133.409657889344;5157.819476318329;3738.2336620992633;3982.820773065219;3990.8603198888045;4026.1680935174427;4052.3516237402023;3851.9807400963095;3954.3673012318036;3985.720999530034;3986.202759448122;3992.38308485064;3563.3407819553336;3732.346839303111;3960.425738267964;3974.046228905071;3975.886751709526;3417.8974630761118;3652.872149474769;3961.8811435656976;3965.484487016684;3966.643002129822;2856.5286727690113;3417.4532074868152;3453.4129198036394;3455.827208639583;3466.7053300469493;4870.951290487085;5074.873128171826;5089.211172268304;5099.311592934943;5145.33110695611;3468.8612455501748;4094.467719196515;4520.615747661453;4581.65637577183;4585.105904348653;5487.560995120421;5494.456075831106;5521.1442226454965;5542.418046105182;5545.473180047889;3238.2875767331147;3849.345611246095;3859.6526312631718;3861.1505468796818;3871.2064026874423;5612.607117501777;5642.730385663193;5771.797987070474;5789.826305210809;5848.385919478478;3339.2653616204398;3882.417637354363;3907.374820028782;3910.257051160327;3913.5890731473355;3967.940480892789;3980.2735126438483;3983.402489626579;3984.1633257015774;3988.6210809973004;4152.833886644561;4233.470816147981;4527;4533.750643714561;4573.908521829545;5056.84829455117;5252.789888404497;5279.313689220377;5554.555635549146;5699.658020518782;1298.2016060122955;1321.4714114354142;1329.2719464695856;1335.9265240411871;1348.581939598708;771.3096778383316;785.9489133206323;850.8596081646583;859.750672305037;863.0721973878107;4253.021804984871;4574.908501829945;4999.575036121971;5116.9744151279;5140.511651393112;5511.476409741068;5563.888722225533;5590.049691552445;5602.6918519481005;5605.355384130877;4859.684120532154;4896.926546101811;5110.386753589519;5149.382074151051;5266.394364648115;3009.653889802657;3012.7103401415084;3015.442143203514;3028.8637011334545;3055.358374741285;5247.897941432266;5961.672108034013;6025.879482410415;6034.48706859913;6042.274927008787;5154.819581314636;5424.566034717213;5660.669742610483;5828.475437210672;5864.677442740605;5182.8963420732125;5242.397124330674;5342.126957955529;5913.142594323799;6036.728347224298;4808.447028591757;5096.184610462308;5350.876315973689;5743.253377061123;5744.626599271034;5030.320906677552;5512.090505066619;5595.601099725069;5637.295338082739;5693.629914055573;5470.671759694431;5571.189363456811;5854.385289544536;5893.705314734332;5983.970080149571;3540.5574303212097;3607.801570913625;3817.6564109230303;3852.345101332724;3881.893660306799;5735.8852822944145;5742.684152371659;5757.913631295618;5762.913556296743;5780.624259423124;5556.333240011225;5562.694051827189;5580.190872323409;5601.887962240814;5629.662220266797;5051.1160546904875;5069.645124841373;5587.469190426903;5621.971890140523;5661.433856614306;4702.318163866289;5112.97443512795;5465.672059676433;5470.9179362308805;5482.013237617267;5481.57401623985;5481.890362192654;5507.889842203053;5587.631030397579;5591.552675785846;4417.403650507141;5446.984615692219;5448.782048718007;5491.588130890279;5521.834344969658 07:55:27 INFO - PROCESS | 1662 | |5;yui.html;689.0972825598469;695.4366962760165;702.1468915267949;769.1846642558888;794.8728203487441;15197;16018.919905400486;16042.278097485612;16046.438374656875;16046.43837465689;13291.401886915088;13344.666383340422;13361.665958351046;13379.933100334485;13816.585502434918;651.6481100205883;669.998352463066;670.8222321084917;804.9235322644354;809.1867672988668;828.8218033122878;831.6714897615439;841.0454134557291;845.2308399356587;849.0109022988212;902.6208992223281;903.7559858838109;903.9412438191497;904.5296445848155;904.9140331668514;691.882379995402;711.921688614252;898.7528429681824;900.4732231644496;900.6622516556291;638.5242993969522;655.8655475627532;656.7963931181301;657.8552718401944;658.1476987301456;15305.1582162981;15370.231488425647;15389.384424623002;15399.461018864286;15399.923000384926;13999.230042347666;14365.281735913268;14377.856221437862;14384.928075359661;14510.274486275644;12641.304728239944;13189.07676462648;13242.404091815892;13319.800202996963;13691.931540342333;4527.3661687363465;4558.483817283099;4614.746188959606;4647;4753.049390121955;105387;106063;106095.4695226519;106110;106173;9246.907530924605;10649.84025239622;11033.448327583588;11517.25137866036;11528.654140375802;22085;22287.219947301768;22325.665115023286;22332.665010024863;22340.106395743987;7761.650725717356;7876.17300183484;7902.920970790334;7929.1277959424415;8172.305354044854;4338.436003319548;4372.45758507791;4374.147041326974;4437.179121862401;4495.460544734653;3511.3328467591587;3660.6522380374354;3661.8718344857803;3663.981680091636;3669;680.0835502935162;683.1563019670702;684.7877158081011;686.9381755642016;692.4737199728143;512.8538366565585;556.6103727390843;599.409581562161;616.5930485879298;659.4361820643377;8598.612132901195;9344.672936447192;9479.383840050376;9486.857697134548;9544.141027307576;434.9630281426051;476.6591886800954;498.8353843231725;534.628433238903;567.7870798450581;4458.242098843204;4468.821247150143;4477.171723231213;4490.887727806831;4544.341070544819;145017.3745656367;147083;165774;169423.15288423726;174122;90620.09379906117;93426.53286733523;116277;139900.6059636425;143756;107805;113155.43422282836;119194.40402797931;121802.39098804626;122050.38974805246;8530.530820804666;8745.518996455256;8749.212570868653;8772.122787721431;9020.864687029569;59094.40905591061;60778.39221607904;63037.36962630315;66045;66415;91030.54484727533;97730;102393.48803255935;104802.61579073808;106604.86790264306;11562.190646654653;11617.825732614187;11744;11891.621675664728;12124.393780311126;12294.877051229374;12350.07374446938;12401.503939842305;12472.126951113334;12830.807537887125;11954.462049207632;11982.460789264678;12033.939830300793;12050.698732531757;12772.680682983;12814.295213763333;12857.292848893027;14666.853331466975;14678.339474723449;14683.265836707908;13067.215967042008;13097.476100956235;14060.718785624435;14337;14342;10573;11049.613263535737;11698.06415486742;11840.70398240051;12032.27806331623;8589.65641374363;11075.957275594512;11450.656480305604;11707.88292117102;11726.120540959633 07:55:27 INFO - PROCESS | 1662 | __end_tp_report 07:55:27 INFO - PROCESS | 1662 | __start_cc_report 07:55:27 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1511 07:55:27 INFO - PROCESS | 1662 | __end_cc_report 07:55:27 INFO - PROCESS | 1662 | __startTimestamp1475247327949__endTimestamp 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | ------- Summary: start ------- 07:55:27 INFO - PROCESS | 1662 | Number of tests: 6 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5693.64 Median:5961.88 stddev:645.02 (10.8%) stddev-sans-first:618.88 07:55:27 INFO - PROCESS | 1662 | Values: 3292.4 3309.2 3339.5 3356.8 3392.7 5595.8 5652.1 5679.8 5706.0 5720.4 5667.4 5698.3 5722.0 5729.9 5734.1 5180.9 5185.0 5208.0 5217.9 5262.9 4181.7 5146.2 5283.0 5290.8 5331.7 5126.8 5157.7 5175.1 5188.8 5195.0 5177.7 5208.9 5275.0 5285.0 5319.3 5152.8 5205.3 5235.0 5243.4 5244.7 5559.3 5604.2 5630.5 5639.2 5711.3 6124.2 6141.3 6193.9 6234.8 6274.1 6197.0 6269.7 6275.8 6284.5 6296.0 5603.6 5647.9 5649.8 5728.3 5773.4 6197.5 6218.6 6220.9 6233.6 6242.5 6128.0 6146.1 6148.3 6148.5 6151.5 6116.2 6152.4 6157.1 6230.4 6244.9 5156.0 5872.4 6104.4 6173.3 6174.3 6178.4 6234.1 6252.6 6253.9 6254.4 4875.3 4921.0 4927.3 4943.6 4959.5 4339.6 4350.4 4351.2 4361.5 4394.3 4760.4 5738.1 5760.9 5765.8 5804.1 5189.9 6127.2 6255.6 6277.7 6289.9 5560.9 5581.4 5632.6 5747.9 5757.1 5342.7 5351.3 5378.4 5399.4 5425.2 6297.3 6301.7 6307.4 6313.5 6313.7 6028.5 6153.2 6153.9 6165.4 6172.6 6138.7 6208.3 6253.6 6258.4 6266.9 5365.2 5892.6 6118.5 6136.9 6141.7 6069.1 6125.4 6127.1 6132.9 6135.9 5961.9 6009.6 6048.2 6058.4 6071.7 6112.0 6121.4 6122.6 6132.1 6132.9 5991.6 5995.1 6002.4 6007.5 6017.3 5949.5 6058.0 6062.5 6090.3 6117.9 5934.5 5963.9 5994.7 5998.7 6043.4 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:79701.36 Median:34246.16 stddev:197699.82 (577.3%) stddev-sans-first:198164.87 07:55:27 INFO - PROCESS | 1662 | Values: 449.9 470.9 471.8 525.2 533.6 30396.7 36963.6 39996.4 40950.4 41104.6 42890.8 43166.8 43182.6 43281.0 43351.8 8491.9 9631.4 9661.6 9812.1 9860.3 8667.6 8890.7 11963.0 12230.9 12255.0 12132.0 12244.4 12248.6 12249.1 12249.3 12214.3 12281.5 12300.4 12312.5 12316.7 12084.2 12151.8 12168.5 12178.3 12208.1 39881.6 40065.0 40139.4 40174.0 40226.2 3242.8 3343.4 3503.6 3634.9 3698.2 31097.7 31295.4 31372.5 31528.5 32370.0 3162.2 3231.5 3255.7 3293.2 3386.7 516612.0 517068.0 519091.0 519197.0 519462.0 32711.8 33386.2 57920.7 58219.8 58340.4 34668.7 34955.8 34964.0 34985.8 34987.8 15010.6 15135.4 15145.3 15169.1 15178.7 11605.7 11808.2 12841.5 12945.7 12951.5 7005.6 7197.2 7685.3 7726.8 7814.5 3168.9 3214.2 3233.3 3250.2 3251.9 857.0 944.6 957.5 962.8 1121.9 28988.1 29629.1 29638.4 30403.5 30471.8 991.4 1048.7 1052.5 1087.7 1102.8 15007.8 15467.9 15508.9 15803.4 15917.0 699753.0 1002431.0 1020323.0 1021578.0 1032064.8 47244.5 58304.0 58403.1 58424.4 58487.4 1216.0 1260.4 1340.8 1355.7 1386.7 21288.9 29246.0 30068.7 31003.0 31450.8 52234.7 52844.2 52921.7 53068.5 53088.7 630816.0 634836.0 636048.0 636852.0 637665.0 23424.4 26596.0 26665.5 27153.7 27217.6 36558.8 38285.4 40440.8 44667.9 45119.0 31586.0 37083.8 37301.4 37924.0 38766.4 37293.8 37454.3 38163.6 38723.4 38850.2 36407.0 36666.6 36770.6 37181.6 37445.0 32422.8 33459.8 34243.5 34248.8 34292.5 20875.6 22490.4 23110.9 25259.6 25771.4 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35106.29 Median:367.55 stddev:102611.19 (27917.8%) stddev-sans-first:102865.79 07:55:27 INFO - PROCESS | 1662 | Values: 317.3 356.6 370.0 378.7 395.9 18892.1 19794.8 20008.3 20614.5 20781.6 19404.9 19525.8 19675.1 20172.6 20218.8 5737.6 5739.1 6016.7 6028.5 6037.7 5778.2 5934.3 5943.0 5945.8 5952.7 5614.6 5859.1 5865.9 5872.6 5875.1 5736.0 5784.2 5789.1 5789.7 5801.1 4867.2 5036.8 5040.6 5070.9 5098.9 24842.8 24855.0 24866.0 25029.0 25155.5 2108.2 2218.2 2320.1 2326.0 2372.9 8769.6 9187.2 9348.3 9639.8 9728.1 1865.4 1889.4 1891.1 1914.5 1924.2 114398.4 117329.4 117742.0 117785.0 118264.0 9097.7 11039.2 11284.8 11300.2 11485.4 14083.1 14114.0 14119.9 14125.9 14148.8 8319.5 8383.0 8404.5 8468.5 8503.4 8466.1 8478.7 8523.3 8615.4 8656.0 4275.1 4292.8 4302.1 4310.7 4369.1 1840.8 1880.2 1886.4 1910.0 1927.3 365.1 373.7 389.2 810.6 919.8 9468.6 10976.2 11089.3 11201.0 11364.4 396.2 409.7 414.7 430.3 830.4 10267.0 11257.7 11417.4 11599.9 11606.3 605935.0 607505.0 611033.9 625640.0 627386.0 102429.0 110513.0 110604.4 114247.0 150440.0 855.3 919.6 943.7 984.6 989.9 14361.0 17906.4 18151.8 18382.2 18977.2 57972.8 58015.0 58639.0 58819.0 59221.0 83361.6 83706.2 87797.0 90169.4 92456.5 7151.8 7279.8 7429.3 7605.4 7897.8 10210.8 12377.4 12435.8 12549.2 12575.0 10596.3 10692.6 10694.8 10729.9 10929.7 10723.3 10743.1 10799.3 10802.4 11065.2 10639.5 10830.1 10997.3 11369.0 11546.7 6826.7 7766.6 7801.5 7847.2 8034.9 10768.7 10774.7 10906.3 11121.2 11158.2 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5688.12 Median:4919.13 stddev:3199.03 (65.0%) stddev-sans-first:3192.23 07:55:27 INFO - PROCESS | 1662 | Values: 1461.6 1492.9 1637.9 1786.3 1810.2 7665.7 8697.0 9108.4 9131.0 9160.7 6378.9 7826.1 8139.3 8761.1 8764.8 2329.9 2393.4 2397.4 2399.8 2411.5 2151.7 2333.9 2367.8 2378.7 2426.7 2090.8 2161.8 2169.4 2318.1 2387.4 2371.0 2387.1 2391.7 2392.4 2395.1 2367.2 2402.3 2403.3 2404.9 2409.5 7153.7 7199.2 8514.5 8539.1 8547.9 5220.3 5235.7 5296.9 5335.8 5395.3 3504.4 3594.8 3675.7 3730.1 3772.9 1104.6 1106.7 1108.7 1127.8 1128.3 9855.5 11726.2 11896.4 11901.8 11936.6 4673.8 4674.3 4875.8 4876.1 4908.7 10201.8 10215.3 10217.9 10229.2 10240.1 5331.8 5395.9 5402.7 5422.0 5424.3 4745.4 4885.4 4929.6 4936.4 4940.5 3845.5 3863.4 3895.1 3929.4 3975.7 1183.4 1189.2 1192.5 1203.2 1205.9 625.7 763.0 871.5 905.0 948.7 5647.5 5874.3 5875.2 6031.8 6074.9 465.3 477.1 543.9 932.4 985.3 3225.3 3789.8 3975.1 4014.0 4020.7 10409.2 10843.5 10941.6 10942.5 10958.8 9589.3 10823.7 10888.2 10905.0 10907.1 8098.5 8337.5 8338.2 8344.4 8348.7 5610.7 5643.9 5735.0 5834.6 5907.1 8735.9 10032.5 10134.5 10255.8 10266.7 9719.8 10163.6 10170.1 10236.7 10381.3 7522.9 7697.9 7701.7 7702.1 7711.0 8124.8 8288.6 8371.8 8374.1 8376.3 7361.4 7472.9 7519.4 7537.5 7583.6 7343.3 7440.3 7452.6 7462.0 7479.8 6984.7 7066.8 7068.4 7069.0 7075.5 4889.8 4948.0 4957.2 5070.1 5210.0 4968.0 5062.5 5082.4 5103.6 5147.2 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4491.74 Median:5097.75 stddev:1387.29 (27.2%) stddev-sans-first:1354.95 07:55:27 INFO - PROCESS | 1662 | Values: 294.7 296.1 304.2 308.7 308.8 4253.6 4958.8 5310.2 5318.3 5341.7 4543.1 4829.0 4894.8 5133.4 5157.8 3738.2 3982.8 3990.9 4026.2 4052.4 3852.0 3954.4 3985.7 3986.2 3992.4 3563.3 3732.3 3960.4 3974.0 3975.9 3417.9 3652.9 3961.9 3965.5 3966.6 2856.5 3417.5 3453.4 3455.8 3466.7 4871.0 5074.9 5089.2 5099.3 5145.3 3468.9 4094.5 4520.6 4581.7 4585.1 5487.6 5494.5 5521.1 5542.4 5545.5 3238.3 3849.3 3859.7 3861.2 3871.2 5612.6 5642.7 5771.8 5789.8 5848.4 3339.3 3882.4 3907.4 3910.3 3913.6 3967.9 3980.3 3983.4 3984.2 3988.6 4152.8 4233.5 4527.0 4533.8 4573.9 5056.8 5252.8 5279.3 5554.6 5699.7 1298.2 1321.5 1329.3 1335.9 1348.6 771.3 785.9 850.9 859.8 863.1 4253.0 4574.9 4999.6 5117.0 5140.5 5511.5 5563.9 5590.0 5602.7 5605.4 4859.7 4896.9 5110.4 5149.4 5266.4 3009.7 3012.7 3015.4 3028.9 3055.4 5247.9 5961.7 6025.9 6034.5 6042.3 5154.8 5424.6 5660.7 5828.5 5864.7 5182.9 5242.4 5342.1 5913.1 6036.7 4808.4 5096.2 5350.9 5743.3 5744.6 5030.3 5512.1 5595.6 5637.3 5693.6 5470.7 5571.2 5854.4 5893.7 5984.0 3540.6 3607.8 3817.7 3852.3 3881.9 5735.9 5742.7 5757.9 5762.9 5780.6 5556.3 5562.7 5580.2 5601.9 5629.7 5051.1 5069.6 5587.5 5622.0 5661.4 4702.3 5113.0 5465.7 5470.9 5482.0 5481.6 5481.9 5507.9 5587.6 5591.6 4417.4 5447.0 5448.8 5491.6 5521.8 07:55:27 INFO - PROCESS | 1662 | 07:55:27 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25133.03 Median:3661.26 stddev:40700.05 (1111.6%) stddev-sans-first:40772.85 07:55:27 INFO - PROCESS | 1662 | Values: 689.1 695.4 702.1 769.2 794.9 15197.0 16018.9 16042.3 16046.4 16046.4 13291.4 13344.7 13361.7 13379.9 13816.6 651.6 670.0 670.8 804.9 809.2 828.8 831.7 841.0 845.2 849.0 902.6 903.8 903.9 904.5 904.9 691.9 711.9 898.8 900.5 900.7 638.5 655.9 656.8 657.9 658.1 15305.2 15370.2 15389.4 15399.5 15399.9 13999.2 14365.3 14377.9 14384.9 14510.3 12641.3 13189.1 13242.4 13319.8 13691.9 4527.4 4558.5 4614.7 4647.0 4753.0 105387.0 106063.0 106095.5 106110.0 106173.0 9246.9 10649.8 11033.4 11517.3 11528.7 22085.0 22287.2 22325.7 22332.7 22340.1 7761.7 7876.2 7902.9 7929.1 8172.3 4338.4 4372.5 4374.1 4437.2 4495.5 3511.3 3660.7 3661.9 3664.0 3669.0 680.1 683.2 684.8 686.9 692.5 512.9 556.6 599.4 616.6 659.4 8598.6 9344.7 9479.4 9486.9 9544.1 435.0 476.7 498.8 534.6 567.8 4458.2 4468.8 4477.2 4490.9 4544.3 145017.4 147083.0 165774.0 169423.2 174122.0 90620.1 93426.5 116277.0 139900.6 143756.0 107805.0 113155.4 119194.4 121802.4 122050.4 8530.5 8745.5 8749.2 8772.1 9020.9 59094.4 60778.4 63037.4 66045.0 66415.0 91030.5 97730.0 102393.5 104802.6 106604.9 11562.2 11617.8 11744.0 11891.6 12124.4 12294.9 12350.1 12401.5 12472.1 12830.8 11954.5 11982.5 12033.9 12050.7 12772.7 12814.3 12857.3 14666.9 14678.3 14683.3 13067.2 13097.5 14060.7 14337.0 14342.0 10573.0 11049.6 11698.1 11840.7 12032.3 8589.7 11076.0 11450.7 11707.9 11726.1 07:55:27 INFO - PROCESS | 1662 | -------- Summary: end -------- 07:55:27 INFO - PROCESS | 1662 | 07:55:28 INFO - TEST-INFO | 1662: exit 0 07:55:28 INFO - TEST-OK | dromaeo_css | took 1116950ms 07:55:28 INFO - TEST-START | kraken 07:55:28 INFO - operating with platform_type : mac_ 07:55:28 INFO - Initialising browser for kraken test... 07:55:28 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpkPCFiu/profile http://localhost:49278/getInfo.html) 07:55:31 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 07:55:31 INFO - PROCESS | 1669 | colorDepth:24 07:55:31 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 07:55:31 INFO - PROCESS | 1669 | __metrics 07:55:31 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:55:31 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:31 INFO - TEST-INFO | 1669: exit 0 07:55:31 INFO - Browser initialized. 07:55:31 INFO - Running cycle 1/1 for kraken test... 07:55:31 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpkPCFiu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:44 INFO - PROCESS | 1670 | RSS: Main: 219168768 07:55:44 INFO - PROCESS | 1670 | 07:55:46 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:47 INFO - PROCESS | 1670 | RSS: Main: 269361152 07:55:47 INFO - PROCESS | 1670 | 07:55:50 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 07:55:50 INFO - PROCESS | 1670 | RSS: Main: 279592960 07:55:50 INFO - PROCESS | 1670 | 07:55:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 07:55:54 INFO - PROCESS | 1670 | RSS: Main: 376160256 07:55:54 INFO - PROCESS | 1670 | 07:55:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 07:55:57 INFO - PROCESS | 1670 | RSS: Main: 280088576 07:55:57 INFO - PROCESS | 1670 | 07:55:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:00 INFO - PROCESS | 1670 | RSS: Main: 280555520 07:56:00 INFO - PROCESS | 1670 | 07:56:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:03 INFO - PROCESS | 1670 | RSS: Main: 318058496 07:56:03 INFO - PROCESS | 1670 | 07:56:06 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:06 INFO - PROCESS | 1670 | RSS: Main: 318681088 07:56:06 INFO - PROCESS | 1670 | 07:56:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 07:56:10 INFO - PROCESS | 1670 | RSS: Main: 317390848 07:56:10 INFO - PROCESS | 1670 | 07:56:11 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:12 INFO - PROCESS | 1670 | RSS: Main: 289058816 07:56:12 INFO - PROCESS | 1670 | 07:56:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:15 INFO - PROCESS | 1670 | RSS: Main: 294641664 07:56:15 INFO - PROCESS | 1670 | 07:56:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:17 INFO - PROCESS | 1670 | RSS: Main: 303742976 07:56:17 INFO - PROCESS | 1670 | 07:56:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:21 INFO - PROCESS | 1670 | RSS: Main: 313675776 07:56:21 INFO - PROCESS | 1670 | 07:56:24 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:24 INFO - PROCESS | 1670 | RSS: Main: 309866496 07:56:24 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 07:56:26 INFO - PROCESS | 1670 | RSS: Main: 353271808 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | __start_tp_report 07:56:26 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 07:56:26 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 07:56:26 INFO - PROCESS | 1670 | |i|pagename|runs| 07:56:26 INFO - PROCESS | 1670 | |0;ai-astar;162;172;172;114;114;115;114;115;115;113 07:56:26 INFO - PROCESS | 1670 | |1;audio-beat-detection;143;109;107;139;106;110;109;108;141;107 07:56:26 INFO - PROCESS | 1670 | |2;audio-dft;183;236;261;184;182;184;182;183;183;181 07:56:26 INFO - PROCESS | 1670 | |3;audio-fft;80;60;59;88;60;61;58;59;82;57 07:56:26 INFO - PROCESS | 1670 | |4;audio-oscillator;85;70;94;68;68;69;90;66;72;108 07:56:26 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;89;87;90;89;90;87;91;87;90;87 07:56:26 INFO - PROCESS | 1670 | |6;imaging-darkroom;95;95;94;95;95;94;95;94;95;95 07:56:26 INFO - PROCESS | 1670 | |7;imaging-desaturate;83;86;84;84;85;92;84;69;126;140 07:56:26 INFO - PROCESS | 1670 | |8;json-parse-financial;58;54;54;54;56;59;59;57;58;58 07:56:26 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;67;66;68;78;74;71;68;67;67;69 07:56:26 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;84;84;85;85;81;88;89;83;84 07:56:26 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;141;157;125;142;153;147;128;152;188;138 07:56:26 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;163;160;207;191;161;163;166;162;168;160 07:56:26 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;67;67;68;66;67;65;68;66;82;66 07:56:26 INFO - PROCESS | 1670 | __end_tp_report 07:56:26 INFO - PROCESS | 1670 | __start_cc_report 07:56:26 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2005 07:56:26 INFO - PROCESS | 1670 | __end_cc_report 07:56:26 INFO - PROCESS | 1670 | __startTimestamp1475247386932__endTimestamp 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | ------- Summary: start ------- 07:56:26 INFO - PROCESS | 1670 | Number of tests: 14 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:130.60 Median:115.00 stddev:26.42 (23.0%) stddev-sans-first:25.46 07:56:26 INFO - PROCESS | 1670 | Values: 162.0 172.0 172.0 114.0 114.0 115.0 114.0 115.0 115.0 113.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:109.50 stddev:16.01 (14.6%) stddev-sans-first:14.17 07:56:26 INFO - PROCESS | 1670 | Values: 143.0 109.0 107.0 139.0 106.0 110.0 109.0 108.0 141.0 107.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:195.90 Median:183.50 stddev:28.36 (15.5%) stddev-sans-first:29.69 07:56:26 INFO - PROCESS | 1670 | Values: 183.0 236.0 261.0 184.0 182.0 184.0 182.0 183.0 183.0 181.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:66.40 Median:60.50 stddev:11.90 (19.7%) stddev-sans-first:11.56 07:56:26 INFO - PROCESS | 1670 | Values: 80.0 60.0 59.0 88.0 60.0 61.0 58.0 59.0 82.0 57.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:71.00 stddev:14.39 (20.3%) stddev-sans-first:15.10 07:56:26 INFO - PROCESS | 1670 | Values: 85.0 70.0 94.0 68.0 68.0 69.0 90.0 66.0 72.0 108.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.50 stddev:1.57 (1.8%) stddev-sans-first:1.66 07:56:26 INFO - PROCESS | 1670 | Values: 89.0 87.0 90.0 89.0 90.0 87.0 91.0 87.0 90.0 87.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:56:26 INFO - PROCESS | 1670 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:84.00 stddev:21.93 (26.1%) stddev-sans-first:22.95 07:56:26 INFO - PROCESS | 1670 | Values: 83.0 86.0 84.0 84.0 85.0 92.0 84.0 69.0 126.0 140.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:58.00 stddev:2.06 (3.5%) stddev-sans-first:2.13 07:56:26 INFO - PROCESS | 1670 | Values: 58.0 54.0 54.0 54.0 56.0 59.0 59.0 57.0 58.0 58.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:68.50 stddev:3.81 (5.6%) stddev-sans-first:3.93 07:56:26 INFO - PROCESS | 1670 | Values: 67.0 66.0 68.0 78.0 74.0 71.0 68.0 67.0 67.0 69.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.40 (2.8%) stddev-sans-first:2.44 07:56:26 INFO - PROCESS | 1670 | Values: 87.0 84.0 84.0 85.0 85.0 81.0 88.0 89.0 83.0 84.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:149.50 stddev:17.73 (11.9%) stddev-sans-first:18.67 07:56:26 INFO - PROCESS | 1670 | Values: 141.0 157.0 125.0 142.0 153.0 147.0 128.0 152.0 188.0 138.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:164.50 stddev:15.89 (9.7%) stddev-sans-first:16.65 07:56:26 INFO - PROCESS | 1670 | Values: 163.0 160.0 207.0 191.0 161.0 163.0 166.0 162.0 168.0 160.0 07:56:26 INFO - PROCESS | 1670 | 07:56:26 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.00 stddev:4.94 (7.4%) stddev-sans-first:5.22 07:56:26 INFO - PROCESS | 1670 | Values: 67.0 67.0 68.0 66.0 67.0 65.0 68.0 66.0 82.0 66.0 07:56:26 INFO - PROCESS | 1670 | -------- Summary: end -------- 07:56:26 INFO - PROCESS | 1670 | 07:56:27 INFO - TEST-INFO | 1670: exit 0 07:56:27 INFO - TEST-OK | kraken | took 59175ms 07:56:27 INFO - SUITE-END | took 1176s 07:56:28 INFO - Completed test suite (00:19:36) 07:56:28 INFO - javascript benchmark 07:56:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.423825830479, 3309.238875058737, 3339.499075138729, 3356.8321583920797, 3392.6776956189155, 5595.8321250362505, 5652.09566469365, 5679.801206957757, 5705.971470142648, 5720.427957204282, 5667.4049224831415, 5698.34469036061, 5722.0, 5729.885402291951, 5734.082546792514, 5180.8704782380455, 5185.040767458014, 5208.0, 5217.895642087175, 5262.8684282892855, 4181.686373521983, 5146.228065790143, 5283.0, 5290.761915713802, 5331.733413329337, 5126.794928202868, 5157.690538567679, 5175.068487672217, 5188.792448302063, 5195.0, 5177.663451875654, 5208.921866172011, 5275.0, 5285.0, 5319.281896943901, 5152.819651312224, 5205.297284866532, 5234.973825130888, 5243.449437809013, 5244.711540865251, 5559.277293951801, 5604.1593760935775, 5630.493255607015, 5639.182318563826, 5711.314642242916, 6124.203853499062, 6141.33846107865, 6193.907091393633, 6234.781782637631, 6274.058891166316, 6196.969015154896, 6269.655168965705, 6275.780347687854, 6284.497240220771, 6296.0, 5603.579731520112, 5647.887042259214, 5649.830505084854, 5728.255326807488, 5773.364929857712, 6197.5351848611535, 6218.5647004710145, 6220.937790622126, 6233.594816336924, 6242.469390101892, 6128.0, 6146.108814221912, 6148.292946311231, 6148.538859585549, 6151.507879369639, 6116.235470566179, 6152.446279834747, 6157.107219453154, 6230.439260466489, 6244.906326405107, 5156.0, 5872.442117998783, 6104.3590423005835, 6173.259208894961, 6174.289956655042, 6178.351273116348, 6234.096056071844, 6252.5935814171935, 6253.937460625336, 6254.437100660872, 4875.293082503088, 4921.0, 4927.285543596158, 4943.555080042814, 4959.528844759814, 4339.631131353807, 4350.369196466495, 4351.151525452507, 4361.476622805284, 4394.252976993918, 4760.357351757469, 5738.110592858114, 5760.934227167987, 5765.769369225268, 5804.129380592861, 5189.922151167735, 6127.172831667668, 6255.624662520263, 6277.686115694289, 6289.905651415233, 5560.944390556043, 5581.386047534768, 5632.633878797865, 5747.885042299131, 5757.050086735641, 5342.652727572696, 5351.25082488452, 5378.381486129067, 5399.433059528693, 5425.186222066722, 6297.275813281532, 6301.7164227609865, 6307.36926307384, 6313.526485513513, 6313.684315784284, 6028.547858910511, 6153.2000839890525, 6153.876922461615, 6165.383461653799, 6172.598781079216, 6138.725610151984, 6208.255009398901, 6253.562250642593, 6258.405451482102, 6266.937330626635, 5365.22204280385, 5892.616979896293, 6118.479929206067, 6136.88672321611, 6141.723622437091, 6069.089636554552, 6125.356837532173, 6127.142200091902, 6132.896078705876, 6135.9386406137155, 5961.880762384815, 6009.609375390585, 6048.183495228088, 6058.363871793398, 6071.696415179312, 6111.95640283616, 6121.4490695837585, 6122.550631083031, 6132.141360525334, 6132.875646117402, 5991.610545314541, 5995.130706047511, 6002.399760023963, 6007.549433792396, 6017.2779266488305, 5949.464548190684, 6057.969710151421, 6062.484688801501, 6090.2996155440915, 6117.877642447215, 5934.495567876779, 5963.880722385441, 5994.70026498682, 5998.670073146019, 6043.365446628217], "value": 5652.83883924191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.93251012348156, 470.88463326485015, 471.8439822435035, 525.2252926932777, 533.6477924569784, 30396.69603303966, 36963.63036369632, 39996.40005399921, 40950.38574421386, 41104.58895411045, 42890.7855460723, 43166.784166079124, 43182.56817431825, 43281.0, 43351.78324108383, 8491.915080849205, 9631.37396069255, 9661.56522956465, 9812.116909478145, 9860.260480463958, 8667.566621668922, 8890.688825891095, 11963.0, 12230.938845305762, 12255.019598432149, 12131.968782653441, 12244.448999794986, 12248.632541023784, 12249.142560020802, 12249.326287054208, 12214.32821194834, 12281.508739650404, 12300.446479908425, 12312.507499700001, 12316.69208269787, 12084.154109212359, 12151.817722734166, 12168.51325946961, 12178.26930384171, 12208.145429819917, 39881.60118398808, 40064.99837504086, 40139.39790903139, 40173.995650108685, 40226.19547609061, 3242.789218700777, 3343.414902392096, 3503.632118627558, 3634.854605815764, 3698.204885949534, 31097.689023109706, 31295.37409251802, 31372.529412058837, 31528.527072093937, 32370.0, 3162.2410621450917, 3231.4991176367703, 3255.7232635226032, 3293.1602441377536, 3386.6791951139076, 516612.0, 517068.0, 519091.0, 519197.0401479911, 519462.0, 32711.83644081812, 33386.16534586606, 57920.71039644775, 58219.8356032877, 58340.416595834344, 34668.653313466544, 34955.82522087424, 34963.951081467596, 34985.82507087499, 34987.82506087453, 15010.624734381729, 15135.394584216509, 15145.318460669296, 15169.08985460876, 15178.696426071638, 11605.6518304451, 11808.232464889754, 12841.48634054646, 12945.676358091123, 12951.481940722266, 7005.579665220103, 7197.172325182566, 7685.269899359552, 7726.7681969541, 7814.492058016324, 3168.8732450701714, 3214.180384002111, 3233.270200442752, 3250.1712063423674, 3251.869925203013, 856.9871451928226, 944.631593678466, 957.5308099031564, 962.7593101724569, 1121.870984836738, 28988.13035608935, 29629.111126666234, 29638.407231855243, 30403.543946840815, 30471.8476407621, 991.3506653142204, 1048.7063622185801, 1052.5316234275826, 1087.6682611803317, 1102.8345748137845, 15007.849921500863, 15467.922660386626, 15508.914375993572, 15803.36786528526, 15917.0, 699753.0, 1002431.0, 1020323.0, 1021578.0, 1032064.8396757968, 47244.5275547247, 58304.0, 58403.123953140734, 58424.415755841896, 58487.415125849046, 1215.9878401215874, 1260.3887114749157, 1340.7653660609353, 1355.735631551838, 1386.729587730383, 21288.893555532122, 29245.976390826218, 30068.699313007466, 31003.0, 31450.79844410961, 52234.73882630563, 52844.207336890744, 52921.7353913228, 53068.469315306356, 53088.73455632697, 630816.0, 634836.0, 636048.0, 636852.0, 637665.0, 23424.414389640395, 26596.0, 26665.46669066569, 27153.72846271512, 27217.591736123577, 36558.8172059138, 38285.4257186148, 40440.79779601083, 44667.88330291769, 45119.0, 31586.0, 37083.814580926926, 37301.4404783923, 37924.0, 38766.4185037219, 37293.81353093326, 37454.25091498209, 38163.61836381601, 38723.41914871223, 38850.2229955405, 36407.0, 36666.63333366632, 36770.63229367672, 37181.6281837189, 37445.0, 32422.83788581042, 33459.83270083634, 34243.4863477043, 34248.82875585606, 34292.48561271533, 20875.58248835045, 22490.437739056655, 23110.884445577663, 25259.6107214105, 25771.355716106496], "value": 19055.32273568379, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2671129690415, 356.64870102948606, 369.98150092495376, 378.72353182176994, 395.90300376407765, 18892.149853256604, 19794.802051979495, 20008.29970951017, 20614.48463788404, 20781.584368312626, 19404.902975485104, 19525.804741952576, 19675.114619842105, 20172.59654806903, 20218.797812021876, 5737.598368114233, 5739.110437882125, 6016.7292471838655, 6028.517718582503, 6037.667928263943, 5778.162166485857, 5934.258217722785, 5942.970285148568, 5945.791897283596, 5952.672603006833, 5614.606977511556, 5859.1211318302385, 5865.912011319833, 5872.559558033143, 5875.148103524986, 5735.971320143393, 5784.161296611967, 5789.073748200289, 5789.652620842763, 5801.071828507418, 4867.172580661296, 5036.798528058874, 5040.59675225981, 5070.873228169288, 5098.923516147261, 24842.751572484223, 24855.0, 24866.0, 25029.0, 25155.496890062095, 2108.1778106538463, 2218.1792736687366, 2320.1183550250967, 2325.988370058156, 2372.916947906815, 8769.605367758466, 9187.173154416134, 9348.345615806897, 9639.759006024835, 9728.075832795874, 1865.421719267018, 1889.4426144287468, 1891.1206289075647, 1914.4639500939759, 1924.2399252295404, 114398.42800785943, 117329.41335293354, 117742.0, 117785.0, 118264.0, 9097.681581144629, 11039.172062095215, 11284.774304514029, 11300.20898537111, 11485.368304743319, 14083.084599501, 14114.0, 14119.929400352932, 14125.858741412454, 14148.787768183485, 8319.459235149696, 8383.035950865607, 8404.537750423786, 8468.534230617375, 8503.362247831437, 8466.111058338909, 8478.703245386381, 8523.318134549345, 8615.353848461391, 8655.961284645757, 4275.1022285319805, 4292.849750258789, 4302.139572085595, 4310.698251122391, 4369.148016136886, 1840.8251216134445, 1880.2197088208513, 1886.3680666976716, 1910.0449775112443, 1927.267638297438, 365.11459710202655, 373.71037445979584, 389.2312682452134, 810.643316940556, 919.7792529792802, 9468.61448070506, 10976.231663783617, 11089.33463992163, 11201.0, 11364.431778411212, 396.22340213182486, 409.71468062000434, 414.69727099217135, 430.3029092869571, 830.3772170871846, 10267.0, 11257.71855703614, 11417.42912854354, 11599.88400115988, 11606.303621782552, 605935.0, 607505.0, 611033.9448302819, 625640.0, 627386.0, 102429.0, 110513.0, 110604.4469777646, 114247.0, 150440.0, 855.3328403845011, 919.5815006532775, 943.7357539888842, 984.5913945712592, 989.9208063354914, 14361.0, 17906.373276935246, 18151.818481815542, 18382.1728022242, 18977.240910363984, 57972.84054318974, 58015.0, 58639.0, 58819.0, 59221.0, 83361.58319208365, 83706.23321950405, 87797.0, 90169.3932242703, 92456.53771731368, 7151.843124725445, 7279.818004549928, 7429.33136017761, 7605.353544948742, 7897.763067107996, 10210.795784084128, 12377.443015064524, 12435.813462797883, 12549.184303020274, 12575.0, 10596.258261921592, 10692.62575809843, 10694.786104277715, 10729.9463502682, 10929.726756831144, 10723.30298530593, 10743.140548756237, 10799.298045627009, 10802.405867677353, 11065.225434219848, 10639.521221545205, 10830.079443247098, 10997.285176463503, 11369.0, 11546.653600392001, 6826.692798824164, 7766.611669416619, 7801.542514108038, 7847.176046515034, 8034.879476807736, 10768.676939691823, 10774.676759697222, 10906.345619262553, 11121.221514493907, 11158.218924675195], "value": 8949.838010271953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.5615315405375, 1492.888033397495, 1637.9344826206946, 1786.3479829862104, 1810.1763697517622, 7665.655045522958, 8696.956515217424, 9108.362414630978, 9130.954345228265, 9160.725178244664, 6378.872422551546, 7826.0608726952705, 8139.348852091834, 8761.123887611237, 8764.824703505927, 2329.9417514562147, 2393.3657580741033, 2397.436602398435, 2399.8320117591775, 2411.5418070566534, 2151.741790985076, 2333.9299821005397, 2367.7987371073477, 2378.6669866218745, 2426.6723992260995, 2090.822280106193, 2161.7730138335482, 2169.381726208031, 2318.0959425823858, 2387.3554140382175, 2371.0, 2387.057112440576, 2391.70103737032, 2392.4497365605835, 2395.0898658509827, 2367.2188177901253, 2402.2793162051316, 2403.327068420845, 2404.8557086574688, 2409.5180963807306, 7153.749618763319, 7199.2080871104135, 8514.531700756455, 8539.103394143587, 8547.914520854774, 5220.347456567929, 5235.73821308933, 5296.92054619181, 5335.839924802262, 5395.325584301962, 3504.421770407905, 3594.8382322795537, 3675.6691897729065, 3730.0861288984374, 3772.86794962175, 1104.5636973395544, 1106.7343837479027, 1108.695108845066, 1127.7575321305876, 1128.2891778179776, 9855.457949812757, 11726.179167458282, 11896.405179741065, 11901.761964760657, 11936.58221962227, 4673.789679464432, 4674.322223277606, 4875.780589873393, 4876.146674331978, 4908.680935739166, 10201.795964080826, 10215.336003159771, 10217.897821021843, 10229.232807539316, 10240.129588985019, 5331.813386531453, 5395.892082158335, 5402.702851343135, 5421.972890135603, 5424.294841670558, 4745.430548334153, 4885.389326334208, 4929.580985616191, 4936.3829521309835, 4940.530649588283, 3845.5193100862393, 3863.36254518007, 3895.104126051024, 3929.4478680920874, 3975.7216994810087, 1183.3964678014274, 1189.1854079955258, 1192.4872304908972, 1203.175824560179, 1205.9397030148632, 625.6652690810395, 762.9771106866802, 871.5424402188902, 904.9819003619891, 948.7390967483997, 5647.463490968352, 5874.295084589791, 5875.206847075676, 6031.788887388921, 6074.908876366858, 465.3229551003282, 477.072094775658, 543.8958913405793, 932.4358762948455, 985.2905907746411, 3225.3226822367096, 3789.7915614640906, 3975.1180394214543, 4014.0366312085475, 4020.718549701493, 10409.167266618653, 10843.51204195813, 10941.56233750657, 10942.507587158598, 10958.780824383468, 9589.328746987643, 10823.729406764895, 10888.183386245904, 10905.0, 10907.072898803532, 8098.473599216032, 8337.541435221121, 8338.24955753985, 8344.415890887702, 8348.749537513884, 5610.747516361692, 5643.858903527444, 5734.971325143348, 5834.591578589458, 5907.143464197753, 8735.868961965703, 10032.548535315782, 10134.543945522322, 10255.794884102426, 10266.691999240034, 9719.805603887742, 10163.644272450429, 10170.135538479017, 10236.744081398025, 10381.273310868166, 7522.924770752223, 7697.88453173214, 7701.730439434593, 7702.075750909927, 7710.961445192738, 8124.837503249783, 8288.627011784363, 8371.790705232417, 8374.120717324593, 8376.32989360862, 7361.374283185775, 7472.850542989001, 7519.43604229674, 7537.472376933562, 7583.620818959141, 7343.3390994810725, 7440.255974402517, 7452.627368631655, 7461.962690186514, 7479.775606731807, 6984.650767461708, 7066.752663656747, 7068.434525237866, 7069.045678833291, 7075.5047146699235, 4889.828855990166, 4948.0, 4957.206846904478, 5070.062038522885, 5209.973950130225, 4968.0, 5062.544371006627, 5082.390113186441, 5103.5661968733075, 5147.202183661539], "value": 4532.963232750179, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.7435730914105, 296.12642704023125, 304.18933542110284, 308.74528513975974, 308.83014342111835, 4253.553376895424, 4958.801647934088, 5310.15037593985, 5318.298144593731, 5341.679499230049, 4543.068670922461, 4828.995966673835, 4894.8286809961655, 5133.409657889344, 5157.819476318329, 3738.2336620992633, 3982.820773065219, 3990.8603198888045, 4026.1680935174427, 4052.3516237402023, 3851.9807400963095, 3954.3673012318036, 3985.720999530034, 3986.202759448122, 3992.38308485064, 3563.3407819553336, 3732.346839303111, 3960.425738267964, 3974.046228905071, 3975.886751709526, 3417.8974630761118, 3652.872149474769, 3961.8811435656976, 3965.484487016684, 3966.643002129822, 2856.5286727690113, 3417.4532074868152, 3453.4129198036394, 3455.827208639583, 3466.7053300469493, 4870.951290487085, 5074.873128171826, 5089.211172268304, 5099.311592934943, 5145.33110695611, 3468.8612455501748, 4094.467719196515, 4520.615747661453, 4581.65637577183, 4585.105904348653, 5487.560995120421, 5494.456075831106, 5521.1442226454965, 5542.418046105182, 5545.473180047889, 3238.2875767331147, 3849.345611246095, 3859.6526312631718, 3861.1505468796818, 3871.2064026874423, 5612.607117501777, 5642.730385663193, 5771.797987070474, 5789.826305210809, 5848.385919478478, 3339.2653616204398, 3882.417637354363, 3907.374820028782, 3910.257051160327, 3913.5890731473355, 3967.940480892789, 3980.2735126438483, 3983.402489626579, 3984.1633257015774, 3988.6210809973004, 4152.833886644561, 4233.470816147981, 4527.0, 4533.750643714561, 4573.908521829545, 5056.84829455117, 5252.789888404497, 5279.313689220377, 5554.555635549146, 5699.658020518782, 1298.2016060122955, 1321.4714114354142, 1329.2719464695856, 1335.9265240411871, 1348.581939598708, 771.3096778383316, 785.9489133206323, 850.8596081646583, 859.750672305037, 863.0721973878107, 4253.021804984871, 4574.908501829945, 4999.575036121971, 5116.9744151279, 5140.511651393112, 5511.476409741068, 5563.888722225533, 5590.049691552445, 5602.6918519481005, 5605.355384130877, 4859.684120532154, 4896.926546101811, 5110.386753589519, 5149.382074151051, 5266.394364648115, 3009.653889802657, 3012.7103401415084, 3015.442143203514, 3028.8637011334545, 3055.358374741285, 5247.897941432266, 5961.672108034013, 6025.879482410415, 6034.48706859913, 6042.274927008787, 5154.819581314636, 5424.566034717213, 5660.669742610483, 5828.475437210672, 5864.677442740605, 5182.8963420732125, 5242.397124330674, 5342.126957955529, 5913.142594323799, 6036.728347224298, 4808.447028591757, 5096.184610462308, 5350.876315973689, 5743.253377061123, 5744.626599271034, 5030.320906677552, 5512.090505066619, 5595.601099725069, 5637.295338082739, 5693.629914055573, 5470.671759694431, 5571.189363456811, 5854.385289544536, 5893.705314734332, 5983.970080149571, 3540.5574303212097, 3607.801570913625, 3817.6564109230303, 3852.345101332724, 3881.893660306799, 5735.8852822944145, 5742.684152371659, 5757.913631295618, 5762.913556296743, 5780.624259423124, 5556.333240011225, 5562.694051827189, 5580.190872323409, 5601.887962240814, 5629.662220266797, 5051.1160546904875, 5069.645124841373, 5587.469190426903, 5621.971890140523, 5661.433856614306, 4702.318163866289, 5112.97443512795, 5465.672059676433, 5470.9179362308805, 5482.013237617267, 5481.57401623985, 5481.890362192654, 5507.889842203053, 5587.631030397579, 5591.552675785846, 4417.403650507141, 5446.984615692219, 5448.782048718007, 5491.588130890279, 5521.834344969658], "value": 4045.2823600843326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.0972825598469, 695.4366962760165, 702.1468915267949, 769.1846642558888, 794.8728203487441, 15197.0, 16018.919905400486, 16042.278097485612, 16046.438374656875, 16046.43837465689, 13291.401886915088, 13344.666383340422, 13361.665958351046, 13379.933100334485, 13816.585502434918, 651.6481100205883, 669.998352463066, 670.8222321084917, 804.9235322644354, 809.1867672988668, 828.8218033122878, 831.6714897615439, 841.0454134557291, 845.2308399356587, 849.0109022988212, 902.6208992223281, 903.7559858838109, 903.9412438191497, 904.5296445848155, 904.9140331668514, 691.882379995402, 711.921688614252, 898.7528429681824, 900.4732231644496, 900.6622516556291, 638.5242993969522, 655.8655475627532, 656.7963931181301, 657.8552718401944, 658.1476987301456, 15305.1582162981, 15370.231488425647, 15389.384424623002, 15399.461018864286, 15399.923000384926, 13999.230042347666, 14365.281735913268, 14377.856221437862, 14384.928075359661, 14510.274486275644, 12641.304728239944, 13189.07676462648, 13242.404091815892, 13319.800202996963, 13691.931540342333, 4527.3661687363465, 4558.483817283099, 4614.746188959606, 4647.0, 4753.049390121955, 105387.0, 106063.0, 106095.4695226519, 106110.0, 106173.0, 9246.907530924605, 10649.84025239622, 11033.448327583588, 11517.25137866036, 11528.654140375802, 22085.0, 22287.219947301768, 22325.665115023286, 22332.665010024863, 22340.106395743987, 7761.650725717356, 7876.17300183484, 7902.920970790334, 7929.1277959424415, 8172.305354044854, 4338.436003319548, 4372.45758507791, 4374.147041326974, 4437.179121862401, 4495.460544734653, 3511.3328467591587, 3660.6522380374354, 3661.8718344857803, 3663.981680091636, 3669.0, 680.0835502935162, 683.1563019670702, 684.7877158081011, 686.9381755642016, 692.4737199728143, 512.8538366565585, 556.6103727390843, 599.409581562161, 616.5930485879298, 659.4361820643377, 8598.612132901195, 9344.672936447192, 9479.383840050376, 9486.857697134548, 9544.141027307576, 434.9630281426051, 476.6591886800954, 498.8353843231725, 534.628433238903, 567.7870798450581, 4458.242098843204, 4468.821247150143, 4477.171723231213, 4490.887727806831, 4544.341070544819, 145017.3745656367, 147083.0, 165774.0, 169423.15288423726, 174122.0, 90620.09379906117, 93426.53286733523, 116277.0, 139900.6059636425, 143756.0, 107805.0, 113155.43422282836, 119194.40402797931, 121802.39098804626, 122050.38974805246, 8530.530820804666, 8745.518996455256, 8749.212570868653, 8772.122787721431, 9020.864687029569, 59094.40905591061, 60778.39221607904, 63037.36962630315, 66045.0, 66415.0, 91030.54484727533, 97730.0, 102393.48803255935, 104802.61579073808, 106604.86790264306, 11562.190646654653, 11617.825732614187, 11744.0, 11891.621675664728, 12124.393780311126, 12294.877051229374, 12350.07374446938, 12401.503939842305, 12472.126951113334, 12830.807537887125, 11954.462049207632, 11982.460789264678, 12033.939830300793, 12050.698732531757, 12772.680682983, 12814.295213763333, 12857.292848893027, 14666.853331466975, 14678.339474723449, 14683.265836707908, 13067.215967042008, 13097.476100956235, 14060.718785624435, 14337.0, 14342.0, 10573.0, 11049.613263535737, 11698.06415486742, 11840.70398240051, 12032.27806331623, 8589.65641374363, 11075.957275594512, 11450.656480305604, 11707.88292117102, 11726.120540959633], "value": 7716.224923038178, "unit": "score"}], "name": "dromaeo_css", "value": 7174.853988469759, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 172.0, 172.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 113.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 107.0, 139.0, 106.0, 110.0, 109.0, 108.0, 141.0, 107.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 236.0, 261.0, 184.0, 182.0, 184.0, 182.0, 183.0, 183.0, 181.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 88.0, 60.0, 61.0, 58.0, 59.0, 82.0, 57.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 94.0, 68.0, 68.0, 69.0, 90.0, 66.0, 72.0, 108.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 89.0, 90.0, 87.0, 91.0, 87.0, 90.0, 87.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 84.0, 85.0, 92.0, 84.0, 69.0, 126.0, 140.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 54.0, 56.0, 59.0, 59.0, 57.0, 58.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 78.0, 74.0, 71.0, 68.0, 67.0, 67.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 85.0, 85.0, 81.0, 88.0, 89.0, 83.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 157.0, 125.0, 142.0, 153.0, 147.0, 128.0, 152.0, 188.0, 138.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 207.0, 191.0, 161.0, 163.0, 166.0, 162.0, 168.0, 160.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 65.0, 68.0, 66.0, 82.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1463.1, "alertThreshold": 2.0}]} 07:56:28 INFO - Return code: 0 07:56:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:28 INFO - # TBPL SUCCESS # 07:56:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:28 INFO - 2016-09-30 07:56:28.259 screenresolution[1674:11013] starting screenresolution argv=screenresolution get 07:56:28 INFO - 2016-09-30 07:56:28.262 screenresolution[1674:11013] Display 0: 1600x1200x32@60 07:56:28 INFO - 2016-09-30 07:56:28.267 screenresolution[1675:11016] starting screenresolution argv=screenresolution list 07:56:28 INFO - Available Modes on Display 0 07:56:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:28 INFO - Intel Iris: 07:56:28 INFO - Chipset Model: Intel Iris 07:56:28 INFO - Type: GPU 07:56:28 INFO - Bus: Built-In 07:56:28 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:28 INFO - Vendor: Intel (0x8086) 07:56:28 INFO - Device ID: 0x0a2e 07:56:28 INFO - Revision ID: 0x0009 07:56:28 INFO - Displays: 07:56:28 INFO - Display: 07:56:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:28 INFO - Display Serial Number: 1600x1200 60 07:56:28 INFO - Main Display: Yes 07:56:28 INFO - Mirror: Off 07:56:28 INFO - Online: Yes 07:56:28 INFO - Rotation: Supported 07:56:28 INFO - Return code: 0 07:56:28 INFO - Running post-action listener: _resource_record_post_action 07:56:28 INFO - [mozharness: 2016-09-30 14:56:28.501886Z] Finished run-tests step (success) 07:56:28 INFO - Running post-run listener: _resource_record_post_run 07:56:28 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32979968; Write bytes: 662289920; Read time: 318; Write time: 1738 07:56:28 INFO - TinderboxPrint: CPU usage
53.2% 07:56:28 INFO - TinderboxPrint: I/O read bytes / time
32,979,968 / 318 07:56:28 INFO - TinderboxPrint: I/O write bytes / time
662,289,920 / 1,738 07:56:28 INFO - TinderboxPrint: CPU idle
2,261.7 (46.8%) 07:56:28 INFO - TinderboxPrint: CPU system
964.4 (19.9%) 07:56:28 INFO - TinderboxPrint: CPU user
1,611.6 (33.3%) 07:56:28 INFO - TinderboxPrint: Swap in / out
392,470,528 / 0 07:56:28 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 354071040; Write bytes: 355993600; Read time: 27391; Write time: 633 07:56:28 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 32050176; Write bytes: 296113664; Read time: 304; Write time: 1072 07:56:28 INFO - Running post-run listener: _upload_blobber_files 07:56:28 INFO - Blob upload gear active. 07:56:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:28 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 07:56:28 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'] 07:56:28 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 07:56:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:30 INFO - (blobuploader) - INFO - Done attempting. 07:56:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:30 INFO - (blobuploader) - INFO - Done attempting. 07:56:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:33 INFO - (blobuploader) - INFO - Done attempting. 07:56:33 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:33 INFO - Return code: 0 07:56:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e57f4eb1ae09867381b4a24e6fb7a705a0abe3a8585262c8fdd0356c5781d51553481278170d97407fbacf01537d5a27062f1ccfc2cba29022f8499ea5fbdbcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969a327597d8930d8fddce8a1ec9873f12821aa16b4d340d521bb337c94ae7df9c65e63c1fa7ae6a71ff6d41e5df3db920e278117e8d4199e173b2d79d952bc9"} 07:56:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:33 INFO - Contents: 07:56:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e57f4eb1ae09867381b4a24e6fb7a705a0abe3a8585262c8fdd0356c5781d51553481278170d97407fbacf01537d5a27062f1ccfc2cba29022f8499ea5fbdbcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969a327597d8930d8fddce8a1ec9873f12821aa16b4d340d521bb337c94ae7df9c65e63c1fa7ae6a71ff6d41e5df3db920e278117e8d4199e173b2d79d952bc9"} 07:56:33 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:33 INFO - Copying logs to upload dir... 07:56:33 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.741639 ========= master_lag: 1.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-30 07:56:35.079466) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-09-30 07:56:35.082628) ========= 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.YGUwfemp3x/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.putTdYdWlo/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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/e57f4eb1ae09867381b4a24e6fb7a705a0abe3a8585262c8fdd0356c5781d51553481278170d97407fbacf01537d5a27062f1ccfc2cba29022f8499ea5fbdbcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969a327597d8930d8fddce8a1ec9873f12821aa16b4d340d521bb337c94ae7df9c65e63c1fa7ae6a71ff6d41e5df3db920e278117e8d4199e173b2d79d952bc9"} build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011081 build_url: 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e57f4eb1ae09867381b4a24e6fb7a705a0abe3a8585262c8fdd0356c5781d51553481278170d97407fbacf01537d5a27062f1ccfc2cba29022f8499ea5fbdbcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969a327597d8930d8fddce8a1ec9873f12821aa16b4d340d521bb337c94ae7df9c65e63c1fa7ae6a71ff6d41e5df3db920e278117e8d4199e173b2d79d952bc9"}' ========= master_lag: 4.65 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-09-30 07:56:39.742855) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:39.743151) ========= 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.YGUwfemp3x/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.putTdYdWlo/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005038 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:39.797513) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-09-30 07:56:39.797788) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-09-30 07:56:45.927188) ========= ========= Total master_lag: 6.59 =========