builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0010 starttime: 1479121721.37 results: success (0) buildid: 20161114015620 builduid: 7575ab475a3f4481a1ee0dc2e232252d revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:41.366154) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:41.366638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:41.366935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:41.398449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:41.398852) ========= 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.Idzg5GRHkd/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.zWa0VumA9p/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-11-14 03:08:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2016-11-14 03:08:41 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.200775 ========= master_lag: 0.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:42.046108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:42.049446) ========= 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.Idzg5GRHkd/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.zWa0VumA9p/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.027478 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:42.096992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 03:08:42.100392) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f867a8846778f927cfb3871e58cc61f6193ad5d --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 0f867a8846778f927cfb3871e58cc61f6193ad5d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Idzg5GRHkd/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.zWa0VumA9p/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-11-14 03:08:42,177 truncating revision to first 12 chars 2016-11-14 03:08:42,177 Setting DEBUG logging. 2016-11-14 03:08:42,177 attempt 1/10 2016-11-14 03:08:42,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f867a884677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 03:08:42,886 unpacking tar archive at: mozilla-aurora-0f867a884677/testing/mozharness/ program finished with exit code 0 elapsedTime=0.980185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 03:08:43.102477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:43.102807) ========= script_repo_revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:43.109230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:43.109521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 03:08:43.131030) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-14 03:08:43.131380) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Idzg5GRHkd/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.zWa0VumA9p/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:08:43 INFO - MultiFileLogger online at 20161114 03:08:43 in /builds/slave/test 03:08:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:08:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:08:43 INFO - {'append_to_log': False, 03:08:43 INFO - 'base_work_dir': '/builds/slave/test', 03:08:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:08:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:08:43 INFO - 'branch': 'Mozilla-Aurora', 03:08:43 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:43 INFO - 'config_files': ('talos/mac_config.py',), 03:08:43 INFO - 'default_actions': ('clobber', 03:08:43 INFO - 'read-buildbot-config', 03:08:43 INFO - 'download-and-extract', 03:08:43 INFO - 'populate-webroot', 03:08:43 INFO - 'create-virtualenv', 03:08:43 INFO - 'install', 03:08:43 INFO - 'run-tests'), 03:08:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:43 INFO - 'download_minidump_stackwalk': True, 03:08:43 INFO - 'download_symbols': 'ondemand', 03:08:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:43 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:43 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:43 INFO - 'installer_path': 'installer.exe', 03:08:43 INFO - 'log_level': 'info', 03:08:43 INFO - 'log_name': 'talos', 03:08:43 INFO - 'log_to_console': True, 03:08:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:08:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:08:43 INFO - 'opt_config_files': (), 03:08:43 INFO - 'pip_index': False, 03:08:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:08:43 INFO - 'cmd': ('bash', 03:08:43 INFO - '-c', 03:08:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:08:43 INFO - 'enabled': True, 03:08:43 INFO - 'halt_on_failure': False, 03:08:43 INFO - 'name': 'check_screen_resolution'},), 03:08:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:08:43 INFO - 'cmd': ('bash', 03:08:43 INFO - '-c', 03:08:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:08:43 INFO - 'enabled': True, 03:08:43 INFO - 'halt_on_failure': False, 03:08:43 INFO - 'name': 'check_screen_resolution'},), 03:08:43 INFO - 'run_cmd_checks_enabled': True, 03:08:43 INFO - 'sps_profile': False, 03:08:43 INFO - 'sps_profile_interval': 0, 03:08:43 INFO - 'suite': 'dromaeojs', 03:08:43 INFO - 'system_bits': '32', 03:08:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:43 INFO - 'title': 't-yosemite-r7-0010', 03:08:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:43 INFO - 'use_talos_json': True, 03:08:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:08:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:43 INFO - 'work_dir': 'build'} 03:08:43 INFO - [mozharness: 2016-11-14 11:08:43.329243Z] Running clobber step. 03:08:43 INFO - Running pre-action listener: _resource_record_pre_action 03:08:43 INFO - Running main action method: clobber 03:08:43 INFO - rmtree: /builds/slave/test/build 03:08:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:08:45 INFO - Running post-action listener: _resource_record_post_action 03:08:45 INFO - [mozharness: 2016-11-14 11:08:45.815760Z] Finished clobber step (success) 03:08:45 INFO - [mozharness: 2016-11-14 11:08:45.815895Z] Running read-buildbot-config step. 03:08:45 INFO - Running pre-action listener: _resource_record_pre_action 03:08:45 INFO - Running main action method: read_buildbot_config 03:08:45 INFO - Using buildbot properties: 03:08:45 INFO - { 03:08:45 INFO - "project": "", 03:08:45 INFO - "product": "firefox", 03:08:45 INFO - "script_repo_revision": "production", 03:08:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:08:45 INFO - "repository": "", 03:08:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:08:45 INFO - "buildid": "20161114015620", 03:08:45 INFO - "pgo_build": "False", 03:08:45 INFO - "basedir": "/builds/slave/test", 03:08:45 INFO - "buildnumber": 126, 03:08:45 INFO - "slavename": "t-yosemite-r7-0010", 03:08:45 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:08:45 INFO - "platform": "yosemite_r7", 03:08:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:08:45 INFO - "branch": "mozilla-aurora", 03:08:45 INFO - "repo_path": "releases/mozilla-aurora", 03:08:45 INFO - "revision": "0f867a8846778f927cfb3871e58cc61f6193ad5d", 03:08:45 INFO - "stage_platform": "macosx64", 03:08:45 INFO - "builduid": "7575ab475a3f4481a1ee0dc2e232252d", 03:08:45 INFO - "slavebuilddir": "test" 03:08:45 INFO - } 03:08:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:08:45 INFO - Running post-action listener: _resource_record_post_action 03:08:45 INFO - [mozharness: 2016-11-14 11:08:45.819259Z] Finished read-buildbot-config step (success) 03:08:45 INFO - [mozharness: 2016-11-14 11:08:45.819409Z] Running download-and-extract step. 03:08:45 INFO - Running pre-action listener: _resource_record_pre_action 03:08:45 INFO - Running main action method: download_and_extract 03:08:45 INFO - mkdir: /builds/slave/test/build/tests 03:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:08:45 INFO - trying https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:08:45 INFO - Downloading https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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 03:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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 03:08:46 INFO - Downloaded 1199 bytes. 03:08:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:08:46 INFO - Using the following test package requirements: 03:08:46 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:08:46 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:08:46 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:08:46 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'jsshell-mac.zip'], 03:08:46 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:08:46 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:08:46 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:08:46 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:08:46 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:08:46 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:08:46 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:08:46 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:08:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:08:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:08:46 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:08:47 INFO - Expected file size: 16423758 03:08:54 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 03:08:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:08:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:08:54 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:08:54 INFO - Expected file size: 16423758 03:09:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:09:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:09:01 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:09:02 INFO - Expected file size: 14414089 03:09: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')]} 03:09:02 INFO - trying https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:09:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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 03:09:05 INFO - Downloaded 115545916 bytes. 03:09:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:09:05 INFO - mkdir: /builds/slave/test/properties 03:09:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:05 INFO - Contents: 03:09:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:09:06 INFO - Running post-action listener: _resource_record_post_action 03:09:06 INFO - Running post-action listener: set_extra_try_arguments 03:09:06 INFO - [mozharness: 2016-11-14 11:09:06.561240Z] Finished download-and-extract step (success) 03:09:06 INFO - [mozharness: 2016-11-14 11:09:06.561394Z] Running populate-webroot step. 03:09:06 INFO - Running pre-action listener: _resource_record_pre_action 03:09:06 INFO - Running main action method: populate_webroot 03:09:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:09:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:09:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:09:06 INFO - '--tppagecycles', 03:09:06 INFO - '7'], 03:09:06 INFO - 'tests': ['tsvgm']}}, 03:09:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:09:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:09:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:09:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:09:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['damp', 'tps']}, 03:09:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'tests': ['damp', 'tps']}, 03:09:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['dromaeo_dom']}, 03:09:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['basic_compositor_video']}, 03:09:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:09:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['a11yr', 03:09:06 INFO - 'ts_paint', 03:09:06 INFO - 'tpaint', 03:09:06 INFO - 'sessionrestore', 03:09:06 INFO - 'sessionrestore_no_auto_restore', 03:09:06 INFO - 'tabpaint']}, 03:09:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:09:06 INFO - 'ts_paint', 03:09:06 INFO - 'tpaint', 03:09:06 INFO - 'sessionrestore', 03:09:06 INFO - 'sessionrestore_no_auto_restore', 03:09:06 INFO - 'tabpaint']}, 03:09:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:09:06 INFO - 'ts_paint', 03:09:06 INFO - 'tpaint', 03:09:06 INFO - 'sessionrestore', 03:09:06 INFO - 'sessionrestore_no_auto_restore', 03:09:06 INFO - 'tabpaint']}, 03:09:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:09:06 INFO - 'ts_paint', 03:09:06 INFO - 'tpaint', 03:09:06 INFO - 'sessionrestore', 03:09:06 INFO - 'sessionrestore_no_auto_restore', 03:09:06 INFO - 'tabpaint']}, 03:09:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['a11yr', 03:09:06 INFO - 'ts_paint', 03:09:06 INFO - 'tpaint', 03:09:06 INFO - 'sessionrestore', 03:09:06 INFO - 'sessionrestore_no_auto_restore', 03:09:06 INFO - 'tabpaint']}, 03:09:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['a11yr', 03:09:06 INFO - 'ts_paint', 03:09:06 INFO - 'tpaint', 03:09:06 INFO - 'sessionrestore', 03:09:06 INFO - 'sessionrestore_no_auto_restore', 03:09:06 INFO - 'tabpaint']}, 03:09:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['tsvgx', 03:09:06 INFO - 'tsvgr_opacity', 03:09:06 INFO - 'tart', 03:09:06 INFO - 'tscrollx', 03:09:06 INFO - 'cart']}, 03:09:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:09:06 INFO - 'tsvgr_opacity', 03:09:06 INFO - 'tart', 03:09:06 INFO - 'tscrollx', 03:09:06 INFO - 'cart']}, 03:09:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'talos_options': ['--disable-e10s'], 03:09:06 INFO - 'tests': ['tp5o']}, 03:09:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'tests': ['tp5o']}, 03:09:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'talos_options': ['--disable-e10s', 03:09:06 INFO - '--xperf_path', 03:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:06 INFO - 'tests': ['tp5n']}, 03:09:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:06 INFO - 'talos_options': ['--xperf_path', 03:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:06 INFO - 'tests': ['tp5n']}}, 03:09:06 INFO - 'talos.zip': {'path': '', 03:09:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:09:06 INFO - Running post-action listener: _resource_record_post_action 03:09:06 INFO - [mozharness: 2016-11-14 11:09:06.580104Z] Finished populate-webroot step (success) 03:09:06 INFO - [mozharness: 2016-11-14 11:09:06.580212Z] Running create-virtualenv step. 03:09:06 INFO - Running pre-action listener: _resource_record_pre_action 03:09:06 INFO - Running main action method: create_virtualenv 03:09:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:09:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:09:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:06 INFO - Using real prefix '/tools/python27' 03:09:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:10 INFO - Installing pip.................done. 03:09:10 INFO - Return code: 0 03:09:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:10 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:10 INFO - 'HOME': '/Users/cltbld', 03:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:10 INFO - 'LOGNAME': 'cltbld', 03:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:10 INFO - 'MOZ_NO_REMOTE': '1', 03:09:10 INFO - 'NO_EM_RESTART': '1', 03:09:10 INFO - 'PAGER': '/bin/cat', 03:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:10 INFO - 'PWD': '/builds/slave/test', 03:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:10 INFO - 'SHELL': '/bin/bash', 03:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:10 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:10 INFO - 'USER': 'cltbld', 03:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:10 INFO - 'XPC_FLAGS': '0x0', 03:09:10 INFO - 'XPC_SERVICE_NAME': '0', 03:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:09:10 INFO - Cleaning up... 03:09:10 INFO - Return code: 0 03:09:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:10 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:10 INFO - 'HOME': '/Users/cltbld', 03:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:10 INFO - 'LOGNAME': 'cltbld', 03:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:10 INFO - 'MOZ_NO_REMOTE': '1', 03:09:10 INFO - 'NO_EM_RESTART': '1', 03:09:10 INFO - 'PAGER': '/bin/cat', 03:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:10 INFO - 'PWD': '/builds/slave/test', 03:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:10 INFO - 'SHELL': '/bin/bash', 03:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:10 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:10 INFO - 'USER': 'cltbld', 03:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:10 INFO - 'XPC_FLAGS': '0x0', 03:09:10 INFO - 'XPC_SERVICE_NAME': '0', 03:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:10 INFO - Downloading/unpacking psutil>=3.1.1 03:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:13 INFO - Installing collected packages: psutil 03:09:13 INFO - Running setup.py install for psutil 03:09:13 INFO - building 'psutil._psutil_osx' extension 03:09:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:09:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:09:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:09:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:09:14 INFO - building 'psutil._psutil_posix' extension 03:09:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:09:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:09:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:09:14 INFO - ^ 03:09:14 INFO - 1 warning generated. 03:09:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:09:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:14 INFO - Successfully installed psutil 03:09:14 INFO - Cleaning up... 03:09:15 INFO - Return code: 0 03:09:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:15 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:15 INFO - 'HOME': '/Users/cltbld', 03:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:15 INFO - 'LOGNAME': 'cltbld', 03:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:15 INFO - 'MOZ_NO_REMOTE': '1', 03:09:15 INFO - 'NO_EM_RESTART': '1', 03:09:15 INFO - 'PAGER': '/bin/cat', 03:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:15 INFO - 'PWD': '/builds/slave/test', 03:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:15 INFO - 'SHELL': '/bin/bash', 03:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:15 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:15 INFO - 'USER': 'cltbld', 03:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:15 INFO - 'XPC_FLAGS': '0x0', 03:09:15 INFO - 'XPC_SERVICE_NAME': '0', 03:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:09:17 INFO - Installing collected packages: mozsystemmonitor 03:09:17 INFO - Running setup.py install for mozsystemmonitor 03:09:17 INFO - Successfully installed mozsystemmonitor 03:09:17 INFO - Cleaning up... 03:09:18 INFO - Return code: 0 03:09:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:18 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:18 INFO - 'HOME': '/Users/cltbld', 03:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:18 INFO - 'LOGNAME': 'cltbld', 03:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:18 INFO - 'MOZ_NO_REMOTE': '1', 03:09:18 INFO - 'NO_EM_RESTART': '1', 03:09:18 INFO - 'PAGER': '/bin/cat', 03:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:18 INFO - 'PWD': '/builds/slave/test', 03:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:18 INFO - 'SHELL': '/bin/bash', 03:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:18 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:18 INFO - 'USER': 'cltbld', 03:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:18 INFO - 'XPC_FLAGS': '0x0', 03:09:18 INFO - 'XPC_SERVICE_NAME': '0', 03:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:18 INFO - Downloading/unpacking jsonschema==2.5.1 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:21 INFO - warning: no files found matching '*.txt' 03:09:21 INFO - no previously-included directories found matching 'build' 03:09:21 INFO - no previously-included directories found matching 'dist' 03:09:21 INFO - no previously-included directories found matching '.git*' 03:09:21 INFO - Installing collected packages: jsonschema, functools32 03:09:21 INFO - Running setup.py install for functools32 03:09:21 INFO - warning: no files found matching '*.txt' 03:09:21 INFO - no previously-included directories found matching 'build' 03:09:21 INFO - no previously-included directories found matching 'dist' 03:09:21 INFO - no previously-included directories found matching '.git*' 03:09:21 INFO - Successfully installed jsonschema functools32 03:09:21 INFO - Cleaning up... 03:09:21 INFO - Return code: 0 03:09:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:21 INFO - 'HOME': '/Users/cltbld', 03:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:21 INFO - 'LOGNAME': 'cltbld', 03:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:21 INFO - 'MOZ_NO_REMOTE': '1', 03:09:21 INFO - 'NO_EM_RESTART': '1', 03:09:21 INFO - 'PAGER': '/bin/cat', 03:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:21 INFO - 'PWD': '/builds/slave/test', 03:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:21 INFO - 'SHELL': '/bin/bash', 03:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:21 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:21 INFO - 'USER': 'cltbld', 03:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:21 INFO - 'XPC_FLAGS': '0x0', 03:09:21 INFO - 'XPC_SERVICE_NAME': '0', 03:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:09:22 INFO - Cleaning up... 03:09:22 INFO - Return code: 0 03:09:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:22 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:22 INFO - 'HOME': '/Users/cltbld', 03:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:22 INFO - 'LOGNAME': 'cltbld', 03:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:22 INFO - 'MOZ_NO_REMOTE': '1', 03:09:22 INFO - 'NO_EM_RESTART': '1', 03:09:22 INFO - 'PAGER': '/bin/cat', 03:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:22 INFO - 'PWD': '/builds/slave/test', 03:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:22 INFO - 'SHELL': '/bin/bash', 03:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:22 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:22 INFO - 'USER': 'cltbld', 03:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:22 INFO - 'XPC_FLAGS': '0x0', 03:09:22 INFO - 'XPC_SERVICE_NAME': '0', 03:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:22 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:25 INFO - Downloading docopt-0.6.1.tar.gz 03:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:26 INFO - Running setup.py install for blobuploader 03:09:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:26 INFO - Running setup.py install for requests 03:09:26 INFO - Running setup.py install for docopt 03:09:26 INFO - Successfully installed blobuploader requests docopt 03:09:26 INFO - Cleaning up... 03:09:27 INFO - Return code: 0 03:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:27 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:27 INFO - 'HOME': '/Users/cltbld', 03:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:27 INFO - 'LOGNAME': 'cltbld', 03:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:27 INFO - 'MOZ_NO_REMOTE': '1', 03:09:27 INFO - 'NO_EM_RESTART': '1', 03:09:27 INFO - 'PAGER': '/bin/cat', 03:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:27 INFO - 'PWD': '/builds/slave/test', 03:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:27 INFO - 'SHELL': '/bin/bash', 03:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:27 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:27 INFO - 'USER': 'cltbld', 03:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:27 INFO - 'XPC_FLAGS': '0x0', 03:09:27 INFO - 'XPC_SERVICE_NAME': '0', 03:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:27 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Y3YYWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:27 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-MCrKZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:27 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-tt1VCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:27 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-yw88ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-H89Bq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-GwPxgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-_EOHCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-yJ_tn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-yZ0WzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-aG0DkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-4nYU3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-_QuB0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-7v5trF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-H3q6Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-BMwsTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-SGt9HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-tzjryj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:29 INFO - Running setup.py install for manifestparser 03:09:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:29 INFO - Running setup.py install for mozcrash 03:09:29 INFO - Running setup.py install for mozdebug 03:09:29 INFO - Running setup.py install for mozdevice 03:09:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Running setup.py install for mozfile 03:09:30 INFO - Running setup.py install for mozhttpd 03:09:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Running setup.py install for mozinfo 03:09:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Running setup.py install for mozInstall 03:09:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Running setup.py install for mozleak 03:09:30 INFO - Running setup.py install for mozlog 03:09:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:30 INFO - Running setup.py install for moznetwork 03:09:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:31 INFO - Running setup.py install for mozprocess 03:09:31 INFO - Running setup.py install for mozprofile 03:09:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:31 INFO - Running setup.py install for mozrunner 03:09:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:31 INFO - Running setup.py install for mozscreenshot 03:09:31 INFO - Running setup.py install for moztest 03:09:31 INFO - Running setup.py install for mozversion 03:09:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:09:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:32 INFO - Cleaning up... 03:09:32 INFO - Return code: 0 03:09:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:32 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:09:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:32 INFO - 'HOME': '/Users/cltbld', 03:09:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:32 INFO - 'LOGNAME': 'cltbld', 03:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:32 INFO - 'MOZ_NO_REMOTE': '1', 03:09:32 INFO - 'NO_EM_RESTART': '1', 03:09:32 INFO - 'PAGER': '/bin/cat', 03:09:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:32 INFO - 'PWD': '/builds/slave/test', 03:09:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:32 INFO - 'SHELL': '/bin/bash', 03:09:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:32 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:32 INFO - 'USER': 'cltbld', 03:09:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:32 INFO - 'XPC_FLAGS': '0x0', 03:09:32 INFO - 'XPC_SERVICE_NAME': '0', 03:09:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:32 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-D0LcsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:32 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-uAyXlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:32 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)) 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:32 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-LB1kOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:32 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-991ThT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:32 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)) 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:32 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-veoLcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:32 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-RgbYxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:32 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-uKow7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-YlEoXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-y9dayO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-UbUqUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-y3yhhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-3vxcW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:33 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)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-rfCbj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-zZANGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:33 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)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-1ahYt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-XGn4E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:33 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)) 03:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-42Gt9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:09:34 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)) 03:09:34 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)) 03:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:09:34 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)) 03:09:34 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)) 03:09:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:36 INFO - Downloading blessings-1.6.tar.gz 03:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:37 INFO - Installing collected packages: blessings 03:09:37 INFO - Running setup.py install for blessings 03:09:37 INFO - Successfully installed blessings 03:09:37 INFO - Cleaning up... 03:09:37 INFO - Return code: 0 03:09:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:37 INFO - Reading from file tmpfile_stdout 03:09:37 INFO - Current package versions: 03:09:37 INFO - blessings == 1.6 03:09:37 INFO - blobuploader == 1.2.4 03:09:37 INFO - docopt == 0.6.1 03:09:37 INFO - functools32 == 3.2.3-2 03:09:37 INFO - jsonschema == 2.5.1 03:09:37 INFO - manifestparser == 1.1 03:09:37 INFO - mozInstall == 1.12 03:09:37 INFO - mozcrash == 0.17 03:09:37 INFO - mozdebug == 0.1 03:09:37 INFO - mozdevice == 0.48 03:09:37 INFO - mozfile == 1.2 03:09:37 INFO - mozhttpd == 0.7 03:09:37 INFO - mozinfo == 0.9 03:09:37 INFO - mozleak == 0.1 03:09:37 INFO - mozlog == 3.4 03:09:37 INFO - moznetwork == 0.27 03:09:37 INFO - mozprocess == 0.23 03:09:37 INFO - mozprofile == 0.28 03:09:37 INFO - mozrunner == 6.12 03:09:37 INFO - mozscreenshot == 0.1 03:09:37 INFO - mozsystemmonitor == 0.3 03:09:37 INFO - moztest == 0.7 03:09:37 INFO - mozversion == 1.4 03:09:37 INFO - psutil == 3.1.1 03:09:37 INFO - requests == 1.2.3 03:09:37 INFO - wsgiref == 0.1.2 03:09:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:37 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 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:37 INFO - 'HOME': '/Users/cltbld', 03:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:37 INFO - 'LOGNAME': 'cltbld', 03:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:37 INFO - 'MOZ_NO_REMOTE': '1', 03:09:37 INFO - 'NO_EM_RESTART': '1', 03:09:37 INFO - 'PAGER': '/bin/cat', 03:09:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:37 INFO - 'PWD': '/builds/slave/test', 03:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:37 INFO - 'SHELL': '/bin/bash', 03:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:37 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:37 INFO - 'USER': 'cltbld', 03:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:37 INFO - 'XPC_FLAGS': '0x0', 03:09:37 INFO - 'XPC_SERVICE_NAME': '0', 03:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:09:37 INFO - Cleaning up... 03:09:37 INFO - Return code: 0 03:09:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d00e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf84570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd952c9e390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, '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.Idzg5GRHkd/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.zWa0VumA9p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:37 INFO - 'HOME': '/Users/cltbld', 03:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:37 INFO - 'LOGNAME': 'cltbld', 03:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:37 INFO - 'MOZ_NO_REMOTE': '1', 03:09:37 INFO - 'NO_EM_RESTART': '1', 03:09:37 INFO - 'PAGER': '/bin/cat', 03:09:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:37 INFO - 'PWD': '/builds/slave/test', 03:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:37 INFO - 'SHELL': '/bin/bash', 03:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:09:37 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:37 INFO - 'USER': 'cltbld', 03:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:37 INFO - 'XPC_FLAGS': '0x0', 03:09:37 INFO - 'XPC_SERVICE_NAME': '0', 03:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:09:38 INFO - Cleaning up... 03:09:38 INFO - Return code: 0 03:09:38 INFO - Running post-action listener: _resource_record_post_action 03:09:38 INFO - Running post-action listener: _start_resource_monitoring 03:09:38 INFO - Starting resource monitoring. 03:09:38 INFO - [mozharness: 2016-11-14 11:09:38.188312Z] Finished create-virtualenv step (success) 03:09:38 INFO - [mozharness: 2016-11-14 11:09:38.189087Z] Running install step. 03:09:38 INFO - Running pre-action listener: _resource_record_pre_action 03:09:38 INFO - Running main action method: install 03:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:38 INFO - Reading from file tmpfile_stdout 03:09:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:09:38 INFO - Reading from file tmpfile_stdout 03:09:38 INFO - Output received: 03:09:38 INFO - Usage: mozinstall [options] installer 03:09:38 INFO - Options: 03:09:38 INFO - -h, --help show this help message and exit 03:09:38 INFO - -d DEST, --destination=DEST 03:09:38 INFO - Directory to install application into. [default: 03:09:38 INFO - "/builds/slave/test"] 03:09:38 INFO - --app=APP Application being installed. [default: firefox] 03:09:38 INFO - mkdir: /builds/slave/test/build/application 03:09:38 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'] 03:09:38 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 03:10:11 INFO - Reading from file tmpfile_stdout 03:10:11 INFO - Output received: 03:10:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:10:11 INFO - Running post-action listener: _resource_record_post_action 03:10:11 INFO - [mozharness: 2016-11-14 11:10:11.027509Z] Finished install step (success) 03:10:11 INFO - [mozharness: 2016-11-14 11:10:11.027625Z] Running run-tests step. 03:10:11 INFO - Running pre-action listener: _resource_record_pre_action 03:10:11 INFO - Running main action method: run_tests 03:10:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:10:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:10:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:10:11 INFO - 2016-11-14 03:10:11.042 screenresolution[1637:7697] starting screenresolution argv=screenresolution get 03:10:11 INFO - 2016-11-14 03:10:11.044 screenresolution[1637:7697] Display 0: 1600x1200x32@60 03:10:11 INFO - 2016-11-14 03:10:11.050 screenresolution[1638:7699] starting screenresolution argv=screenresolution list 03:10:11 INFO - Available Modes on Display 0 03:10:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:10:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:10:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:10:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:10:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:10:11 INFO - Intel Iris: 03:10:11 INFO - Chipset Model: Intel Iris 03:10:11 INFO - Type: GPU 03:10:11 INFO - Bus: Built-In 03:10:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:10:11 INFO - Vendor: Intel (0x8086) 03:10:11 INFO - Device ID: 0x0a2e 03:10:11 INFO - Revision ID: 0x0009 03:10:11 INFO - Displays: 03:10:11 INFO - Display: 03:10:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:10:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:10:11 INFO - Display Serial Number: 1600x1200 60 03:10:11 INFO - Main Display: Yes 03:10:11 INFO - Mirror: Off 03:10:11 INFO - Online: Yes 03:10:11 INFO - Rotation: Supported 03:10:11 INFO - Return code: 0 03:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:11 INFO - Python 2.7.3 03:10:11 INFO - Return code: 0 03:10:11 INFO - grabbing minidump binary from tooltool 03:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:11 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 0x10ce22d30>, '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 0x10cc88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce1ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:10:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:10:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:10:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:11 INFO - Return code: 0 03:10:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:10:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:10:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:11 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/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:10:11 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/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Idzg5GRHkd/Render', 03:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:11 INFO - 'HOME': '/Users/cltbld', 03:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:11 INFO - 'LOGNAME': 'cltbld', 03:10:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:11 INFO - 'MOZ_NO_REMOTE': '1', 03:10:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:11 INFO - 'NO_EM_RESTART': '1', 03:10:11 INFO - 'PAGER': '/bin/cat', 03:10:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:11 INFO - 'PWD': '/builds/slave/test', 03:10:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:11 INFO - 'SHELL': '/bin/bash', 03:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zWa0VumA9p/Listeners', 03:10:11 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 03:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:11 INFO - 'USER': 'cltbld', 03:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:11 INFO - 'XPC_FLAGS': '0x0', 03:10:11 INFO - 'XPC_SERVICE_NAME': '0', 03:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:11 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/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:10:11 INFO - mozversion application_buildid: 20161114015620 03:10:11 INFO - mozversion application_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 03:10:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:10:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:11 INFO - mozversion application_name: Firefox 03:10:11 INFO - mozversion application_remotingname: firefox-dev 03:10:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:10:11 INFO - mozversion application_vendor: Mozilla 03:10:11 INFO - mozversion application_version: 51.0a2 03:10:11 INFO - mozversion platform_buildid: 20161114015620 03:10:11 INFO - mozversion platform_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 03:10:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:10:11 INFO - mozversion platform_version: 51.0a2 03:10:11 INFO - using testdate: 1479121811 03:10:11 INFO - actual date: 1479121811 03:10:11 INFO - starting webserver on 'localhost:49272' 03:10:11 INFO - SUITE-START | Running 2 tests 03:10:11 INFO - TEST-START | dromaeo_css 03:10:11 INFO - operating with platform_type : mac_ 03:10:11 INFO - Initialising browser for dromaeo_css test... 03:10:11 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpInOfQb/profile http://localhost:49272/getInfo.html) 03:10:13 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 03:10:13 INFO - PROCESS | 1648 | colorDepth:24 03:10:13 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 03:10:13 INFO - PROCESS | 1648 | __metrics 03:10:14 INFO - PROCESS | 1648 | 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" 03:10:14 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:10:14 INFO - TEST-INFO | 1648: exit 0 03:10:14 INFO - Browser initialized. 03:10:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:14 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpInOfQb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:26 INFO - PROCESS | 1650 | RSS: Main: 219578368 03:10:26 INFO - PROCESS | 1650 | 03:11:18 INFO - PROCESS | 1650 | 1479121878309 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] 03:13:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 03:13:31 INFO - PROCESS | 1650 | RSS: Main: 322064384 03:13:31 INFO - PROCESS | 1650 | 03:16:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 03:16:35 INFO - PROCESS | 1650 | RSS: Main: 352681984 03:16:35 INFO - PROCESS | 1650 | 03:19:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 03:19:38 INFO - PROCESS | 1650 | RSS: Main: 314081280 03:19:38 INFO - PROCESS | 1650 | 03:22:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 03:22:40 INFO - PROCESS | 1650 | RSS: Main: 315985920 03:22:40 INFO - PROCESS | 1650 | 03:25:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 03:25:45 INFO - PROCESS | 1650 | RSS: Main: 312160256 03:25:45 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 03:28:48 INFO - PROCESS | 1650 | RSS: Main: 412651520 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | __start_tp_report 03:28:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 03:28:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 03:28:48 INFO - PROCESS | 1650 | |i|pagename|runs| 03:28:48 INFO - PROCESS | 1650 | |0;dojo.html;2771.2517620242534;3356.0770788033287;3384.4923261510785;3384.984504648605;3418.982905085474;5797.797077102302;5818.0400233961345;5860.150278209662;5881.117832325142;5934.020886553719;5780;5844.357120716729;5853.765849366031;5854.677992710399;5859.6777177255235;5184.300119483869;5324.973375133139;5326.121190003645;5334;5371.865703357408;5250.606204534656;5257.211418287268;5275.235090911816;5285.86785330366;5397.7031263280505;5320.680759154463;5370.865728356803;5395.973020134914;5403.648762830423;5418.972905135489;5372.57019438444;5373.489518495737;5381.461853814587;5389.946100538984;5397.27136836526;5204.115300398941;5224.190250511177;5250.921236181461;5321.840344789663;5390.0836857734275;5683.545316374722;5729.88540229193;5776.422357764232;5794.855128621776;5797.623154494944;6239.313675495692;6249.2813326467585;6272.341404152589;6319.74721011159;6329.145565348711;6311.368863113652;6312.084747711556;6318.2733985591785;6328.272248691414;6334.986402175676;5670.376258611549;5808.099744539603;5812;5812.070068788974;5846.152307915413;6306.527010474233;6311.684415779193;6325.683715814191;6344.904826427515;6354.4281014708895;6200.100985357098;6224.470919971763;6228.875422491525;6245.281792593819;6247.156633854372;6154.169187159766;6199.938000620026;6237.438630523275;6334.9683251584365;6358.91898377277;6232.252129744369;6312.779052733133;6319.494440444753;6325.462335701517;6331.176946996861;6191.133241346215;6334.9366506334345;6348.587341822767;6351.745930162741;6354.17395738551;4851.369321988119;4916.950830491721;4974.1543937530705;4979.3526841510375;4990.850274491771;4427.5572442755465;4477.462704475419;4482.955170448319;4486.3494793254795;4557.248054071041;5924.674142922095;5952.255968003999;5953.880922381528;5958.791442299499;5967.910481342783;6261.7182226799905;6297.748090076438;6303.991361382157;6313.05304204373;6320;5677.517411020027;5694.1458781183155;5745.109508026263;5834.708264586839;5917.852053698692;5480.177973303957;5480.588955828329;5493.725313734377;5498.642588231832;5517.531009864127;6370.968145159244;6382.648954307465;6388.2972872984865;6389.233292004897;6395.680215989275;6140.416660417253;6293.496520278275;6293.937060629335;6296.559240853279;6306.085617585516;5371.4897084776885;6236.968815156077;6276.623402595859;6377.74489020434;6381.3937675920715;6273.65494897785;6273.749050037947;6279.874402512016;6292.874142517033;6300.117983482408;6197.411245931629;6256.280527739368;6257.2804127525915;6299.685015749103;6321.273053598711;6101.877962440815;6134.4172303631085;6173.290071641819;6243.625382476885;6251.187345645037;6187.319394866471;6205.131281620667;6212.9068063978175;6235.906461402992;6242.28213755424;5919.556033297434;6016.398360163948;6054.90917636227;6055.485283750931;6070.271567411939;6114.38856114385;6134.222293197161;6153.815385538441;6213.347598502092;6279.748810047729;6040.679688550763;6094.9085763714465;6120.233815636221;6128.689509994036;6131.816045518463 03:28:48 INFO - PROCESS | 1650 | |1;ext.html;474.2341119092665;499.8575406009287;529.1480716047166;533.0644718518998;570.9942900570995;26759.922608899982;30239.99999999997;32076.839615801946;32132.67867321326;32369.51445728313;32965;33466.330673386576;41400.37899431503;42376.788116059455;42509.57490425095;9707.75730606737;9856.211503079772;9862.704118876409;9872.950635246849;9889.604415823358;9738.51307434629;9855.162311203556;9855.901440985606;9859.014098590156;9862.11240988311;8704.260137888286;8894.555272236395;9812.754681132994;11851.881481185206;12055.27668339898;12141.635750927486;12180.634580962585;12183.695407614881;12201.145919785618;12217.328046957413;11844.88155118455;11940.761184776256;11947.940260298643;11956.163068585203;11967.581134660246;31285.687143128504;31809.36381272385;39777.20445591101;39876.800615997025;39933.40099898504;3317.319949410365;3356.261622443083;3599.8020108894;3625.673689367943;3963.2667956427863;29493.262668433246;30331;30527.08418747419;31529.52705709416;31841.84079079613;3279.5527792145795;3301.7688761786685;3341.6491268416953;3359.7144242739396;3386.102682789063;519176;520266;521445;521532;526650.3667481677;48920;49865.75067124641;50152.49847501551;52827.73586132121;52905.94188116216;60034.69982650146;61454;61639;64570;65341.67329163324;16051.277692503865;16253.674926501404;16260.105694186934;16272.105034222994;16272.674546509004;12599.5590154346;12708.364581770875;12709.682257943625;12719.554815581596;12720.918721908742;13882.514112006233;14026.50907218263;14578.542145785548;15593.844061559466;15740.291686874118;4971.676841005323;6947.930520694728;7090.539114957512;7099.361057504746;7173.856522869513;900.909909009107;936.5130132331286;978.9412635241908;1018.4856647393167;1047.61238341814;27515;29571.408571828444;29573.55639665407;30087.94692185763;30477.542836857465;1066.7173199102244;1071.6838532632892;1098.763765790359;1127.8590176227972;1142.457332766929;15005.849941500444;15527.534173974798;15566.533004009898;15582;15603.947831518228;681611;684489;685390;685566;686712;57065.85868282611;57294.71352643293;57309.71345143331;57349.426505735246;57577.71211143918;1211.4790640024873;1268.1186575330241;1351.236551348485;1376.876081152701;1398.8601139886134;29028;30311.84844075854;30489.54265685972;30795.69204307928;31447.685523144475;48095.27857082077;48532;48625.756871216836;48644.513554863996;48651.27023094727;475471;476585;477148;477393;479184;25618.23145305644;26254.212373628823;26427.735722642527;27133.72866271391;27179.184624461297;46084.53915460803;46438.071238575714;46645.76677116593;46728.29907551457;46932.296015560474;37997.53101168818;38083.61916380912;38671.80664096661;38689.6131038686;39593.80203098966;38302.42546361751;38645.420318694676;39036.60963390443;39217.6078239214;39909.2018159641;36791.81604091962;36903.89288321355;38062.85811425662;38063.80968095142;39441.802790985865;32896;34153.146171345914;34791.65208347985;34838.9548313551;35083;21948.231811887144;25477.3630659235;25503.107391241218;25657.174561758842;25710.61434078453 03:28:48 INFO - PROCESS | 1650 | |2;jquery.html;348.8866118511484;373.23673088533945;376.34515942260464;383.0767849482746;399.9780012099335;14981.250937453138;15125.546233612982;16374.672506549878;20234.89882550589;20817.27139550116;18587.721184182246;18810.15354309056;19744.506387340323;20460.59078818423;20743.896280518577;5462.989346970803;5950.613210141338;6131.233595800525;6182.567220294582;6223.875522489548;3504.702100321476;4470.173017991666;4478.932816007762;6062.42406971337;6116.235470566179;6539.4114529692315;6860.108185935846;6860.931390686104;6938.063361446216;6949.061876646639;6602.801915942506;6784.7964561063;6857.177138743333;6868.587884726882;6884.0362349270645;5708.229389032469;5920.733566989496;5953.464188223037;5954.732037058299;5955.851103722398;25404.87297563519;25463.363415914566;25698.614520782205;25712;25985.480290394276;2294.1626306398043;2353.411647088228;2354.1407386304045;2487.129504673368;3010.443068032421;15371.385144594204;15453.840961927901;15648.92175539115;16008.679826403406;16158.515244542683;1810.7464954906325;1856.2667746240295;1867.8419379984362;1867.8785878917963;1915.4349466907295;119356.80643193543;121468.39265803703;125645;125837;125972;9312.534373281309;9729.416235025921;9963.252756043326;10022.198224142052;10139.64511242103;12437.00503959681;12514.874851251552;12531.874681253254;12535.122541422013;12562.560310389092;6741.8651626967185;7835.960820195863;8044.3564514839845;8112.918870811216;8130.186981301823;8392.244697977212;8395.790105247295;8410.495370277802;8525.658973640984;8529.57352132391;3837.6929845612285;3852.325842977468;3867.497225360685;3913.9804300978312;3926.941095883507;1768.4075834595296;1806.5059686212574;1818.3181307009872;1922.9520560602914;1989.60207958406;866.3545658484469;888;934.1965909317981;961.1493827962304;975.3708857786829;16252.674946501003;21159.153633854472;21177.894110529658;21295.254666086923;21458;830.3274347778198;879.9780005499786;931.8648795924688;947.6825263536792;949.8765160529225;10617.416042117604;10686;11143.108551315876;11199.272047316897;11210.607628732956;476723;574181;574476;575185;616086;131083.34458327838;131794;133713;137252;141749;959.822432849925;966.1063516247443;980.1472718734747;1003.2776400991274;1004.347174336687;15455.84544154544;18445.53886152857;19169.233230670616;19597.31409400664;19764.703529447357;42604.78697606492;46855;55294.44705552893;57513.13730293965;58057.4194258052;81218;81724;82714;85094;85410.71883921622;7943;7953.18962774435;7954.323882469824;8414.537200454033;8494.91505084966;11398.316101033965;12694.111412201057;12758.87241127614;12801.167924084904;13039.022073344728;10925.890741092806;11088.112950964065;11156.107511398906;11398.601048963246;11497.770044598894;10974.890251097388;10978.670639880816;11090.611828585961;11231.775364492501;11253.268537545033;11359.829602555803;11378.715532111764;11389.772204556028;11410.54357825711;11681.941590291994;7019.227884932551;7239.058922340273;7427.517211381243;7556.546607203585;8119.4722343047515;9593.712188634352;11040.889591104307;11465;11531.365774882126;11565.132615053737 03:28:48 INFO - PROCESS | 1650 | |3;mootools.html;1406.2687402550673;1516.4540765324484;1682.9747553786694;1868.6262747450514;1878.5491482044313;8492.447990880597;9036.457812531253;9046.140616641425;9048.230900373468;9059.411138276017;7906.80232994174;8165.51006939584;8187.91812081879;8652.826943461127;8850.291976641869;2369.395804069964;2394.6647469354302;2397.6883005209297;2398.244552965819;2399.8800059997016;2030.46192758919;2358.740538540759;2369.2536850892;2406.7713567211085;2412.9879350603223;2103.032605001701;2189.3979155732222;2329.5690297295055;2401.1955994741697;2408.7470815564375;1993.9700904486444;2382.3924899150693;2412.1436889904094;2412.4692567635093;2417;2000.4198782353246;2394.114177754242;2398.9640155397683;2402.8678422686744;2406.2300063979533;8927.642894284221;8999.19007289347;9005.684801031932;9016.278697704169;9048.77378065547;5248;5374.516293533601;5451.754671039813;5462.590305727047;5465.754041068121;3474.5483087198504;3533.840977156034;3607.098225443639;3658.158623516606;3669.559652841676;1069.0825836817517;1103.1450625765017;1106.0543235533664;1129.8531190945207;1130.1693255457233;11897.048236141089;12024.579139730067;12027;12047.277163370138;12053.457594408274;4066.9796651017145;4588.3805686231935;4649.628029757611;4868.975655121772;4870.293807397908;10072.647457338959;10078.445685487222;10100.494975251208;10100.898991009995;10101.646442374482;5353.250544923714;5354;5358.839234822962;5364.678119312854;5366.114591092426;4749.976250118796;4867.780949857265;4874.683145595525;4894.583960363409;4895.632827537877;3936.4685767421606;3960.5247370315747;3975.463312452782;4020.537638171589;4057.655099316591;1173.8943495085311;1268.5750273658427;1272;1275.7384736129072;1291.6835375333103;791.9941674073893;802.6829402386142;832.633641197871;882.9911700883038;974.4494360686332;5833.6413309492855;5909.911351329733;6002.459778619857;6166.753329866845;6221.657808820468;807.1878632470142;924.3160061554536;945.9621615135455;966.0146650416535;996.4071377530358;3967.8016099194924;3989.3617021276455;4001.379786133154;4005.0988527581644;4020.798960051986;10727.624533141303;10930.070943969851;11053.060489858452;11084.445777711082;11084.778304433867;10911.290766100177;10962.56149754001;10992.890071099346;11012.724681883017;11017.83473247902;7894.6842126314305;8266.297364724065;8288.63237565795;8335.749927502186;8357.95821020891;5171.612129090258;5990.741944191768;6064.786352981042;6076.513878889767;6091.725872335667;9594.904050959402;9936.701898943043;10151.543180556744;10237.23220758461;10326.070653640907;9909.504524773589;10245;10339.75922889258;10457.26799124054;10471.895281047397;7299.160596531467;7556.093268807778;7573.848523029619;7679.961600192187;7776;8438.493690378597;8544.145585441654;8551.187637174458;8555.486670799772;8568.957155214184;7469.663865126191;7562.432817538596;7587.848243035219;7604.163542010485;7726.42051846125;7318.3047610476915;7426.962865185639;7453.627318634155;7498.887516687145;7654.196309387657;6963.651817409008;6999.1950925644205;7009.439244860297;7125.714971401293;7143.392811611071;4969.527894849984;4993.750312484289;5030.0945829749535;5078.97460512695;5161.458046905021;4986.476419975996;5011.724355160355;5107.9489205107475;5119.590432765444;5164.354455693038 03:28:48 INFO - PROCESS | 1650 | |4;prototype.html;238.67778499026312;299.66437589899317;305.6591900031464;306.97851150419467;312.45944515987327;4770.761461926907;5422.539084177844;5501.394846566875;5504.944950550494;5521.122818241797;5120.206368012964;5295.205719142131;5307.65500242484;5326.416687906372;5338.759755810988;3659.597444281127;3909.2572411241918;3948.7038472114564;4133.656561617471;4212.683024336618;3475.6003059648083;4164.875053748392;4187.602177793105;4209.327077305918;4245.617894389505;3987.4018897165365;4146.523149837762;4159.980804702852;4182.309918863384;4197.916041679165;4108.897277568085;4135.855245066408;4144.8134833932545;4145.730527515701;4170.374443833419;3605.855765769366;3611.6636844367754;3613.728970327236;3624.4744512045604;3653.799041052741;4072.6131017553284;4521.525239849801;4736.123817093849;5336.039512887679;5388.275751759438;4663.930041049387;4672.4393072831135;4691.554302341272;4697.741624210667;4750.738709370983;4826.986332870101;5097.617678674114;5271.65734227274;5485.149801780731;5798.391168927286;3726.552813662378;3881.3983832506005;3882.8446862125766;3890.5489541588618;3892.0853599404118;5649.954758369715;5892.793752218652;5986.2517185351835;5993.730282137314;6002.069679199731;3931.6658084063174;3944.8422063117728;3956.9208615827524;3957.168994511185;3978.1754953982995;3416.6241713411505;3681.950644066482;3972.3445631470486;4027.496562929634;4044.757314561077;4270.935935960963;4430.003249268889;4791.401074865642;4810.7113573185725;4858.562729354305;4744.5492678195515;5114.462981386975;5210.088234558937;5852.4147585241135;5858.882822343529;1294.9834380011646;1330.2683524061727;1393.9233342166278;1413.6640874373618;1418.0995068131604;845.5625436757537;939.5161491831713;970.1995853420815;971.0241207586472;971.1502435369052;4364.432623758891;5363.249145119687;5363.436839131913;5389.407165211824;5623.915641265385;4604.677672562889;5277.920831187535;5530;5853.239078919713;5870.559708021916;4662.673612847068;4994.600431965434;5381.013537486654;5394.406615272317;5400.297961265011;2705.3642394037383;3081.7534597232166;3102.6897310269246;3113.6025260549704;3140.5132204508336;4873.343063358475;5115.7442127893455;5302.946970530323;5994.520438364921;6092.070614453741;4862.635302352338;5509.531689806411;5540.113581826889;5968.552358573038;5986.970065149733;5651.321841379061;6032.39676032402;6055.424734650202;6069.544784141119;6070.544709146743;5183.896322073613;5498.477644623755;5828.504577110993;5831.620944638585;5831.708414579339;4912.484189160086;4928.940277840282;5261.500157485033;5791.13133030032;5872.207252020922;5699.686517241592;5853.853653658693;5997.301214453426;6000.669963152069;6073.813427166305;3327.850246738854;3497.860085596548;3866.2460820139804;3894.5131858517684;3908.081600823861;4876.463589005136;6000.849978750566;6032.487238584769;6045.546584006129;6051.1830902829315;5018.5232402921665;5612.635178713371;5752.440164126923;5834.795782147605;5841.970790146022;5169.68173115853;5641.774329026793;5729.742161602655;5747.023006088892;5775.393583673654;5346.8395948121615;5533.944660553343;5622.409646987007;5624.409437009055;5636.605437619327;5753.475329037892;5754.539636829128;5760.596758227051;5781.653100813965;5793.768249270151;4988.850334489971;5388.165509978011;5534.806281780118;5599.776008959759;5631 03:28:48 INFO - PROCESS | 1650 | |5;yui.html;716.4018044932482;755.305119290253;774.7598244544191;790.201896084954;829.9045609754878;14489.855101448982;14699;15974.520764377074;16011.359545618176;16907.1546422679;16526.66946661066;16917;16959;16977.98132112074;17036;675.6689222281096;773.8276511085695;814.7922279818638;873.1792115411524;874.4097734029536;697.5082566790426;706.2972342519175;751.3538357012992;823.4894365493373;847.7880529867533;843.7974886027371;872.6989188729877;882.2104216726026;883.9734807955772;889.6041261638574;883.2360008592585;883.5935469683953;884.385352180235;885.0087901550305;885.0485727842563;523.3118449239238;540.2787278982563;541.4044550993915;546.1425561867869;660.7753363856264;12617.936910315482;15184.46854360092;15273.541793746093;15332;15968.121753303563;14043.368048437742;14354.64113397163;14391.280435978158;14394.280285985764;14481;11510.539578416854;11859.169858109935;11861.406929653569;11878.821817672742;11969.640910772603;3784.9810750946344;3844.1350696093436;3879.709021823346;3945.28984782739;3949.921001579981;90709.37162513491;110647.44676276647;113739;115642;116824.41587792007;8831.161039701217;10699.518521666543;10710.143188544898;10975.451227438596;11163.330200188015;21866.89066554657;21881.67177492339;21897.343079707633;21932.780672193392;21947.890260548596;7549.698012079565;8000.51996880189;8024.956755621732;8072.192780721881;8078.798030049295;4405.691601587858;4411.205982923105;4476.104779044204;4597.839075632337;4638.884027899262;3566.5363502744476;3662.6520480554304;3724.7206459515646;3733.1600389912596;3734.4958430612064;634.1629049654504;640.3436477610486;644.3427703742157;654.326044174501;659.5745743995096;578.9247397838254;678.6301465701205;679.3172861274387;679.9053523826734;682.5017737051979;7927.167647397056;9092.681756138636;9504.857427138599;9566.838425284885;9932.900670993342;543.5407081016534;638.0142679560091;653.9803805885831;669.5882032549947;692.3768608252512;4358.21552120615;4774.259989701602;4807.759612019455;4807.831725889577;4881.560659540658;88066.63366980126;90256.09743902608;94571.52714236385;125990;148524.51475485106;104683.2201976897;105291.47354263334;107209;113725;115598;93783.53108234415;96828.84707003296;98438.01561984289;100005.49997249967;103470;9009.23421509179;9029.503377314048;9043.68347107848;9160.6793762218;9439.244860411014;58089;58632.82734345204;59167;59847;61638;81078;82807.75788363299;87223;87301;91140;12935.805962910375;13034.152780069266;13083.084184107402;13263.535776247785;13373.264470454218;14364.353604087632;14766.409343626136;14844.925775371054;14852.183129927958;14916;13389.397477113358;13487.527936522174;13526.797098043735;13785.862141378859;14403.135811850903;13382.732345353234;13412.597622071353;13632.591022269347;14084.01411901157;14587.927060364631;13303.66740831487;13707.725845483234;13987;14209.857901421266;14216.289185540889;8883.822323553364;11256.718582035515;11551.653450396165;11677.708057298636;11840.644780656594;11444.625756645572;11445.942770286096;11668.824967625322;11716.648500544998;11728.589499367481 03:28:48 INFO - PROCESS | 1650 | __end_tp_report 03:28:48 INFO - PROCESS | 1650 | __start_cc_report 03:28:48 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1297 03:28:48 INFO - PROCESS | 1650 | __end_cc_report 03:28:48 INFO - PROCESS | 1650 | __startTimestamp1479122928468__endTimestamp 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | ------- Summary: start ------- 03:28:48 INFO - PROCESS | 1650 | Number of tests: 6 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5823.36 Median:6094.91 stddev:654.87 (10.7%) stddev-sans-first:611.54 03:28:48 INFO - PROCESS | 1650 | Values: 2771.3 3356.1 3384.5 3385.0 3419.0 5797.8 5818.0 5860.2 5881.1 5934.0 5780.0 5844.4 5853.8 5854.7 5859.7 5184.3 5325.0 5326.1 5334.0 5371.9 5250.6 5257.2 5275.2 5285.9 5397.7 5320.7 5370.9 5396.0 5403.6 5419.0 5372.6 5373.5 5381.5 5389.9 5397.3 5204.1 5224.2 5250.9 5321.8 5390.1 5683.5 5729.9 5776.4 5794.9 5797.6 6239.3 6249.3 6272.3 6319.7 6329.1 6311.4 6312.1 6318.3 6328.3 6335.0 5670.4 5808.1 5812.0 5812.1 5846.2 6306.5 6311.7 6325.7 6344.9 6354.4 6200.1 6224.5 6228.9 6245.3 6247.2 6154.2 6199.9 6237.4 6335.0 6358.9 6232.3 6312.8 6319.5 6325.5 6331.2 6191.1 6334.9 6348.6 6351.7 6354.2 4851.4 4917.0 4974.2 4979.4 4990.9 4427.6 4477.5 4483.0 4486.3 4557.2 5924.7 5952.3 5953.9 5958.8 5967.9 6261.7 6297.7 6304.0 6313.1 6320.0 5677.5 5694.1 5745.1 5834.7 5917.9 5480.2 5480.6 5493.7 5498.6 5517.5 6371.0 6382.6 6388.3 6389.2 6395.7 6140.4 6293.5 6293.9 6296.6 6306.1 5371.5 6237.0 6276.6 6377.7 6381.4 6273.7 6273.7 6279.9 6292.9 6300.1 6197.4 6256.3 6257.3 6299.7 6321.3 6101.9 6134.4 6173.3 6243.6 6251.2 6187.3 6205.1 6212.9 6235.9 6242.3 5919.6 6016.4 6054.9 6055.5 6070.3 6114.4 6134.2 6153.8 6213.3 6279.7 6040.7 6094.9 6120.2 6128.7 6131.8 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:68831.91 Median:3612.74 stddev:152050.71 (4208.7%) stddev-sans-first:152390.63 03:28:48 INFO - PROCESS | 1650 | Values: 474.2 499.9 529.1 533.1 571.0 26759.9 30240.0 32076.8 32132.7 32369.5 32965.0 33466.3 41400.4 42376.8 42509.6 9707.8 9856.2 9862.7 9873.0 9889.6 9738.5 9855.2 9855.9 9859.0 9862.1 8704.3 8894.6 9812.8 11851.9 12055.3 12141.6 12180.6 12183.7 12201.1 12217.3 11844.9 11940.8 11947.9 11956.2 11967.6 31285.7 31809.4 39777.2 39876.8 39933.4 3317.3 3356.3 3599.8 3625.7 3963.3 29493.3 30331.0 30527.1 31529.5 31841.8 3279.6 3301.8 3341.6 3359.7 3386.1 519176.0 520266.0 521445.0 521532.0 526650.4 48920.0 49865.8 50152.5 52827.7 52905.9 60034.7 61454.0 61639.0 64570.0 65341.7 16051.3 16253.7 16260.1 16272.1 16272.7 12599.6 12708.4 12709.7 12719.6 12720.9 13882.5 14026.5 14578.5 15593.8 15740.3 4971.7 6947.9 7090.5 7099.4 7173.9 900.9 936.5 978.9 1018.5 1047.6 27515.0 29571.4 29573.6 30087.9 30477.5 1066.7 1071.7 1098.8 1127.9 1142.5 15005.8 15527.5 15566.5 15582.0 15603.9 681611.0 684489.0 685390.0 685566.0 686712.0 57065.9 57294.7 57309.7 57349.4 57577.7 1211.5 1268.1 1351.2 1376.9 1398.9 29028.0 30311.8 30489.5 30795.7 31447.7 48095.3 48532.0 48625.8 48644.5 48651.3 475471.0 476585.0 477148.0 477393.0 479184.0 25618.2 26254.2 26427.7 27133.7 27179.2 46084.5 46438.1 46645.8 46728.3 46932.3 37997.5 38083.6 38671.8 38689.6 39593.8 38302.4 38645.4 39036.6 39217.6 39909.2 36791.8 36903.9 38062.9 38063.8 39441.8 32896.0 34153.1 34791.7 34839.0 35083.0 21948.2 25477.4 25503.1 25657.2 25710.6 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34471.23 Median:25848.74 stddev:95106.68 (367.9%) stddev-sans-first:95338.97 03:28:48 INFO - PROCESS | 1650 | Values: 348.9 373.2 376.3 383.1 400.0 14981.3 15125.5 16374.7 20234.9 20817.3 18587.7 18810.2 19744.5 20460.6 20743.9 5463.0 5950.6 6131.2 6182.6 6223.9 3504.7 4470.2 4478.9 6062.4 6116.2 6539.4 6860.1 6860.9 6938.1 6949.1 6602.8 6784.8 6857.2 6868.6 6884.0 5708.2 5920.7 5953.5 5954.7 5955.9 25404.9 25463.4 25698.6 25712.0 25985.5 2294.2 2353.4 2354.1 2487.1 3010.4 15371.4 15453.8 15648.9 16008.7 16158.5 1810.7 1856.3 1867.8 1867.9 1915.4 119356.8 121468.4 125645.0 125837.0 125972.0 9312.5 9729.4 9963.3 10022.2 10139.6 12437.0 12514.9 12531.9 12535.1 12562.6 6741.9 7836.0 8044.4 8112.9 8130.2 8392.2 8395.8 8410.5 8525.7 8529.6 3837.7 3852.3 3867.5 3914.0 3926.9 1768.4 1806.5 1818.3 1923.0 1989.6 866.4 888.0 934.2 961.1 975.4 16252.7 21159.2 21177.9 21295.3 21458.0 830.3 880.0 931.9 947.7 949.9 10617.4 10686.0 11143.1 11199.3 11210.6 476723.0 574181.0 574476.0 575185.0 616086.0 131083.3 131794.0 133713.0 137252.0 141749.0 959.8 966.1 980.1 1003.3 1004.3 15455.8 18445.5 19169.2 19597.3 19764.7 42604.8 46855.0 55294.4 57513.1 58057.4 81218.0 81724.0 82714.0 85094.0 85410.7 7943.0 7953.2 7954.3 8414.5 8494.9 11398.3 12694.1 12758.9 12801.2 13039.0 10925.9 11088.1 11156.1 11398.6 11497.8 10974.9 10978.7 11090.6 11231.8 11253.3 11359.8 11378.7 11389.8 11410.5 11681.9 7019.2 7239.1 7427.5 7556.5 8119.5 9593.7 11040.9 11465.0 11531.4 11565.1 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5789.29 Median:4895.11 stddev:3273.41 (66.9%) stddev-sans-first:3266.02 03:28:48 INFO - PROCESS | 1650 | Values: 1406.3 1516.5 1683.0 1868.6 1878.5 8492.4 9036.5 9046.1 9048.2 9059.4 7906.8 8165.5 8187.9 8652.8 8850.3 2369.4 2394.7 2397.7 2398.2 2399.9 2030.5 2358.7 2369.3 2406.8 2413.0 2103.0 2189.4 2329.6 2401.2 2408.7 1994.0 2382.4 2412.1 2412.5 2417.0 2000.4 2394.1 2399.0 2402.9 2406.2 8927.6 8999.2 9005.7 9016.3 9048.8 5248.0 5374.5 5451.8 5462.6 5465.8 3474.5 3533.8 3607.1 3658.2 3669.6 1069.1 1103.1 1106.1 1129.9 1130.2 11897.0 12024.6 12027.0 12047.3 12053.5 4067.0 4588.4 4649.6 4869.0 4870.3 10072.6 10078.4 10100.5 10100.9 10101.6 5353.3 5354.0 5358.8 5364.7 5366.1 4750.0 4867.8 4874.7 4894.6 4895.6 3936.5 3960.5 3975.5 4020.5 4057.7 1173.9 1268.6 1272.0 1275.7 1291.7 792.0 802.7 832.6 883.0 974.4 5833.6 5909.9 6002.5 6166.8 6221.7 807.2 924.3 946.0 966.0 996.4 3967.8 3989.4 4001.4 4005.1 4020.8 10727.6 10930.1 11053.1 11084.4 11084.8 10911.3 10962.6 10992.9 11012.7 11017.8 7894.7 8266.3 8288.6 8335.7 8358.0 5171.6 5990.7 6064.8 6076.5 6091.7 9594.9 9936.7 10151.5 10237.2 10326.1 9909.5 10245.0 10339.8 10457.3 10471.9 7299.2 7556.1 7573.8 7680.0 7776.0 8438.5 8544.1 8551.2 8555.5 8569.0 7469.7 7562.4 7587.8 7604.2 7726.4 7318.3 7427.0 7453.6 7498.9 7654.2 6963.7 6999.2 7009.4 7125.7 7143.4 4969.5 4993.8 5030.1 5079.0 5161.5 4986.5 5011.7 5107.9 5119.6 5164.4 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4603.92 Median:5144.94 stddev:1404.11 (27.3%) stddev-sans-first:1369.29 03:28:48 INFO - PROCESS | 1650 | Values: 238.7 299.7 305.7 307.0 312.5 4770.8 5422.5 5501.4 5504.9 5521.1 5120.2 5295.2 5307.7 5326.4 5338.8 3659.6 3909.3 3948.7 4133.7 4212.7 3475.6 4164.9 4187.6 4209.3 4245.6 3987.4 4146.5 4160.0 4182.3 4197.9 4108.9 4135.9 4144.8 4145.7 4170.4 3605.9 3611.7 3613.7 3624.5 3653.8 4072.6 4521.5 4736.1 5336.0 5388.3 4663.9 4672.4 4691.6 4697.7 4750.7 4827.0 5097.6 5271.7 5485.1 5798.4 3726.6 3881.4 3882.8 3890.5 3892.1 5650.0 5892.8 5986.3 5993.7 6002.1 3931.7 3944.8 3956.9 3957.2 3978.2 3416.6 3682.0 3972.3 4027.5 4044.8 4270.9 4430.0 4791.4 4810.7 4858.6 4744.5 5114.5 5210.1 5852.4 5858.9 1295.0 1330.3 1393.9 1413.7 1418.1 845.6 939.5 970.2 971.0 971.2 4364.4 5363.2 5363.4 5389.4 5623.9 4604.7 5277.9 5530.0 5853.2 5870.6 4662.7 4994.6 5381.0 5394.4 5400.3 2705.4 3081.8 3102.7 3113.6 3140.5 4873.3 5115.7 5302.9 5994.5 6092.1 4862.6 5509.5 5540.1 5968.6 5987.0 5651.3 6032.4 6055.4 6069.5 6070.5 5183.9 5498.5 5828.5 5831.6 5831.7 4912.5 4928.9 5261.5 5791.1 5872.2 5699.7 5853.9 5997.3 6000.7 6073.8 3327.9 3497.9 3866.2 3894.5 3908.1 4876.5 6000.8 6032.5 6045.5 6051.2 5018.5 5612.6 5752.4 5834.8 5842.0 5169.7 5641.8 5729.7 5747.0 5775.4 5346.8 5533.9 5622.4 5624.4 5636.6 5753.5 5754.5 5760.6 5781.7 5793.8 4988.9 5388.2 5534.8 5599.8 5631.0 03:28:48 INFO - PROCESS | 1650 | 03:28:48 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:22770.42 Median:4154.07 stddev:34172.09 (822.6%) stddev-sans-first:34227.83 03:28:48 INFO - PROCESS | 1650 | Values: 716.4 755.3 774.8 790.2 829.9 14489.9 14699.0 15974.5 16011.4 16907.2 16526.7 16917.0 16959.0 16978.0 17036.0 675.7 773.8 814.8 873.2 874.4 697.5 706.3 751.4 823.5 847.8 843.8 872.7 882.2 884.0 889.6 883.2 883.6 884.4 885.0 885.0 523.3 540.3 541.4 546.1 660.8 12617.9 15184.5 15273.5 15332.0 15968.1 14043.4 14354.6 14391.3 14394.3 14481.0 11510.5 11859.2 11861.4 11878.8 11969.6 3785.0 3844.1 3879.7 3945.3 3949.9 90709.4 110647.4 113739.0 115642.0 116824.4 8831.2 10699.5 10710.1 10975.5 11163.3 21866.9 21881.7 21897.3 21932.8 21947.9 7549.7 8000.5 8025.0 8072.2 8078.8 4405.7 4411.2 4476.1 4597.8 4638.9 3566.5 3662.7 3724.7 3733.2 3734.5 634.2 640.3 644.3 654.3 659.6 578.9 678.6 679.3 679.9 682.5 7927.2 9092.7 9504.9 9566.8 9932.9 543.5 638.0 654.0 669.6 692.4 4358.2 4774.3 4807.8 4807.8 4881.6 88066.6 90256.1 94571.5 125990.0 148524.5 104683.2 105291.5 107209.0 113725.0 115598.0 93783.5 96828.8 98438.0 100005.5 103470.0 9009.2 9029.5 9043.7 9160.7 9439.2 58089.0 58632.8 59167.0 59847.0 61638.0 81078.0 82807.8 87223.0 87301.0 91140.0 12935.8 13034.2 13083.1 13263.5 13373.3 14364.4 14766.4 14844.9 14852.2 14916.0 13389.4 13487.5 13526.8 13785.9 14403.1 13382.7 13412.6 13632.6 14084.0 14587.9 13303.7 13707.7 13987.0 14209.9 14216.3 8883.8 11256.7 11551.7 11677.7 11840.6 11444.6 11445.9 11668.8 11716.6 11728.6 03:28:48 INFO - PROCESS | 1650 | -------- Summary: end -------- 03:28:48 INFO - PROCESS | 1650 | 03:28:49 INFO - TEST-INFO | 1650: exit 0 03:28:49 INFO - TEST-OK | dromaeo_css | took 1117449ms 03:28:49 INFO - TEST-START | kraken 03:28:49 INFO - operating with platform_type : mac_ 03:28:49 INFO - Initialising browser for kraken test... 03:28:49 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpx54GZ6/profile http://localhost:49272/getInfo.html) 03:28:51 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 03:28:51 INFO - PROCESS | 1657 | colorDepth:24 03:28:51 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 03:28:51 INFO - PROCESS | 1657 | __metrics 03:28:51 INFO - PROCESS | 1657 | 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" 03:28:51 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:28:52 INFO - TEST-INFO | 1657: exit 0 03:28:52 INFO - Browser initialized. 03:28:52 INFO - Running cycle 1/1 for kraken test... 03:28:52 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpx54GZ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:04 INFO - PROCESS | 1658 | RSS: Main: 220233728 03:29:04 INFO - PROCESS | 1658 | 03:29:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:08 INFO - PROCESS | 1658 | RSS: Main: 270213120 03:29:08 INFO - PROCESS | 1658 | 03:29:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 03:29:11 INFO - PROCESS | 1658 | RSS: Main: 280756224 03:29:11 INFO - PROCESS | 1658 | 03:29:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 03:29:15 INFO - PROCESS | 1658 | RSS: Main: 379068416 03:29:15 INFO - PROCESS | 1658 | 03:29:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 03:29:17 INFO - PROCESS | 1658 | RSS: Main: 279879680 03:29:17 INFO - PROCESS | 1658 | 03:29:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:20 INFO - PROCESS | 1658 | RSS: Main: 281571328 03:29:20 INFO - PROCESS | 1658 | 03:29:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:23 INFO - PROCESS | 1658 | RSS: Main: 319524864 03:29:23 INFO - PROCESS | 1658 | 03:29:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:27 INFO - PROCESS | 1658 | RSS: Main: 319574016 03:29:27 INFO - PROCESS | 1658 | 03:29:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 03:29:31 INFO - PROCESS | 1658 | RSS: Main: 316911616 03:29:31 INFO - PROCESS | 1658 | 03:29:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:33 INFO - PROCESS | 1658 | RSS: Main: 295956480 03:29:33 INFO - PROCESS | 1658 | 03:29:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:35 INFO - PROCESS | 1658 | RSS: Main: 295989248 03:29:35 INFO - PROCESS | 1658 | 03:29:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:38 INFO - PROCESS | 1658 | RSS: Main: 303751168 03:29:38 INFO - PROCESS | 1658 | 03:29:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:42 INFO - PROCESS | 1658 | RSS: Main: 309989376 03:29:42 INFO - PROCESS | 1658 | 03:29:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:29:45 INFO - PROCESS | 1658 | RSS: Main: 309403648 03:29:45 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 03:29:47 INFO - PROCESS | 1658 | RSS: Main: 353337344 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | __start_tp_report 03:29:47 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 03:29:47 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 03:29:47 INFO - PROCESS | 1658 | |i|pagename|runs| 03:29:47 INFO - PROCESS | 1658 | |0;ai-astar;115;121;168;140;115;111;113;114;115;113 03:29:47 INFO - PROCESS | 1658 | |1;audio-beat-detection;145;108;109;142;109;111;109;107;138;113 03:29:47 INFO - PROCESS | 1658 | |2;audio-dft;182;184;183;183;183;183;181;182;184;184 03:29:47 INFO - PROCESS | 1658 | |3;audio-fft;80;60;59;87;59;58;59;58;82;56 03:29:47 INFO - PROCESS | 1658 | |4;audio-oscillator;87;70;95;68;81;94;123;94;71;89 03:29:47 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;116;98;89;87;89;85;90;86;89;86 03:29:47 INFO - PROCESS | 1658 | |6;imaging-darkroom;94;94;94;94;96;94;94;94;93;93 03:29:47 INFO - PROCESS | 1658 | |7;imaging-desaturate;97;142;83;86;123;139;133;84;95;140 03:29:47 INFO - PROCESS | 1658 | |8;json-parse-financial;55;56;52;53;77;84;84;85;56;57 03:29:47 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;73;70;82;75;72;71;71;71;71 03:29:47 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;85;84;83;82;86;82;85;83;83;89 03:29:47 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;141;137;149;147;135;138;149;139;176;132 03:29:47 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;167;167;165;165;166;166;225;167;166;169 03:29:47 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;68;67;67;68;66;67;67;67;66 03:29:47 INFO - PROCESS | 1658 | __end_tp_report 03:29:47 INFO - PROCESS | 1658 | __start_cc_report 03:29:47 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2132 03:29:47 INFO - PROCESS | 1658 | __end_cc_report 03:29:47 INFO - PROCESS | 1658 | __startTimestamp1479122987856__endTimestamp 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | ------- Summary: start ------- 03:29:47 INFO - PROCESS | 1658 | Number of tests: 14 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:122.50 Median:115.00 stddev:18.05 (15.7%) stddev-sans-first:18.94 03:29:47 INFO - PROCESS | 1658 | Values: 115.0 121.0 168.0 140.0 115.0 111.0 113.0 114.0 115.0 113.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:112.00 stddev:15.74 (14.1%) stddev-sans-first:13.63 03:29:47 INFO - PROCESS | 1658 | Values: 145.0 108.0 109.0 142.0 109.0 111.0 109.0 107.0 138.0 113.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:0.99 (0.5%) stddev-sans-first:1.00 03:29:47 INFO - PROCESS | 1658 | Values: 182.0 184.0 183.0 183.0 183.0 183.0 181.0 182.0 184.0 184.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:65.80 Median:59.50 stddev:12.04 (20.2%) stddev-sans-first:11.62 03:29:47 INFO - PROCESS | 1658 | Values: 80.0 60.0 59.0 87.0 59.0 58.0 59.0 58.0 82.0 56.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:88.00 stddev:16.34 (18.6%) stddev-sans-first:17.33 03:29:47 INFO - PROCESS | 1658 | Values: 87.0 70.0 95.0 68.0 81.0 94.0 123.0 94.0 71.0 89.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:89.00 stddev:9.35 (10.5%) stddev-sans-first:3.87 03:29:47 INFO - PROCESS | 1658 | Values: 116.0 98.0 89.0 87.0 89.0 85.0 90.0 86.0 89.0 86.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:29:47 INFO - PROCESS | 1658 | Values: 94.0 94.0 94.0 94.0 96.0 94.0 94.0 94.0 93.0 93.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:112.20 Median:83.50 stddev:25.36 (30.4%) stddev-sans-first:26.30 03:29:47 INFO - PROCESS | 1658 | Values: 97.0 142.0 83.0 86.0 123.0 139.0 133.0 84.0 95.0 140.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:67.00 stddev:14.52 (21.7%) stddev-sans-first:14.85 03:29:47 INFO - PROCESS | 1658 | Values: 55.0 56.0 52.0 53.0 77.0 84.0 84.0 85.0 56.0 57.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:71.50 stddev:4.31 (6.0%) stddev-sans-first:3.72 03:29:47 INFO - PROCESS | 1658 | Values: 65.0 73.0 70.0 82.0 75.0 72.0 71.0 71.0 71.0 71.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:2.15 (2.5%) stddev-sans-first:2.26 03:29:47 INFO - PROCESS | 1658 | Values: 85.0 84.0 83.0 82.0 86.0 82.0 85.0 83.0 83.0 89.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:144.00 stddev:12.59 (8.7%) stddev-sans-first:13.29 03:29:47 INFO - PROCESS | 1658 | Values: 141.0 137.0 149.0 147.0 135.0 138.0 149.0 139.0 176.0 132.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:167.00 stddev:18.55 (11.1%) stddev-sans-first:19.58 03:29:47 INFO - PROCESS | 1658 | Values: 167.0 167.0 165.0 165.0 166.0 166.0 225.0 167.0 166.0 169.0 03:29:47 INFO - PROCESS | 1658 | 03:29:47 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:29:47 INFO - PROCESS | 1658 | Values: 67.0 68.0 67.0 67.0 68.0 66.0 67.0 67.0 67.0 66.0 03:29:47 INFO - PROCESS | 1658 | -------- Summary: end -------- 03:29:47 INFO - PROCESS | 1658 | 03:29:48 INFO - TEST-INFO | 1658: exit 0 03:29:48 INFO - TEST-OK | kraken | took 59633ms 03:29:48 INFO - SUITE-END | took 1177s 03:29:49 INFO - Completed test suite (00:19:37) 03:29:49 INFO - javascript benchmark 03:29:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2771.2517620242534, 3356.0770788033287, 3384.4923261510785, 3384.984504648605, 3418.982905085474, 5797.797077102302, 5818.0400233961345, 5860.150278209662, 5881.117832325142, 5934.020886553719, 5780.0, 5844.357120716729, 5853.765849366031, 5854.677992710399, 5859.6777177255235, 5184.300119483869, 5324.973375133139, 5326.121190003645, 5334.0, 5371.865703357408, 5250.606204534656, 5257.211418287268, 5275.235090911816, 5285.86785330366, 5397.7031263280505, 5320.680759154463, 5370.865728356803, 5395.973020134914, 5403.648762830423, 5418.972905135489, 5372.57019438444, 5373.489518495737, 5381.461853814587, 5389.946100538984, 5397.27136836526, 5204.115300398941, 5224.190250511177, 5250.921236181461, 5321.840344789663, 5390.0836857734275, 5683.545316374722, 5729.88540229193, 5776.422357764232, 5794.855128621776, 5797.623154494944, 6239.313675495692, 6249.2813326467585, 6272.341404152589, 6319.74721011159, 6329.145565348711, 6311.368863113652, 6312.084747711556, 6318.2733985591785, 6328.272248691414, 6334.986402175676, 5670.376258611549, 5808.099744539603, 5812.0, 5812.070068788974, 5846.152307915413, 6306.527010474233, 6311.684415779193, 6325.683715814191, 6344.904826427515, 6354.4281014708895, 6200.100985357098, 6224.470919971763, 6228.875422491525, 6245.281792593819, 6247.156633854372, 6154.169187159766, 6199.938000620026, 6237.438630523275, 6334.9683251584365, 6358.91898377277, 6232.252129744369, 6312.779052733133, 6319.494440444753, 6325.462335701517, 6331.176946996861, 6191.133241346215, 6334.9366506334345, 6348.587341822767, 6351.745930162741, 6354.17395738551, 4851.369321988119, 4916.950830491721, 4974.1543937530705, 4979.3526841510375, 4990.850274491771, 4427.5572442755465, 4477.462704475419, 4482.955170448319, 4486.3494793254795, 4557.248054071041, 5924.674142922095, 5952.255968003999, 5953.880922381528, 5958.791442299499, 5967.910481342783, 6261.7182226799905, 6297.748090076438, 6303.991361382157, 6313.05304204373, 6320.0, 5677.517411020027, 5694.1458781183155, 5745.109508026263, 5834.708264586839, 5917.852053698692, 5480.177973303957, 5480.588955828329, 5493.725313734377, 5498.642588231832, 5517.531009864127, 6370.968145159244, 6382.648954307465, 6388.2972872984865, 6389.233292004897, 6395.680215989275, 6140.416660417253, 6293.496520278275, 6293.937060629335, 6296.559240853279, 6306.085617585516, 5371.4897084776885, 6236.968815156077, 6276.623402595859, 6377.74489020434, 6381.3937675920715, 6273.65494897785, 6273.749050037947, 6279.874402512016, 6292.874142517033, 6300.117983482408, 6197.411245931629, 6256.280527739368, 6257.2804127525915, 6299.685015749103, 6321.273053598711, 6101.877962440815, 6134.4172303631085, 6173.290071641819, 6243.625382476885, 6251.187345645037, 6187.319394866471, 6205.131281620667, 6212.9068063978175, 6235.906461402992, 6242.28213755424, 5919.556033297434, 6016.398360163948, 6054.90917636227, 6055.485283750931, 6070.271567411939, 6114.38856114385, 6134.222293197161, 6153.815385538441, 6213.347598502092, 6279.748810047729, 6040.679688550763, 6094.9085763714465, 6120.233815636221, 6128.689509994036, 6131.816045518463], "value": 5779.199570741417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.2341119092665, 499.8575406009287, 529.1480716047166, 533.0644718518998, 570.9942900570995, 26759.922608899982, 30239.99999999997, 32076.839615801946, 32132.67867321326, 32369.51445728313, 32965.0, 33466.330673386576, 41400.37899431503, 42376.788116059455, 42509.57490425095, 9707.75730606737, 9856.211503079772, 9862.704118876409, 9872.950635246849, 9889.604415823358, 9738.51307434629, 9855.162311203556, 9855.901440985606, 9859.014098590156, 9862.11240988311, 8704.260137888286, 8894.555272236395, 9812.754681132994, 11851.881481185206, 12055.27668339898, 12141.635750927486, 12180.634580962585, 12183.695407614881, 12201.145919785618, 12217.328046957413, 11844.88155118455, 11940.761184776256, 11947.940260298643, 11956.163068585203, 11967.581134660246, 31285.687143128504, 31809.36381272385, 39777.20445591101, 39876.800615997025, 39933.40099898504, 3317.319949410365, 3356.261622443083, 3599.8020108894, 3625.673689367943, 3963.2667956427863, 29493.262668433246, 30331.0, 30527.08418747419, 31529.52705709416, 31841.84079079613, 3279.5527792145795, 3301.7688761786685, 3341.6491268416953, 3359.7144242739396, 3386.102682789063, 519176.0, 520266.0, 521445.0, 521532.0, 526650.3667481677, 48920.0, 49865.75067124641, 50152.49847501551, 52827.73586132121, 52905.94188116216, 60034.69982650146, 61454.0, 61639.0, 64570.0, 65341.67329163324, 16051.277692503865, 16253.674926501404, 16260.105694186934, 16272.105034222994, 16272.674546509004, 12599.5590154346, 12708.364581770875, 12709.682257943625, 12719.554815581596, 12720.918721908742, 13882.514112006233, 14026.50907218263, 14578.542145785548, 15593.844061559466, 15740.291686874118, 4971.676841005323, 6947.930520694728, 7090.539114957512, 7099.361057504746, 7173.856522869513, 900.909909009107, 936.5130132331286, 978.9412635241908, 1018.4856647393167, 1047.61238341814, 27515.0, 29571.408571828444, 29573.55639665407, 30087.94692185763, 30477.542836857465, 1066.7173199102244, 1071.6838532632892, 1098.763765790359, 1127.8590176227972, 1142.457332766929, 15005.849941500444, 15527.534173974798, 15566.533004009898, 15582.0, 15603.947831518228, 681611.0, 684489.0, 685390.0, 685566.0, 686712.0, 57065.85868282611, 57294.71352643293, 57309.71345143331, 57349.426505735246, 57577.71211143918, 1211.4790640024873, 1268.1186575330241, 1351.236551348485, 1376.876081152701, 1398.8601139886134, 29028.0, 30311.84844075854, 30489.54265685972, 30795.69204307928, 31447.685523144475, 48095.27857082077, 48532.0, 48625.756871216836, 48644.513554863996, 48651.27023094727, 475471.0, 476585.0, 477148.0, 477393.0, 479184.0, 25618.23145305644, 26254.212373628823, 26427.735722642527, 27133.72866271391, 27179.184624461297, 46084.53915460803, 46438.071238575714, 46645.76677116593, 46728.29907551457, 46932.296015560474, 37997.53101168818, 38083.61916380912, 38671.80664096661, 38689.6131038686, 39593.80203098966, 38302.42546361751, 38645.420318694676, 39036.60963390443, 39217.6078239214, 39909.2018159641, 36791.81604091962, 36903.89288321355, 38062.85811425662, 38063.80968095142, 39441.802790985865, 32896.0, 34153.146171345914, 34791.65208347985, 34838.9548313551, 35083.0, 21948.231811887144, 25477.3630659235, 25503.107391241218, 25657.174561758842, 25710.61434078453], "value": 19745.82063822835, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.8866118511484, 373.23673088533945, 376.34515942260464, 383.0767849482746, 399.9780012099335, 14981.250937453138, 15125.546233612982, 16374.672506549878, 20234.89882550589, 20817.27139550116, 18587.721184182246, 18810.15354309056, 19744.506387340323, 20460.59078818423, 20743.896280518577, 5462.989346970803, 5950.613210141338, 6131.233595800525, 6182.567220294582, 6223.875522489548, 3504.702100321476, 4470.173017991666, 4478.932816007762, 6062.42406971337, 6116.235470566179, 6539.4114529692315, 6860.108185935846, 6860.931390686104, 6938.063361446216, 6949.061876646639, 6602.801915942506, 6784.7964561063, 6857.177138743333, 6868.587884726882, 6884.0362349270645, 5708.229389032469, 5920.733566989496, 5953.464188223037, 5954.732037058299, 5955.851103722398, 25404.87297563519, 25463.363415914566, 25698.614520782205, 25712.0, 25985.480290394276, 2294.1626306398043, 2353.411647088228, 2354.1407386304045, 2487.129504673368, 3010.443068032421, 15371.385144594204, 15453.840961927901, 15648.92175539115, 16008.679826403406, 16158.515244542683, 1810.7464954906325, 1856.2667746240295, 1867.8419379984362, 1867.8785878917963, 1915.4349466907295, 119356.80643193543, 121468.39265803703, 125645.0, 125837.0, 125972.0, 9312.534373281309, 9729.416235025921, 9963.252756043326, 10022.198224142052, 10139.64511242103, 12437.00503959681, 12514.874851251552, 12531.874681253254, 12535.122541422013, 12562.560310389092, 6741.8651626967185, 7835.960820195863, 8044.3564514839845, 8112.918870811216, 8130.186981301823, 8392.244697977212, 8395.790105247295, 8410.495370277802, 8525.658973640984, 8529.57352132391, 3837.6929845612285, 3852.325842977468, 3867.497225360685, 3913.9804300978312, 3926.941095883507, 1768.4075834595296, 1806.5059686212574, 1818.3181307009872, 1922.9520560602914, 1989.60207958406, 866.3545658484469, 888.0, 934.1965909317981, 961.1493827962304, 975.3708857786829, 16252.674946501003, 21159.153633854472, 21177.894110529658, 21295.254666086923, 21458.0, 830.3274347778198, 879.9780005499786, 931.8648795924688, 947.6825263536792, 949.8765160529225, 10617.416042117604, 10686.0, 11143.108551315876, 11199.272047316897, 11210.607628732956, 476723.0, 574181.0, 574476.0, 575185.0, 616086.0, 131083.34458327838, 131794.0, 133713.0, 137252.0, 141749.0, 959.822432849925, 966.1063516247443, 980.1472718734747, 1003.2776400991274, 1004.347174336687, 15455.84544154544, 18445.53886152857, 19169.233230670616, 19597.31409400664, 19764.703529447357, 42604.78697606492, 46855.0, 55294.44705552893, 57513.13730293965, 58057.4194258052, 81218.0, 81724.0, 82714.0, 85094.0, 85410.71883921622, 7943.0, 7953.18962774435, 7954.323882469824, 8414.537200454033, 8494.91505084966, 11398.316101033965, 12694.111412201057, 12758.87241127614, 12801.167924084904, 13039.022073344728, 10925.890741092806, 11088.112950964065, 11156.107511398906, 11398.601048963246, 11497.770044598894, 10974.890251097388, 10978.670639880816, 11090.611828585961, 11231.775364492501, 11253.268537545033, 11359.829602555803, 11378.715532111764, 11389.772204556028, 11410.54357825711, 11681.941590291994, 7019.227884932551, 7239.058922340273, 7427.517211381243, 7556.546607203585, 8119.4722343047515, 9593.712188634352, 11040.889591104307, 11465.0, 11531.365774882126, 11565.132615053737], "value": 9552.40280249184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.2687402550673, 1516.4540765324484, 1682.9747553786694, 1868.6262747450514, 1878.5491482044313, 8492.447990880597, 9036.457812531253, 9046.140616641425, 9048.230900373468, 9059.411138276017, 7906.80232994174, 8165.51006939584, 8187.91812081879, 8652.826943461127, 8850.291976641869, 2369.395804069964, 2394.6647469354302, 2397.6883005209297, 2398.244552965819, 2399.8800059997016, 2030.46192758919, 2358.740538540759, 2369.2536850892, 2406.7713567211085, 2412.9879350603223, 2103.032605001701, 2189.3979155732222, 2329.5690297295055, 2401.1955994741697, 2408.7470815564375, 1993.9700904486444, 2382.3924899150693, 2412.1436889904094, 2412.4692567635093, 2417.0, 2000.4198782353246, 2394.114177754242, 2398.9640155397683, 2402.8678422686744, 2406.2300063979533, 8927.642894284221, 8999.19007289347, 9005.684801031932, 9016.278697704169, 9048.77378065547, 5248.0, 5374.516293533601, 5451.754671039813, 5462.590305727047, 5465.754041068121, 3474.5483087198504, 3533.840977156034, 3607.098225443639, 3658.158623516606, 3669.559652841676, 1069.0825836817517, 1103.1450625765017, 1106.0543235533664, 1129.8531190945207, 1130.1693255457233, 11897.048236141089, 12024.579139730067, 12027.0, 12047.277163370138, 12053.457594408274, 4066.9796651017145, 4588.3805686231935, 4649.628029757611, 4868.975655121772, 4870.293807397908, 10072.647457338959, 10078.445685487222, 10100.494975251208, 10100.898991009995, 10101.646442374482, 5353.250544923714, 5354.0, 5358.839234822962, 5364.678119312854, 5366.114591092426, 4749.976250118796, 4867.780949857265, 4874.683145595525, 4894.583960363409, 4895.632827537877, 3936.4685767421606, 3960.5247370315747, 3975.463312452782, 4020.537638171589, 4057.655099316591, 1173.8943495085311, 1268.5750273658427, 1272.0, 1275.7384736129072, 1291.6835375333103, 791.9941674073893, 802.6829402386142, 832.633641197871, 882.9911700883038, 974.4494360686332, 5833.6413309492855, 5909.911351329733, 6002.459778619857, 6166.753329866845, 6221.657808820468, 807.1878632470142, 924.3160061554536, 945.9621615135455, 966.0146650416535, 996.4071377530358, 3967.8016099194924, 3989.3617021276455, 4001.379786133154, 4005.0988527581644, 4020.798960051986, 10727.624533141303, 10930.070943969851, 11053.060489858452, 11084.445777711082, 11084.778304433867, 10911.290766100177, 10962.56149754001, 10992.890071099346, 11012.724681883017, 11017.83473247902, 7894.6842126314305, 8266.297364724065, 8288.63237565795, 8335.749927502186, 8357.95821020891, 5171.612129090258, 5990.741944191768, 6064.786352981042, 6076.513878889767, 6091.725872335667, 9594.904050959402, 9936.701898943043, 10151.543180556744, 10237.23220758461, 10326.070653640907, 9909.504524773589, 10245.0, 10339.75922889258, 10457.26799124054, 10471.895281047397, 7299.160596531467, 7556.093268807778, 7573.848523029619, 7679.961600192187, 7776.0, 8438.493690378597, 8544.145585441654, 8551.187637174458, 8555.486670799772, 8568.957155214184, 7469.663865126191, 7562.432817538596, 7587.848243035219, 7604.163542010485, 7726.42051846125, 7318.3047610476915, 7426.962865185639, 7453.627318634155, 7498.887516687145, 7654.196309387657, 6963.651817409008, 6999.1950925644205, 7009.439244860297, 7125.714971401293, 7143.392811611071, 4969.527894849984, 4993.750312484289, 5030.0945829749535, 5078.97460512695, 5161.458046905021, 4986.476419975996, 5011.724355160355, 5107.9489205107475, 5119.590432765444, 5164.354455693038], "value": 4630.692090574957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [238.67778499026312, 299.66437589899317, 305.6591900031464, 306.97851150419467, 312.45944515987327, 4770.761461926907, 5422.539084177844, 5501.394846566875, 5504.944950550494, 5521.122818241797, 5120.206368012964, 5295.205719142131, 5307.65500242484, 5326.416687906372, 5338.759755810988, 3659.597444281127, 3909.2572411241918, 3948.7038472114564, 4133.656561617471, 4212.683024336618, 3475.6003059648083, 4164.875053748392, 4187.602177793105, 4209.327077305918, 4245.617894389505, 3987.4018897165365, 4146.523149837762, 4159.980804702852, 4182.309918863384, 4197.916041679165, 4108.897277568085, 4135.855245066408, 4144.8134833932545, 4145.730527515701, 4170.374443833419, 3605.855765769366, 3611.6636844367754, 3613.728970327236, 3624.4744512045604, 3653.799041052741, 4072.6131017553284, 4521.525239849801, 4736.123817093849, 5336.039512887679, 5388.275751759438, 4663.930041049387, 4672.4393072831135, 4691.554302341272, 4697.741624210667, 4750.738709370983, 4826.986332870101, 5097.617678674114, 5271.65734227274, 5485.149801780731, 5798.391168927286, 3726.552813662378, 3881.3983832506005, 3882.8446862125766, 3890.5489541588618, 3892.0853599404118, 5649.954758369715, 5892.793752218652, 5986.2517185351835, 5993.730282137314, 6002.069679199731, 3931.6658084063174, 3944.8422063117728, 3956.9208615827524, 3957.168994511185, 3978.1754953982995, 3416.6241713411505, 3681.950644066482, 3972.3445631470486, 4027.496562929634, 4044.757314561077, 4270.935935960963, 4430.003249268889, 4791.401074865642, 4810.7113573185725, 4858.562729354305, 4744.5492678195515, 5114.462981386975, 5210.088234558937, 5852.4147585241135, 5858.882822343529, 1294.9834380011646, 1330.2683524061727, 1393.9233342166278, 1413.6640874373618, 1418.0995068131604, 845.5625436757537, 939.5161491831713, 970.1995853420815, 971.0241207586472, 971.1502435369052, 4364.432623758891, 5363.249145119687, 5363.436839131913, 5389.407165211824, 5623.915641265385, 4604.677672562889, 5277.920831187535, 5530.0, 5853.239078919713, 5870.559708021916, 4662.673612847068, 4994.600431965434, 5381.013537486654, 5394.406615272317, 5400.297961265011, 2705.3642394037383, 3081.7534597232166, 3102.6897310269246, 3113.6025260549704, 3140.5132204508336, 4873.343063358475, 5115.7442127893455, 5302.946970530323, 5994.520438364921, 6092.070614453741, 4862.635302352338, 5509.531689806411, 5540.113581826889, 5968.552358573038, 5986.970065149733, 5651.321841379061, 6032.39676032402, 6055.424734650202, 6069.544784141119, 6070.544709146743, 5183.896322073613, 5498.477644623755, 5828.504577110993, 5831.620944638585, 5831.708414579339, 4912.484189160086, 4928.940277840282, 5261.500157485033, 5791.13133030032, 5872.207252020922, 5699.686517241592, 5853.853653658693, 5997.301214453426, 6000.669963152069, 6073.813427166305, 3327.850246738854, 3497.860085596548, 3866.2460820139804, 3894.5131858517684, 3908.081600823861, 4876.463589005136, 6000.849978750566, 6032.487238584769, 6045.546584006129, 6051.1830902829315, 5018.5232402921665, 5612.635178713371, 5752.440164126923, 5834.795782147605, 5841.970790146022, 5169.68173115853, 5641.774329026793, 5729.742161602655, 5747.023006088892, 5775.393583673654, 5346.8395948121615, 5533.944660553343, 5622.409646987007, 5624.409437009055, 5636.605437619327, 5753.475329037892, 5754.539636829128, 5760.596758227051, 5781.653100813965, 5793.768249270151, 4988.850334489971, 5388.165509978011, 5534.806281780118, 5599.776008959759, 5631.0], "value": 4154.7298892586605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.4018044932482, 755.305119290253, 774.7598244544191, 790.201896084954, 829.9045609754878, 14489.855101448982, 14699.0, 15974.520764377074, 16011.359545618176, 16907.1546422679, 16526.66946661066, 16917.0, 16959.0, 16977.98132112074, 17036.0, 675.6689222281096, 773.8276511085695, 814.7922279818638, 873.1792115411524, 874.4097734029536, 697.5082566790426, 706.2972342519175, 751.3538357012992, 823.4894365493373, 847.7880529867533, 843.7974886027371, 872.6989188729877, 882.2104216726026, 883.9734807955772, 889.6041261638574, 883.2360008592585, 883.5935469683953, 884.385352180235, 885.0087901550305, 885.0485727842563, 523.3118449239238, 540.2787278982563, 541.4044550993915, 546.1425561867869, 660.7753363856264, 12617.936910315482, 15184.46854360092, 15273.541793746093, 15332.0, 15968.121753303563, 14043.368048437742, 14354.64113397163, 14391.280435978158, 14394.280285985764, 14481.0, 11510.539578416854, 11859.169858109935, 11861.406929653569, 11878.821817672742, 11969.640910772603, 3784.9810750946344, 3844.1350696093436, 3879.709021823346, 3945.28984782739, 3949.921001579981, 90709.37162513491, 110647.44676276647, 113739.0, 115642.0, 116824.41587792007, 8831.161039701217, 10699.518521666543, 10710.143188544898, 10975.451227438596, 11163.330200188015, 21866.89066554657, 21881.67177492339, 21897.343079707633, 21932.780672193392, 21947.890260548596, 7549.698012079565, 8000.51996880189, 8024.956755621732, 8072.192780721881, 8078.798030049295, 4405.691601587858, 4411.205982923105, 4476.104779044204, 4597.839075632337, 4638.884027899262, 3566.5363502744476, 3662.6520480554304, 3724.7206459515646, 3733.1600389912596, 3734.4958430612064, 634.1629049654504, 640.3436477610486, 644.3427703742157, 654.326044174501, 659.5745743995096, 578.9247397838254, 678.6301465701205, 679.3172861274387, 679.9053523826734, 682.5017737051979, 7927.167647397056, 9092.681756138636, 9504.857427138599, 9566.838425284885, 9932.900670993342, 543.5407081016534, 638.0142679560091, 653.9803805885831, 669.5882032549947, 692.3768608252512, 4358.21552120615, 4774.259989701602, 4807.759612019455, 4807.831725889577, 4881.560659540658, 88066.63366980126, 90256.09743902608, 94571.52714236385, 125990.0, 148524.51475485106, 104683.2201976897, 105291.47354263334, 107209.0, 113725.0, 115598.0, 93783.53108234415, 96828.84707003296, 98438.01561984289, 100005.49997249967, 103470.0, 9009.23421509179, 9029.503377314048, 9043.68347107848, 9160.6793762218, 9439.244860411014, 58089.0, 58632.82734345204, 59167.0, 59847.0, 61638.0, 81078.0, 82807.75788363299, 87223.0, 87301.0, 91140.0, 12935.805962910375, 13034.152780069266, 13083.084184107402, 13263.535776247785, 13373.264470454218, 14364.353604087632, 14766.409343626136, 14844.925775371054, 14852.183129927958, 14916.0, 13389.397477113358, 13487.527936522174, 13526.797098043735, 13785.862141378859, 14403.135811850903, 13382.732345353234, 13412.597622071353, 13632.591022269347, 14084.01411901157, 14587.927060364631, 13303.66740831487, 13707.725845483234, 13987.0, 14209.857901421266, 14216.289185540889, 8883.822323553364, 11256.718582035515, 11551.653450396165, 11677.708057298636, 11840.644780656594, 11444.625756645572, 11445.942770286096, 11668.824967625322, 11716.648500544998, 11728.589499367481], "value": 7684.023538395885, "unit": "score"}], "name": "dromaeo_css", "value": 7376.99545027638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 121.0, 168.0, 140.0, 115.0, 111.0, 113.0, 114.0, 115.0, 113.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 109.0, 142.0, 109.0, 111.0, 109.0, 107.0, 138.0, 113.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 183.0, 183.0, 183.0, 181.0, 182.0, 184.0, 184.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 87.0, 59.0, 58.0, 59.0, 58.0, 82.0, 56.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 95.0, 68.0, 81.0, 94.0, 123.0, 94.0, 71.0, 89.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 98.0, 89.0, 87.0, 89.0, 85.0, 90.0, 86.0, 89.0, 86.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 142.0, 83.0, 86.0, 123.0, 139.0, 133.0, 84.0, 95.0, 140.0], "value": 112.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 52.0, 53.0, 77.0, 84.0, 84.0, 85.0, 56.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 70.0, 82.0, 75.0, 72.0, 71.0, 71.0, 71.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 82.0, 86.0, 82.0, 85.0, 83.0, 83.0, 89.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 149.0, 147.0, 135.0, 138.0, 149.0, 139.0, 176.0, 132.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 165.0, 165.0, 166.0, 166.0, 225.0, 167.0, 166.0, 169.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1481.0, "alertThreshold": 2.0}]} 03:29:49 INFO - Return code: 0 03:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:29:49 INFO - # TBPL SUCCESS # 03:29:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:49 INFO - 2016-11-14 03:29:49.174 screenresolution[1662:9975] starting screenresolution argv=screenresolution get 03:29:49 INFO - 2016-11-14 03:29:49.176 screenresolution[1662:9975] Display 0: 1600x1200x32@60 03:29:49 INFO - 2016-11-14 03:29:49.182 screenresolution[1663:9978] starting screenresolution argv=screenresolution list 03:29:49 INFO - Available Modes on Display 0 03:29:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:49 INFO - Intel Iris: 03:29:49 INFO - Chipset Model: Intel Iris 03:29:49 INFO - Type: GPU 03:29:49 INFO - Bus: Built-In 03:29:49 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:49 INFO - Vendor: Intel (0x8086) 03:29:49 INFO - Device ID: 0x0a2e 03:29:49 INFO - Revision ID: 0x0009 03:29:49 INFO - Displays: 03:29:49 INFO - Display: 03:29:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:49 INFO - Display Serial Number: 1600x1200 60 03:29:49 INFO - Main Display: Yes 03:29:49 INFO - Mirror: Off 03:29:49 INFO - Online: Yes 03:29:49 INFO - Rotation: Supported 03:29:49 INFO - Return code: 0 03:29:49 INFO - Running post-action listener: _resource_record_post_action 03:29:49 INFO - [mozharness: 2016-11-14 11:29:49.417286Z] Finished run-tests step (success) 03:29:49 INFO - Running post-run listener: _resource_record_post_run 03:29:49 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38761472; Write bytes: 664996864; Read time: 383; Write time: 1869 03:29:49 INFO - TinderboxPrint: CPU usage
53.5% 03:29:49 INFO - TinderboxPrint: I/O read bytes / time
38,761,472 / 383 03:29:49 INFO - TinderboxPrint: I/O write bytes / time
664,996,864 / 1,869 03:29:49 INFO - TinderboxPrint: CPU idle
2,250.9 (46.5%) 03:29:49 INFO - TinderboxPrint: CPU system
970.2 (20.0%) 03:29:49 INFO - TinderboxPrint: CPU user
1,620.6 (33.5%) 03:29:49 INFO - TinderboxPrint: Swap in / out
402,202,624 / 0 03:29:49 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 360501760; Write bytes: 355919872; Read time: 27735; Write time: 666 03:29:49 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32562176; Write bytes: 297012736; Read time: 299; Write time: 1163 03:29:49 INFO - Running post-run listener: _upload_blobber_files 03:29:49 INFO - Blob upload gear active. 03:29:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:29:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:29:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:52 INFO - (blobuploader) - INFO - Done attempting. 03:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:52 INFO - (blobuploader) - INFO - Done attempting. 03:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:55 INFO - (blobuploader) - INFO - Done attempting. 03:29:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:29:55 INFO - Return code: 0 03:29:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:29:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:29:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c098a08a7b459be3a943d6ab74ff89fcce61be14315aeea70b1acc060fa8348e75907972acb4ca5d7be8518eb30b48ebd64c195d11c23863f3c9e1464467001b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b0ab2daffa114a95eb1924b6b5277283810dc9eba59cf2a021fd25785bdcbb574b9bbd028a6d9c74c480537a9e6acdfafb233209b3622e9159020c00205a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c949d2f39749a86ec29b01a3f7fac6810c03c2fee3db1b5021623bc5b5335f64bc9650ee65547bd177d81e8819a2a9d55ddf573e32a0b0ca5d87695e9f25b77f"} 03:29:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:29:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:29:55 INFO - Contents: 03:29:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c098a08a7b459be3a943d6ab74ff89fcce61be14315aeea70b1acc060fa8348e75907972acb4ca5d7be8518eb30b48ebd64c195d11c23863f3c9e1464467001b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b0ab2daffa114a95eb1924b6b5277283810dc9eba59cf2a021fd25785bdcbb574b9bbd028a6d9c74c480537a9e6acdfafb233209b3622e9159020c00205a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c949d2f39749a86ec29b01a3f7fac6810c03c2fee3db1b5021623bc5b5335f64bc9650ee65547bd177d81e8819a2a9d55ddf573e32a0b0ca5d87695e9f25b77f"} 03:29:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:29:55 INFO - Copying logs to upload dir... 03:29:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:29:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.202591 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-14 03:29:55.390342) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 03:29:55.394663) ========= 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.Idzg5GRHkd/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.zWa0VumA9p/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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/c098a08a7b459be3a943d6ab74ff89fcce61be14315aeea70b1acc060fa8348e75907972acb4ca5d7be8518eb30b48ebd64c195d11c23863f3c9e1464467001b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b0ab2daffa114a95eb1924b6b5277283810dc9eba59cf2a021fd25785bdcbb574b9bbd028a6d9c74c480537a9e6acdfafb233209b3622e9159020c00205a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c949d2f39749a86ec29b01a3f7fac6810c03c2fee3db1b5021623bc5b5335f64bc9650ee65547bd177d81e8819a2a9d55ddf573e32a0b0ca5d87695e9f25b77f"} build_url:https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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/c098a08a7b459be3a943d6ab74ff89fcce61be14315aeea70b1acc060fa8348e75907972acb4ca5d7be8518eb30b48ebd64c195d11c23863f3c9e1464467001b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b0ab2daffa114a95eb1924b6b5277283810dc9eba59cf2a021fd25785bdcbb574b9bbd028a6d9c74c480537a9e6acdfafb233209b3622e9159020c00205a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c949d2f39749a86ec29b01a3f7fac6810c03c2fee3db1b5021623bc5b5335f64bc9650ee65547bd177d81e8819a2a9d55ddf573e32a0b0ca5d87695e9f25b77f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 03:29:55.435223) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:29:55.435691) ========= 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.Idzg5GRHkd/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.zWa0VumA9p/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005421 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:29:55.488102) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 03:29:55.491514) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 03:29:55.491941) ========= ========= Total master_lag: 0.62 =========