builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1490864858.18 results: success (0) buildid: 20170330004004 builduid: 0a5c29dce87a438eb08ba5997e7fdc42 revision: 437ac8a1ad2cdb94ba9b5573da06049855ea4a38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.176308) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.176772) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.177048) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.204179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.204530) ========= 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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-30 02:07:38-- 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% 200M=0s 2017-03-30 02:07:38 (200 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.300685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.529632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.529948) ========= 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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.034311 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:38.586757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2017-03-30 02:07:38.587108) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 437ac8a1ad2cdb94ba9b5573da06049855ea4a38 --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 437ac8a1ad2cdb94ba9b5573da06049855ea4a38 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0zxHJoVbl4/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.gFkaZYmiTs/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-30 02:07:38,696 truncating revision to first 12 chars 2017-03-30 02:07:38,696 Setting DEBUG logging. 2017-03-30 02:07:38,696 attempt 1/10 2017-03-30 02:07:38,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/437ac8a1ad2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 02:07:42,889 unpacking tar archive at: mozilla-aurora-437ac8a1ad2c/testing/mozharness/ program finished with exit code 0 elapsedTime=9.204526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2017-03-30 02:07:47.814497) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:47.814842) ========= script_repo_revision: 437ac8a1ad2cdb94ba9b5573da06049855ea4a38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:47.815273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:47.815635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 02:07:47.835758) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 11 secs) (at 2017-03-30 02:07:47.836192) ========= /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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:07:48 INFO - MultiFileLogger online at 20170330 02:07:48 in /builds/slave/test 02:07:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:07:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:48 INFO - {'append_to_log': False, 02:07:48 INFO - 'base_work_dir': '/builds/slave/test', 02:07:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:07:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:48 INFO - 'branch': 'Mozilla-Aurora', 02:07:48 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:48 INFO - 'config_files': ('talos/mac_config.py',), 02:07:48 INFO - 'default_actions': ('clobber', 02:07:48 INFO - 'read-buildbot-config', 02:07:48 INFO - 'download-and-extract', 02:07:48 INFO - 'populate-webroot', 02:07:48 INFO - 'create-virtualenv', 02:07:48 INFO - 'install', 02:07:48 INFO - 'run-tests'), 02:07:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:48 INFO - 'download_minidump_stackwalk': True, 02:07:48 INFO - 'download_symbols': 'ondemand', 02:07:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:48 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:48 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:48 INFO - 'gecko_profile': False, 02:07:48 INFO - 'gecko_profile_interval': 0, 02:07:48 INFO - 'installer_path': 'installer.exe', 02:07:48 INFO - 'log_level': 'info', 02:07:48 INFO - 'log_name': 'talos', 02:07:48 INFO - 'log_to_console': True, 02:07:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:07:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:07:48 INFO - 'opt_config_files': (), 02:07:48 INFO - 'pip_index': False, 02:07:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:48 INFO - 'cmd': ('bash', 02:07:48 INFO - '-c', 02:07:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:48 INFO - 'enabled': True, 02:07:48 INFO - 'halt_on_failure': False, 02:07:48 INFO - 'name': 'check_screen_resolution'},), 02:07:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:48 INFO - 'cmd': ('bash', 02:07:48 INFO - '-c', 02:07:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:48 INFO - 'enabled': True, 02:07:48 INFO - 'halt_on_failure': False, 02:07:48 INFO - 'name': 'check_screen_resolution'},), 02:07:48 INFO - 'run_cmd_checks_enabled': True, 02:07:48 INFO - 'suite': 'dromaeojs', 02:07:48 INFO - 'system_bits': '32', 02:07:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:48 INFO - 'title': 't-yosemite-r7-0060', 02:07:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:48 INFO - 'use_talos_json': True, 02:07:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:48 INFO - 'work_dir': 'build'} 02:07:48 INFO - [mozharness: 2017-03-30 09:07:48.054084Z] Running clobber step. 02:07:48 INFO - Running pre-action listener: _resource_record_pre_action 02:07:48 INFO - Running main action method: clobber 02:07:48 INFO - rmtree: /builds/slave/test/build 02:07:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:50 INFO - Running post-action listener: _resource_record_post_action 02:07:50 INFO - [mozharness: 2017-03-30 09:07:50.497504Z] Finished clobber step (success) 02:07:50 INFO - [mozharness: 2017-03-30 09:07:50.497646Z] Running read-buildbot-config step. 02:07:50 INFO - Running pre-action listener: _resource_record_pre_action 02:07:50 INFO - Running main action method: read_buildbot_config 02:07:50 INFO - Using buildbot properties: 02:07:50 INFO - { 02:07:50 INFO - "project": "", 02:07:50 INFO - "product": "firefox", 02:07:50 INFO - "script_repo_revision": "production", 02:07:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:07:50 INFO - "repository": "", 02:07:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:07:50 INFO - "buildid": "20170330004004", 02:07:50 INFO - "stage_platform": "macosx64", 02:07:50 INFO - "basedir": "/builds/slave/test", 02:07:50 INFO - "nightly_build": "True", 02:07:50 INFO - "buildnumber": 71, 02:07:50 INFO - "slavename": "t-yosemite-r7-0060", 02:07:50 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:07:50 INFO - "platform": "yosemite_r7", 02:07:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:07:50 INFO - "branch": "mozilla-aurora", 02:07:50 INFO - "repo_path": "releases/mozilla-aurora", 02:07:50 INFO - "revision": "437ac8a1ad2cdb94ba9b5573da06049855ea4a38", 02:07:50 INFO - "pgo_build": "False", 02:07:50 INFO - "builduid": "0a5c29dce87a438eb08ba5997e7fdc42", 02:07:50 INFO - "slavebuilddir": "test" 02:07:50 INFO - } 02:07:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:07:50 INFO - Running post-action listener: _resource_record_post_action 02:07:50 INFO - [mozharness: 2017-03-30 09:07:50.501166Z] Finished read-buildbot-config step (success) 02:07:50 INFO - [mozharness: 2017-03-30 09:07:50.501289Z] Running download-and-extract step. 02:07:50 INFO - Running pre-action listener: _resource_record_pre_action 02:07:50 INFO - Running main action method: download_and_extract 02:07:50 INFO - mkdir: /builds/slave/test/build/tests 02:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:50 INFO - trying https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:07:50 INFO - Downloading https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:07:52 INFO - Downloaded 1199 bytes. 02:07:52 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:07:52 INFO - Using the following test package requirements: 02:07:52 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:07:52 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:07:52 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:07:52 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'jsshell-mac.zip'], 02:07:52 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:07:52 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:07:52 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:07:52 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:07:52 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:07:52 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:07:52 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:07:52 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:07:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:07:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:07:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:07:54 INFO - Expected file size: 51791038 02:07:54 INFO - Obtained file size: 51791038 02:08:10 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:08:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:08:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:08:10 INFO - Fetch https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:08:12 INFO - Expected file size: 51791038 02:08:12 INFO - Obtained file size: 51791038 02:08:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:08:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:08:27 INFO - Fetch https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:08:28 INFO - Expected file size: 14404438 02:08:28 INFO - Obtained file size: 14404438 02:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:29 INFO - trying https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:08:29 INFO - Downloading https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:09:00 INFO - retry: attempt #1 caught exception: '' 02:09:00 INFO - retry: Failed, sleeping 30 seconds before retrying 02:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #2 02:09:34 INFO - Downloaded 74750363 bytes. 02:09:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:09:34 INFO - mkdir: /builds/slave/test/properties 02:09:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:09:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:09:34 INFO - Contents: 02:09:34 INFO - build_url:https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:09:35 INFO - Running post-action listener: _resource_record_post_action 02:09:35 INFO - Running post-action listener: set_extra_try_arguments 02:09:35 INFO - [mozharness: 2017-03-30 09:09:35.405672Z] Finished download-and-extract step (success) 02:09:35 INFO - [mozharness: 2017-03-30 09:09:35.405813Z] Running populate-webroot step. 02:09:35 INFO - Running pre-action listener: _resource_record_pre_action 02:09:35 INFO - Running main action method: populate_webroot 02:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:09:35 INFO - '--tppagecycles', 02:09:35 INFO - '7'], 02:09:35 INFO - 'tests': ['tsvgm']}}, 02:09:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:09:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:09:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:09:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:09:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:09:35 INFO - 'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:09:35 INFO - 'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['damp', 'tps']}, 02:09:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:09:35 INFO - 'tests': ['damp', 'tps']}, 02:09:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['dromaeo_dom']}, 02:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:09:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['basic_compositor_video']}, 02:09:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:09:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['a11yr', 02:09:35 INFO - 'ts_paint', 02:09:35 INFO - 'tpaint', 02:09:35 INFO - 'sessionrestore', 02:09:35 INFO - 'sessionrestore_no_auto_restore', 02:09:35 INFO - 'tabpaint']}, 02:09:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:09:35 INFO - 'ts_paint', 02:09:35 INFO - 'tpaint', 02:09:35 INFO - 'sessionrestore', 02:09:35 INFO - 'sessionrestore_no_auto_restore', 02:09:35 INFO - 'tabpaint']}, 02:09:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:09:35 INFO - 'ts_paint', 02:09:35 INFO - 'tpaint', 02:09:35 INFO - 'sessionrestore', 02:09:35 INFO - 'sessionrestore_no_auto_restore', 02:09:35 INFO - 'tabpaint']}, 02:09:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:09:35 INFO - 'ts_paint', 02:09:35 INFO - 'tpaint', 02:09:35 INFO - 'sessionrestore', 02:09:35 INFO - 'sessionrestore_no_auto_restore', 02:09:35 INFO - 'tabpaint']}, 02:09:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['a11yr', 02:09:35 INFO - 'ts_paint', 02:09:35 INFO - 'tpaint', 02:09:35 INFO - 'sessionrestore', 02:09:35 INFO - 'sessionrestore_no_auto_restore', 02:09:35 INFO - 'tabpaint']}, 02:09:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['a11yr', 02:09:35 INFO - 'ts_paint', 02:09:35 INFO - 'tpaint', 02:09:35 INFO - 'sessionrestore', 02:09:35 INFO - 'sessionrestore_no_auto_restore', 02:09:35 INFO - 'tabpaint']}, 02:09:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['tsvgx', 02:09:35 INFO - 'tsvgr_opacity', 02:09:35 INFO - 'tart', 02:09:35 INFO - 'tscrollx', 02:09:35 INFO - 'cart', 02:09:35 INFO - 'tsvg_static']}, 02:09:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:09:35 INFO - 'tsvgr_opacity', 02:09:35 INFO - 'tart', 02:09:35 INFO - 'tscrollx', 02:09:35 INFO - 'cart', 02:09:35 INFO - 'tsvg_static']}, 02:09:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:09:35 INFO - 'talos_options': ['--disable-e10s'], 02:09:35 INFO - 'tests': ['tp5o']}, 02:09:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:09:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:09:35 INFO - 'talos_options': ['--disable-e10s', 02:09:35 INFO - '--xperf_path', 02:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:35 INFO - 'tests': ['tp5n']}, 02:09:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:09:35 INFO - 'talos_options': ['--xperf_path', 02:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:35 INFO - 'tests': ['tp5n']}}, 02:09:35 INFO - 'talos.zip': {'path': '', 02:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:09:35 INFO - Running post-action listener: _resource_record_post_action 02:09:35 INFO - [mozharness: 2017-03-30 09:09:35.424141Z] Finished populate-webroot step (success) 02:09:35 INFO - [mozharness: 2017-03-30 09:09:35.424254Z] Running create-virtualenv step. 02:09:35 INFO - Running pre-action listener: _resource_record_pre_action 02:09:35 INFO - Running main action method: create_virtualenv 02:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:09:35 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 02:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:09:35 INFO - Using real prefix '/tools/python27' 02:09:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:09:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:09:39 INFO - Installing pip.................done. 02:09:39 INFO - Return code: 0 02:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:09:39 INFO - Reading from file tmpfile_stdout 02:09:39 INFO - Output received: 02:09:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:09:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:09:39 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')]} 02:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:39 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')]} 02:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:41 INFO - 'HOME': '/Users/cltbld', 02:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:41 INFO - 'LOGNAME': 'cltbld', 02:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:41 INFO - 'MOZ_NO_REMOTE': '1', 02:09:41 INFO - 'NO_EM_RESTART': '1', 02:09:41 INFO - 'PAGER': '/bin/cat', 02:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:41 INFO - 'PWD': '/builds/slave/test', 02:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:41 INFO - 'SHELL': '/bin/bash', 02:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:09:41 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:41 INFO - 'USER': 'cltbld', 02:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:41 INFO - 'XPC_FLAGS': '0x0', 02:09:41 INFO - 'XPC_SERVICE_NAME': '0', 02:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:41 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 02:09:41 INFO - Cleaning up... 02:09:41 INFO - Return code: 0 02:09:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:41 INFO - 'HOME': '/Users/cltbld', 02:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:41 INFO - 'LOGNAME': 'cltbld', 02:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:41 INFO - 'MOZ_NO_REMOTE': '1', 02:09:41 INFO - 'NO_EM_RESTART': '1', 02:09:41 INFO - 'PAGER': '/bin/cat', 02:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:41 INFO - 'PWD': '/builds/slave/test', 02:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:41 INFO - 'SHELL': '/bin/bash', 02:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:09:41 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:41 INFO - 'USER': 'cltbld', 02:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:41 INFO - 'XPC_FLAGS': '0x0', 02:09:41 INFO - 'XPC_SERVICE_NAME': '0', 02:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:42 INFO - Downloading/unpacking psutil>=3.1.1 02:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:55 INFO - Installing collected packages: psutil 02:09:55 INFO - Running setup.py install for psutil 02:09:56 INFO - building 'psutil._psutil_osx' extension 02:09:56 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 02:09:56 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 02:09:56 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 02:09:56 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 02:09:56 INFO - building 'psutil._psutil_posix' extension 02:09:56 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 02:09:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:09:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:09:56 INFO - ^ 02:09:57 INFO - 1 warning generated. 02:09:57 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 02:09:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:57 INFO - Successfully installed psutil 02:09:57 INFO - Cleaning up... 02:09:57 INFO - Return code: 0 02:09:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:57 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:09:57 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 02:09:57 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 02:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:57 INFO - 'HOME': '/Users/cltbld', 02:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:57 INFO - 'LOGNAME': 'cltbld', 02:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:57 INFO - 'MOZ_NO_REMOTE': '1', 02:09:57 INFO - 'NO_EM_RESTART': '1', 02:09:57 INFO - 'PAGER': '/bin/cat', 02:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:57 INFO - 'PWD': '/builds/slave/test', 02:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:57 INFO - 'SHELL': '/bin/bash', 02:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:09:57 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:57 INFO - 'USER': 'cltbld', 02:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:57 INFO - 'XPC_FLAGS': '0x0', 02:09:57 INFO - 'XPC_SERVICE_NAME': '0', 02:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:09:57 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 02:09:57 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 02:09:57 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 02:09:57 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 02:09:57 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 02:09:57 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 02:10:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:01 INFO - Installing collected packages: mozsystemmonitor 02:10:01 INFO - Running setup.py install for mozsystemmonitor 02:10:01 INFO - Successfully installed mozsystemmonitor 02:10:01 INFO - Cleaning up... 02:10:01 INFO - Return code: 0 02:10:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:01 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:10:01 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 02:10:01 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 02:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:01 INFO - 'HOME': '/Users/cltbld', 02:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:01 INFO - 'LOGNAME': 'cltbld', 02:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:01 INFO - 'MOZ_NO_REMOTE': '1', 02:10:01 INFO - 'NO_EM_RESTART': '1', 02:10:01 INFO - 'PAGER': '/bin/cat', 02:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:01 INFO - 'PWD': '/builds/slave/test', 02:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:01 INFO - 'SHELL': '/bin/bash', 02:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:10:01 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:01 INFO - 'USER': 'cltbld', 02:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:01 INFO - 'XPC_FLAGS': '0x0', 02:10:01 INFO - 'XPC_SERVICE_NAME': '0', 02:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:01 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:10 INFO - warning: no files found matching '*.txt' 02:10:10 INFO - no previously-included directories found matching 'build' 02:10:10 INFO - no previously-included directories found matching 'dist' 02:10:10 INFO - no previously-included directories found matching '.git*' 02:10:10 INFO - Installing collected packages: jsonschema, functools32 02:10:10 INFO - Running setup.py install for functools32 02:10:10 INFO - warning: no files found matching '*.txt' 02:10:10 INFO - no previously-included directories found matching 'build' 02:10:10 INFO - no previously-included directories found matching 'dist' 02:10:10 INFO - no previously-included directories found matching '.git*' 02:10:11 INFO - Successfully installed jsonschema functools32 02:10:11 INFO - Cleaning up... 02:10:11 INFO - Return code: 0 02:10:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02: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')]} 02:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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')]} 02:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:11 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:10:11 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 02:10:11 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 02:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:11 INFO - 'HOME': '/Users/cltbld', 02:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:11 INFO - 'LOGNAME': 'cltbld', 02:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:11 INFO - 'MOZ_NO_REMOTE': '1', 02:10:11 INFO - 'NO_EM_RESTART': '1', 02:10:11 INFO - 'PAGER': '/bin/cat', 02:10:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:11 INFO - 'PWD': '/builds/slave/test', 02:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:11 INFO - 'SHELL': '/bin/bash', 02:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:10:11 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:11 INFO - 'USER': 'cltbld', 02:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:11 INFO - 'XPC_FLAGS': '0x0', 02:10:11 INFO - 'XPC_SERVICE_NAME': '0', 02:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:10:11 INFO - Cleaning up... 02:10:11 INFO - Return code: 0 02:10:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02: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')]} 02:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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')]} 02:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:11 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:10:11 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 02:10:11 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 02:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:11 INFO - 'HOME': '/Users/cltbld', 02:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:11 INFO - 'LOGNAME': 'cltbld', 02:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:11 INFO - 'MOZ_NO_REMOTE': '1', 02:10:11 INFO - 'NO_EM_RESTART': '1', 02:10:11 INFO - 'PAGER': '/bin/cat', 02:10:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:11 INFO - 'PWD': '/builds/slave/test', 02:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:11 INFO - 'SHELL': '/bin/bash', 02:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:10:11 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:11 INFO - 'USER': 'cltbld', 02:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:11 INFO - 'XPC_FLAGS': '0x0', 02:10:11 INFO - 'XPC_SERVICE_NAME': '0', 02:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:11 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 02:10:11 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 02:10:11 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 02:10:11 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 02:10:11 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 02:10:11 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 02:10:22 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:23 INFO - Downloading docopt-0.6.1.tar.gz 02:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:23 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:23 INFO - Running setup.py install for blobuploader 02:10:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:23 INFO - Running setup.py install for requests 02:10:24 INFO - Running setup.py install for docopt 02:10:24 INFO - Successfully installed blobuploader requests docopt 02:10:24 INFO - Cleaning up... 02:10:24 INFO - Return code: 0 02:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:24 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:10:24 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 02:10:24 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 02:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:24 INFO - 'HOME': '/Users/cltbld', 02:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:24 INFO - 'LOGNAME': 'cltbld', 02:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:24 INFO - 'MOZ_NO_REMOTE': '1', 02:10:24 INFO - 'NO_EM_RESTART': '1', 02:10:24 INFO - 'PAGER': '/bin/cat', 02:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:24 INFO - 'PWD': '/builds/slave/test', 02:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:24 INFO - 'SHELL': '/bin/bash', 02:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:10:24 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:24 INFO - 'USER': 'cltbld', 02:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:24 INFO - 'XPC_FLAGS': '0x0', 02:10:24 INFO - 'XPC_SERVICE_NAME': '0', 02:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:24 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-2Pzfr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:24 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-799AZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:24 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-A92hwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:24 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Z15MjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Ea6qbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-IC9P5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-sjMjpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-dYgZac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-z8Uxoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ZGV4So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-h6lB78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-cDxN0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-CxNYfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:25 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-r8YuFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:26 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-13aYnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:26 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-UfuUxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:26 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-4P4dqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:26 INFO - Running setup.py install for manifestparser 02:10:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:26 INFO - Running setup.py install for mozcrash 02:10:26 INFO - Running setup.py install for mozdebug 02:10:26 INFO - Running setup.py install for mozdevice 02:10:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozfile 02:10:27 INFO - Running setup.py install for mozhttpd 02:10:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozinfo 02:10:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozInstall 02:10:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozleak 02:10:27 INFO - Running setup.py install for mozlog 02:10:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for moznetwork 02:10:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Running setup.py install for mozprocess 02:10:28 INFO - Running setup.py install for mozprofile 02:10:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Running setup.py install for mozrunner 02:10:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Running setup.py install for mozscreenshot 02:10:28 INFO - Running setup.py install for moztest 02:10:28 INFO - Running setup.py install for mozversion 02:10:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:28 INFO - Cleaning up... 02:10:29 INFO - Return code: 0 02:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:29 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:10:29 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 02:10:29 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 02:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:29 INFO - 'HOME': '/Users/cltbld', 02:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:29 INFO - 'LOGNAME': 'cltbld', 02:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:29 INFO - 'MOZ_NO_REMOTE': '1', 02:10:29 INFO - 'NO_EM_RESTART': '1', 02:10:29 INFO - 'PAGER': '/bin/cat', 02:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:29 INFO - 'PWD': '/builds/slave/test', 02:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:29 INFO - 'SHELL': '/bin/bash', 02:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:10:29 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:29 INFO - 'USER': 'cltbld', 02:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:29 INFO - 'XPC_FLAGS': '0x0', 02:10:29 INFO - 'XPC_SERVICE_NAME': '0', 02:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:29 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-2sYrp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:29 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-YVY_Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:29 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ec5fDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:29 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ETq030-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:29 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-r04r75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:29 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-vfDcZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:29 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-j_hBtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-g4nGFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-yxUFR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-j3rIxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-7To_YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-4sLeua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-KgLh5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-wHIKYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-bWpIKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-kvGs5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:30 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-6LM_Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:31 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)) 02:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:31 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)) 02:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:41 INFO - Downloading blessings-1.6.tar.gz 02:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:41 INFO - Installing collected packages: blessings 02:10:41 INFO - Running setup.py install for blessings 02:10:41 INFO - Successfully installed blessings 02:10:41 INFO - Cleaning up... 02:10:41 INFO - Return code: 0 02:10:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:42 INFO - Reading from file tmpfile_stdout 02:10:42 INFO - Current package versions: 02:10:42 INFO - blessings == 1.6 02:10:42 INFO - blobuploader == 1.2.4 02:10:42 INFO - docopt == 0.6.1 02:10:42 INFO - functools32 == 3.2.3-2 02:10:42 INFO - jsonschema == 2.5.1 02:10:42 INFO - manifestparser == 1.1 02:10:42 INFO - mozInstall == 1.12 02:10:42 INFO - mozcrash == 1.0 02:10:42 INFO - mozdebug == 0.1 02:10:42 INFO - mozdevice == 0.49 02:10:42 INFO - mozfile == 1.2 02:10:42 INFO - mozhttpd == 0.7 02:10:42 INFO - mozinfo == 0.9 02:10:42 INFO - mozleak == 0.1 02:10:42 INFO - mozlog == 3.4 02:10:42 INFO - moznetwork == 0.27 02:10:42 INFO - mozprocess == 0.25 02:10:42 INFO - mozprofile == 0.28 02:10:42 INFO - mozrunner == 6.13 02:10:42 INFO - mozscreenshot == 0.1 02:10:42 INFO - mozsystemmonitor == 0.3 02:10:42 INFO - moztest == 0.8 02:10:42 INFO - mozversion == 1.4 02:10:42 INFO - psutil == 3.1.1 02:10:42 INFO - requests == 1.2.3 02:10:42 INFO - wsgiref == 0.1.2 02:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:42 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')]} 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:45 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:10:45 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 02:10:45 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 02:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:45 INFO - 'HOME': '/Users/cltbld', 02:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:45 INFO - 'LOGNAME': 'cltbld', 02:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:45 INFO - 'MOZ_NO_REMOTE': '1', 02:10:45 INFO - 'NO_EM_RESTART': '1', 02:10:45 INFO - 'PAGER': '/bin/cat', 02:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:45 INFO - 'PWD': '/builds/slave/test', 02:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:45 INFO - 'SHELL': '/bin/bash', 02:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:10:45 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:45 INFO - 'USER': 'cltbld', 02:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:45 INFO - 'XPC_FLAGS': '0x0', 02:10:45 INFO - 'XPC_SERVICE_NAME': '0', 02:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 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)) 02:10:46 INFO - Cleaning up... 02:10:46 INFO - Return code: 0 02:10:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:47 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 0x10f424b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f427768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f824cf670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, '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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:10:47 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 02:10:47 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 02:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:47 INFO - 'HOME': '/Users/cltbld', 02:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:47 INFO - 'LOGNAME': 'cltbld', 02:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:47 INFO - 'MOZ_NO_REMOTE': '1', 02:10:47 INFO - 'NO_EM_RESTART': '1', 02:10:47 INFO - 'PAGER': '/bin/cat', 02:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:47 INFO - 'PWD': '/builds/slave/test', 02:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:47 INFO - 'SHELL': '/bin/bash', 02:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:10:47 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:47 INFO - 'USER': 'cltbld', 02:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:47 INFO - 'XPC_FLAGS': '0x0', 02:10:47 INFO - 'XPC_SERVICE_NAME': '0', 02:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:10:47 INFO - Cleaning up... 02:10:47 INFO - Return code: 0 02:10:47 INFO - Running post-action listener: _resource_record_post_action 02:10:47 INFO - Running post-action listener: _start_resource_monitoring 02:10:47 INFO - Starting resource monitoring. 02:10:47 INFO - [mozharness: 2017-03-30 09:10:47.389907Z] Finished create-virtualenv step (success) 02:10:47 INFO - [mozharness: 2017-03-30 09:10:47.390853Z] Running install step. 02:10:47 INFO - Running pre-action listener: _resource_record_pre_action 02:10:47 INFO - Running main action method: install 02:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:47 INFO - Reading from file tmpfile_stdout 02:10:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:47 INFO - Reading from file tmpfile_stdout 02:10:47 INFO - Output received: 02:10:47 INFO - Usage: mozinstall [options] installer 02:10:47 INFO - Options: 02:10:47 INFO - -h, --help show this help message and exit 02:10:47 INFO - -d DEST, --destination=DEST 02:10:47 INFO - Directory to install application into. [default: 02:10:47 INFO - "/builds/slave/test"] 02:10:47 INFO - --app=APP Application being installed. [default: firefox] 02:10:47 INFO - mkdir: /builds/slave/test/build/application 02:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:11:08 INFO - Reading from file tmpfile_stdout 02:11:08 INFO - Output received: 02:11:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:11:08 INFO - Running post-action listener: _resource_record_post_action 02:11:08 INFO - [mozharness: 2017-03-30 09:11:08.361642Z] Finished install step (success) 02:11:08 INFO - [mozharness: 2017-03-30 09:11:08.361784Z] Running run-tests step. 02:11:08 INFO - Running pre-action listener: _resource_record_pre_action 02:11:08 INFO - Running main action method: run_tests 02:11:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:11:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:11:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:11:08 INFO - 2017-03-30 02:11:08.376 screenresolution[1630:7924] starting screenresolution argv=screenresolution get 02:11:08 INFO - 2017-03-30 02:11:08.379 screenresolution[1630:7924] Display 0: 1600x1200x32@60 02:11:08 INFO - 2017-03-30 02:11:08.385 screenresolution[1631:7926] starting screenresolution argv=screenresolution list 02:11:08 INFO - Available Modes on Display 0 02:11:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:11:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:11:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:11:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:11:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:11:08 INFO - Intel Iris: 02:11:08 INFO - Chipset Model: Intel Iris 02:11:08 INFO - Type: GPU 02:11:08 INFO - Bus: Built-In 02:11:08 INFO - VRAM (Dynamic, Max): 1536 MB 02:11:08 INFO - Vendor: Intel (0x8086) 02:11:08 INFO - Device ID: 0x0a2e 02:11:08 INFO - Revision ID: 0x0009 02:11:08 INFO - Displays: 02:11:08 INFO - Display: 02:11:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:11:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:11:08 INFO - Display Serial Number: 1600x1200 60 02:11:08 INFO - Main Display: Yes 02:11:08 INFO - Mirror: Off 02:11:08 INFO - Online: Yes 02:11:08 INFO - Rotation: Supported 02:11:08 INFO - Return code: 0 02:11:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:11:08 INFO - Python 2.7.3 02:11:08 INFO - Return code: 0 02:11:08 INFO - grabbing minidump binary from tooltool 02:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:08 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 0x10f202d30>, '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 0x10f129db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:11:08 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 02:11:08 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 02:11:08 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 02:11:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:11:08 INFO - Return code: 0 02:11:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:11:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:11:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:11:08 INFO - ENV: RUST_BACKTRACE is now 1 02:11:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:11:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:11:08 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/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 02:11:08 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/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --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 02:11:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0zxHJoVbl4/Render', 02:11:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:08 INFO - 'HOME': '/Users/cltbld', 02:11:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:08 INFO - 'LOGNAME': 'cltbld', 02:11:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:08 INFO - 'MOZ_NO_REMOTE': '1', 02:11:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:08 INFO - 'NO_EM_RESTART': '1', 02:11:08 INFO - 'PAGER': '/bin/cat', 02:11:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:08 INFO - 'PWD': '/builds/slave/test', 02:11:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:08 INFO - 'RUST_BACKTRACE': '1', 02:11:08 INFO - 'SHELL': '/bin/bash', 02:11:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFkaZYmiTs/Listeners', 02:11:08 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:11:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:08 INFO - 'USER': 'cltbld', 02:11:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:08 INFO - 'XPC_FLAGS': '0x0', 02:11:08 INFO - 'XPC_SERVICE_NAME': '0', 02:11:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:08 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/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 02:11:08 INFO - mozversion application_buildid: 20170330004004 02:11:08 INFO - mozversion application_changeset: 437ac8a1ad2cdb94ba9b5573da06049855ea4a38 02:11:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:11:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:11:08 INFO - mozversion application_name: Firefox 02:11:08 INFO - mozversion application_remotingname: firefox-dev 02:11:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:11:08 INFO - mozversion application_vendor: Mozilla 02:11:08 INFO - mozversion application_version: 54.0a2 02:11:08 INFO - mozversion platform_buildid: 20170330004004 02:11:08 INFO - mozversion platform_changeset: 437ac8a1ad2cdb94ba9b5573da06049855ea4a38 02:11:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:11:08 INFO - mozversion platform_version: 54.0a2 02:11:08 INFO - using testdate: 1490865068 02:11:08 INFO - actual date: 1490865068 02:11:08 INFO - starting webserver on 'localhost:49250' 02:11:08 INFO - SUITE-START | Running 2 tests 02:11:08 INFO - TEST-START | dromaeo_css 02:11:08 INFO - operating with platform_type : mac_ 02:11:08 INFO - Initialising browser for dromaeo_css test... 02:11:09 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpxhgPb2/profile http://localhost:49250/getInfo.html) 02:11:11 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 02:11:11 INFO - PROCESS | 1641 | colorDepth:24 02:11:11 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 02:11:11 INFO - PROCESS | 1641 | __metrics 02:11:12 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:11:12 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:11:12 INFO - TEST-INFO | 1641: exit 0 02:11:12 INFO - Browser initialized. 02:11:12 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:12 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpxhgPb2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:25 INFO - PROCESS | 1646 | RSS: Main: 214581248 02:11:25 INFO - PROCESS | 1646 | 02:14:29 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 02:14:31 INFO - PROCESS | 1646 | RSS: Main: 405549056 02:14:31 INFO - PROCESS | 1646 | 02:16:14 INFO - PROCESS | 1646 | ************************* 02:16:14 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 02:16:14 INFO - PROCESS | 1646 | 02:16:14 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:16:14 INFO - PROCESS | 1646 | Full stack: 02:16:14 INFO - PROCESS | 1646 | ************************* 02:17:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 02:17:35 INFO - PROCESS | 1646 | RSS: Main: 345731072 02:17:35 INFO - PROCESS | 1646 | 02:20:37 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 02:20:38 INFO - PROCESS | 1646 | RSS: Main: 337711104 02:20:38 INFO - PROCESS | 1646 | 02:23:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 02:23:41 INFO - PROCESS | 1646 | RSS: Main: 321552384 02:23:41 INFO - PROCESS | 1646 | 02:26:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 02:26:45 INFO - PROCESS | 1646 | RSS: Main: 326410240 02:26:45 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 02:29:49 INFO - PROCESS | 1646 | RSS: Main: 464748544 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | __start_tp_report 02:29:49 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 02:29:49 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 02:29:49 INFO - PROCESS | 1646 | |i|pagename|runs| 02:29:49 INFO - PROCESS | 1646 | |0;dojo.html;3385.9888061556208;3391.9660803391967;3395.609504906935;3397.6602339766027;3453.464712969489;5906.970465147673;5924.822255332336;5942.405759424067;5946.4945479634225;5948.167256584076;5913.467787899099;5982.312034116078;5982.491488223495;5996.670183139926;6005.909911351333;5307.814226502073;5331.200319952019;5334.253204551366;5381.4349493303225;5415;5257.027449921758;5261.657992230493;5451.754671039813;5453.563714902798;5492.176173573956;5277.102892508283;5321.228421878825;5329.760160792774;5337.1994200869985;5343.919841202385;5348.598855085884;5350.384705758829;5357.4374690657305;5358.169483730008;5366.543843773284;4957.487966170316;5200.427952925175;5287.418383977798;5304.124819404794;5333.759980800874;5174.637775355726;5937.792177273818;5950.375210602911;5964.642121472682;5970.13433052205;6236.906446403307;6280.905786413207;6289.339619339949;6302.873942521124;6311.526635502356;6327.17746692927;6338.271098823649;6339.841503962438;6343.746250149989;6345.016522439029;5013.949860501385;6066.393360663942;6073.149759033695;6074.8785024299705;6120.387961203888;6194.628322300587;6236.158118653923;6419.935800642027;6442.355764423567;6481.578697384655;6241.78153764616;6258.280297765724;6295.087212354183;6303.117563541108;6310.968445157837;6309.116723658692;6312.715927783261;6313.621182729051;6319.115323854664;6322.083297921776;5219.347581552306;6288.025356069817;6298.590591611531;6303.810885673437;6309.589876658002;6203.131561581382;6240.937590624127;6293.1504246927;6331.05034244867;6350.587211831308;4386.429764130643;5082.669626474268;5161.483851614808;5162.406323272797;5165.535101840853;4512.706674066175;4523.705959112647;4541.9545804542195;4554.908901821945;4559.133764584718;6023.247094113236;6079.179310793074;6081.239845019372;6096.359882212392;6108.5723999319625;6245.219347581552;6269.404406581368;6287.2769631492965;6296.811095667137;6313.905291420632;5987;6018.307894592178;6104.4505994460715;6110.541709371815;6131.14164017038;4753.239481682914;5581.972090139523;5642.633228840113;5651.717414129359;5675.063614503643;6588.472922166311;6596.439302659328;6597.3072827352435;6603;6609.966950165219;6223.564350495421;6266.68666566679;6271.4669253114;6326.873462530815;6335.683215839097;6520.902186467112;6555.868882622225;6563.868722625425;6570.8028759137305;6583.144191255106;6292.874142517216;6298.0867774171575;6323.747050117944;6326.145970294136;6329.145565348619;6232.25212974446;6236.158118653923;6301.747930082745;6303;6319.715612797343;5885.323187833454;6240.157578726996;6253.96873015632;6287.654179020198;6288.088227207121;6287.46556542699;6300.495960323072;6316.336784637547;6322.810315690536;6325.652089135142;6219.657918814509;6227.159333490102;6265.49876009909;6269.153664255267;6275.278342990432;6124.938750612437;6140.19751335002;6239.188905442445;6257.217847769029;6291.528135389773;6238.095476155841;6239.4696450800375;6253.78111766086;6254.562180647311;6255.78104766331 02:29:49 INFO - PROCESS | 1646 | |1;ext.html;694.1531331775234;776.8446310737854;798.8402319536094;863.25328590769;873.6854732296376;38381.424278635845;39166.60833391665;41175.176496470056;41382.96542586437;41391.37912931301;40087;40338.19323613526;40474.39288410669;40534.58128965487;40546.59453405465;7291;8913.910860891388;9050.275977921783;9061.864072038925;9063.773405664879;7368.263173682616;9064.728058158265;11078.002979731822;11146.498407571638;11175.329480231172;10908.454577271144;10918.399488028155;10938.890611093866;10972.780544389107;11006.174536909724;7236.204017558064;10935.890641093567;10950.39772812499;10979.670609881716;10983.560657573687;7313;10556.947215263952;10810.243282970196;10885.673429797118;10943.23397362185;38291.234175316335;38538.61461385378;38555.807220963994;38583.61416385856;38608.61391386078;3725.329440700673;3840.2127563849344;3845.807709614536;3865.43951127085;3894.2600905827803;27026.729732702617;27761.889524419;28100.718992810016;28720.281992950135;28748.712512874812;2970.212893583202;3008.443437963984;3014.6985301469895;3215.26049008727;3220.0500852248642;340846;340951;341194.9999999975;341251;341449;50271.49728502741;50426;50527.49472505302;50589.74705126451;50651;54071.18893216605;54101;54109;54200;54236.728816355666;12344.75310493785;14762.335694893756;14878.851211487747;14895.553133406016;14896.180710060835;12824.909882660078;12828.422720977578;12829.93585032069;12838.358082096045;12851.614451566467;10582.57669693219;11955;11959.342236176919;12086.39568021613;12102.273863568214;5163.922541161885;5209.088409528317;5227.111391063529;5228.712420816892;5229.424763276036;1057.5399701130034;1136.812425949709;1138.322697994692;1153.3195414705365;1159.1538177130574;23634.527309453715;24597.38506537351;26382.340441488734;26822.463550729266;26883.865580671973;597.0070048821909;1043.5773511727762;1066.6373433032807;1084.9945750271197;1116.5757012335262;13069.346532673328;13203.867961320457;13370.46518139283;13375.063745537718;13414;462100;465445;465453.6727316409;466233;468080;56372.71813640906;56398.59003524945;56414.71792641011;56433;56879;1412.0750908155176;1450.6010847016944;1457.205822826541;1457.2203870929002;1458.8322342930487;22609.660855087517;23711.1701090461;24322.75677243205;24944.378615389942;25242.368940775894;44737.55262447334;44936.101277973605;44992;45014.77492612516;45130.54869451263;356979;422654;422953;424906;425961;31402.900898468444;31519.684803151675;31645.525317119802;31646.36707265888;31653.892113775906;41916.58083419127;42034.369484458366;42262;42529.57470425256;42814.929626758334;25989.480210396065;29159.833606655495;29360.559591605717;29953.101406957827;30105;28067.298317542223;30094.946676866206;30300.393992120476;30390;30473.695263047084;27913.162605121877;29223.41553168882;34079;35829;35939.64060359468;29592.816287348265;29647.407051859274;30536.84731576328;31901.6809831908;31904.042878713677;24764;24780.38049048788;24877.626835597843;25301.367465813502;25312.873435632704 02:29:49 INFO - PROCESS | 1646 | |2;jquery.html;388.58421489006776;406.59137566745414;424.6326927207964;427.9721818081824;446.47093194564445;10158.54286557105;15011.699766004687;21182.04680789366;21744.8912755436;21887.233946811866;21842.563148737056;22010.779892201073;22562.661560076613;22909.312720618407;23191;6575.178102737158;6612.933870661304;6761.729530818761;6849.554778939378;6872.072270243503;4192.119654872466;4486.035502366991;5876.882462350751;6615.900761488581;6779.864402711943;4457.955420445803;7805.4145939054515;7832.255935686101;7846.568438735867;7847.843043139133;7545.69817207311;7664;7731.45879788415;7758.418118641124;7792.220777922191;7277.3086556777025;7481.364084052862;7519.849603007964;7552.8867066994035;7556.924430755677;24704;25730.22809315705;26419.73580264192;27312;27587.206831555886;2890.609767681357;2934.89727859526;2936.5741967414606;2994.2813724705916;3053.7862349635534;15193.468228611946;15567.455139070078;15912.124833134172;16044.839551604451;16495.670086598322;2015.8689685170564;2031.1672214392029;2049.0867012981835;2053.147943603403;2113.7252157219464;151080;153291;153811.23094384567;156484;156823;17836.732449013274;18159.909200453912;20335.694964575545;20581.58836823255;20602.381928542167;32354.676453235636;32625.51061734076;32670.67329326724;32688.509672354932;32691.836540817145;8078.676852925817;8727.81434776302;10063.798724025624;10344.172466202686;10454.843177352346;8405.831883362298;8557;8571.871421928676;8746.562671866508;8786.912130878738;8863.626137948628;9174.20186843006;9287.309908496301;9319.440833550008;9323.766905827273;3744.3260213161348;3829.3681542545723;3831.4635950966886;3834.1948190880225;3842.193139440749;701.2951983256794;800.4116974024088;872.1017352127319;886.6453418632599;905.6060613633091;20443.795562044488;21104.155833766785;21129.943502824797;21168.78831211699;21212.363629091153;909.8908131024319;917.7705573606598;922.524899676667;924.9722508324761;928.9024652411534;8835.895513060867;10051.296409251428;10728.409937453358;10987.835182472269;11012.779744405067;362216.188919059;487707;683619.5819020873;697707;698445;143062.284688578;152318.47681523266;154332;155687;157185.42516598644;1158.9594364197212;1205.2467207995003;1254.6110705681085;1255.617036803802;1255.8241846141548;19377.903110484356;19394.2242310306;19821.702674459608;19839.30562430308;19863.404097877086;58440.707796460745;58806.11790823226;60290.79418411695;60369.69815151072;60633;81003;82774;83401.58299208707;84016;93650.53174734356;11380.43097845121;11426.885731142582;11651.592194273499;11787.764244715228;11991.340476273888;12841.35793210317;12873.935630321788;13036.283004434468;13236.470541178245;13272.668183295495;11181.944090279496;11233.96814989225;11458.82811757841;11630.069594432594;11677.591284305008;10669.946650266698;10671.519781609692;10761.408122553335;10959.890401095887;10970.451477425937;11290.040346570633;11653.708657283636;11754.529818807152;11803.350815705218;11821.822672659744;11544.826827597424;11571.363575003455;11752.94123529411;11822.586209482626;11932.880671193177;9102.499362535124;11146.275492092987;11450.427478625868;11501.252418592765;11508.712282193012 02:29:49 INFO - PROCESS | 1646 | |3;mootools.html;1510.3807438950018;1515.5907904865687;1538.2385719069061;1559.3606621285269;1565.5146904459618;9730.513474326292;10207.489625518712;10208.540615672304;10224.693259202217;10227.48862556871;10639.840402393951;11014.944925275362;11232.4945377458;11247.718807029829;11252.212345135824;2031.8984050797476;2428.514297140579;2428.9271321860374;2431.124795073772;2431.3556907419547;2353.211674089182;2419.6733440985417;2435.025989604155;2443.841150325223;2444.4622183119686;2349.0955981946904;2398.256540472459;2404.362843846382;2432.4526981429126;2434.7078350597953;2309.6881920940627;2344.4373350395954;2384.29663249341;2388.916387926423;2393.628987506939;2314.305708287507;2332.486852892361;2338.4153961509624;2343.4492894169857;2344.871032093234;10643.57425702971;11141.832872506919;11150.386728729916;11173.273737207055;11179.720506987309;5775.335836378828;5911.349751527328;5934;5955.34491205967;5965.55258355625;3513.437849944022;3621.040424287566;3659.2315613721153;3686.7419280650365;3708.388115960863;1186.0985650905288;1193.8448001759716;1223.4616768621777;1228.8525376954822;1249.4065318973505;13520.594382168452;13844.723105537832;14134.646633834134;15302.311395987208;15537.456189033443;4003.599640035973;4238.385434112037;4319.438472998553;4322.567743225715;4372.737635741865;11720.765584688259;11804.17370784037;11812.881871181178;11817.645470635895;11830.467628956718;4624.606908412756;5883.852903677357;5884.47039766423;5884.617499862581;5884.852878678067;5138.434772175057;5231.764570594332;5255.921161182585;5306.7611957462;5333.759980800874;3753.774773513543;3798.9050273742823;3847.153626202231;3869;3891.7081218908697;1004.4124187350482;1018.9490525473697;1023.3194925374692;1031.28841099641;1031.6028329093353;803.843250566134;837.4263629413749;909.3861643390685;918.3296193778579;937.8827646544182;5810.593258471867;6394.912864812993;6498.447631951242;6682.866342673119;6824.078749368871;997.486294558303;1014.6043043213152;1031.9122874555746;1049.2969710294121;1085.3867564825848;4429.75636339998;4434.17967675981;4503.954960450354;4676.929846052312;4736.455307639666;11557.595484158013;13412.262325572186;13830;13845.930770346084;13933.442662293597;12815;13290.66773330655;13511.864881351257;13554.322283885964;13719.862801372059;8616.698415555426;8907.153820387053;10332.070113689804;10362.585496580203;10377.066064054121;5249.291345668286;6020.909686354796;6723.2604413515455;6767.661616919233;6802.319768023158;11703.180777345844;11750.647480575597;11857.881421185677;11944.283342999448;12088.093392995737;11973.221740586834;12042.879571204176;12083;12113.75772484563;12198.878011219775;7818.92181078182;8906.73279801607;9120.315976301672;9265.44407335562;9279.536023198949;10164.949175254076;10182.083612474913;10198.082172604501;10292.125169360688;10333.948330258301;8667;8696.521691306785;8700.564971751513;8773.912260877309;8786.428882122642;8356.582170891552;8518.275946544612;8547.529885856338;8579.699710510102;8633.56832158377;7508.774736757906;7682.231776822273;7810.140884502586;7821.726239581587;7827.84344313122;5752.395998420106;5760.1935728998815;5784.739686714024;5829.125631155191;5926.111083337534;5819.330776960704;5847.532197424281;5874.500667443315;5979.910301345571;6112.908306375497 02:29:49 INFO - PROCESS | 1646 | |4;prototype.html;375.4555893953767;375.7182113414939;376.51993708022286;385.1219220177992;385.2987562636002;4151.584841515847;4453.86214616984;5091.541761241488;5144.459831717662;5190.818321358754;4535.299262776459;4986.476419975905;5084.949150508493;5107.084843183806;5121.308623335848;3628.2924829658227;3644.763090399129;4245.405643209953;4248.320268756999;4272.658187345012;4040.6665800285837;4228.471441069866;4239.342901850203;4292.61366477017;4298.204832106055;3756.3050835595363;3843.7501562398493;3955.8417663293576;4239.427677263576;4302.880411701507;3938.6849052075763;4144.378343248507;4171.874843754677;4308.18144552534;4359.215341238576;3645.7994810285422;3763.9272807250077;3869.361555343365;3896.8246428910766;3902.2585708715255;4386.605205531518;4540.841070562515;4660.627149828006;4926.236433352836;4989.775460104304;4594.931076033862;4880.585150262232;4890.706557606555;4905.509449055102;4927.728974906378;4220.493540775096;4997.775100120503;5425.83344580917;5468.234447177399;5494.313210848644;3768.4724138620613;3932.6825513453027;4104.753714777123;4375.671824613167;4380;4697.88255293617;5019.9709059643055;5224.947750522522;5649.389923871718;5778.566607504412;4009.957411073142;4366.039471316305;4398.64810815134;4422.938494761234;4423.717122034638;3910.667593254548;4414.646828253732;4524.796384162721;4528.954710452919;4557.430321209848;4468.173387923244;4604.539546045368;4647.790849411717;4746.406699162605;4885.877853053631;4709.693869898446;5417.972910135424;5481.424450432647;5521.585881058856;5540.445955404427;1511.4709851551868;1658.6599747051825;1694.1359906447553;1721.2013445949012;1754.7101033151605;1319.7096638739463;1386.5632325817537;1405.868276037779;1416.199847086393;1422.69412076402;4707.081609402193;4736.692115012514;5165.690058596496;5176.343570057621;5213.3222681051975;4917.754112294371;5318.73406329682;5354.11657076578;5521.779128834802;5708.40061793514;4370.2570563004365;4847.345608342899;4893.510648935149;5091.719955402488;5151.5878729701535;2732.7130651281727;2774.569941659046;2903.8257704537373;2951.642244567523;2952.601398811176;4928.835134311573;5154.742262886841;5405.810721641233;5823.359430462646;5900.557458190653;4495.595396414338;5347.545458636059;5539.002979463655;5885.793997210163;5912.3496415394275;5542.445755424425;5636.689982050944;5864.853378665567;5925.822225333247;5929.911051334234;5282.8943421132135;5440.836774896601;5614.820887613483;5683.60214784961;5717.342505611908;4869.366982292421;5217.2434996925995;5343;5590.413006634245;5631.774729010794;5151.562117220078;5335.439778823323;5673.461021202979;5750.482456578928;5805.680687562224;3832.73170878047;3904.570497245244;4317.568243175658;4515.5484451554585;4517.864464066083;4834.371531700997;5250.18622113573;5421.647592906448;5461.754221059982;5675.517581005661;4660.883477913079;4713.62291016711;5403.918941215964;5498.45015498447;5520.171974203901;4905.975470122769;5482.5613950883035;5529.755804943856;5557.749901254534;5565.248691426606;4451.063787252556;5189.558887494454;5194.246834209094;5302.28419163408;5368.382635996911;4852.781624826962;4904.125740664835;5529.723513824373;5535.418781027934;5541.251930989426;4397.824087036611;4926.679765815211;4929.679570828028;5429.457054294539;5433.483819037185 02:29:49 INFO - PROCESS | 1646 | |5;yui.html;694.271015433795;719.6042176802757;756.9115235816578;768.1089935674619;857.8541647919851;15454.381824727012;15993.84006159938;15994.920025399857;16021.519354419372;16048.27782749776;14414.918881083935;14446.494372696958;14481.131132132054;14515.129092254472;14618.415263389452;908.5411867007168;930.1117432851644;931.6040682709855;943.3160958305208;943.688582767685;942.7407462947675;943.7546237978141;943.9197668198211;944.3578366710634;944.6174299408716;990.8662330585387;991.3407583956661;993.101243374747;994.6966175316526;995.0397866059251;987.2990176974286;988.7528117970471;989.1345073061071;989.6783545347755;990.0495524296684;728.155339805828;728.4245446097576;728.5701436152696;728.7085165933617;730;15774.132422716746;16052.59868503285;16096.195190240558;16227.350905963747;16472.176391180394;14013;14146.29268536569;14203.857961420461;14269.714605707932;14310.71378572433;11135.554577816878;11442.942785286103;11715.7071073223;11861.229020113666;12355.196912200678;3489.7289352553184;3635.800030998294;3725.2921944830396;3806.505154329947;3846.8653597123966;112130;116548.8345116555;117843;118798;120377.39811300975;10479.94760026195;10678.946605266923;10941.12471002318;11237.83143252852;11276.774464510663;22855.657165142537;23320.53358932812;23344.182953596544;23425.76574234236;23493;7667.233276672288;7672.80817979555;7787.727429539939;7824.921750782533;7960.164182760843;3868.3037053330672;4000.6399424051974;4029.2658212758556;4071.6742660587674;4091.590840915944;3409.2670075933793;3472.73954453417;3492.7904325740537;3496.8251587420527;3500.6674365935196;614.4899733221415;622.1103821535248;622.1197006236216;636.7707625254905;638.581728967527;620.965846878417;629.9275583307979;667.9298673639198;671.9832004199836;678.504691575153;9564.196698384212;9936.850947235796;10861.945690271656;11290.54837806495;11701.180917335705;566.6143307858775;572.1160806553884;621.4996927473337;656.8719099775593;709.2552819539463;4805.591524720368;4983.9252411213865;4991.226359914219;4995.950040499549;5031.4213865405945;77175.68472945821;93882.06117938732;97251;100181;103309;87368;87539;89372;89770.55114724385;90366.09633903709;76857.84713229306;77108.61445692848;78693;79680.60159699165;79747;8672.523011234443;8695.434796738191;8709.433886797338;8727.825443491221;8764.07190418107;38886.80556597199;47777.522224778695;47957.52042479531;48247.75876120597;48902.10978902081;68248;69275;69505.30494694988;70797.29202707906;72468;12237.632871013884;12746.10777245584;12812.974962003203;12953.417096230503;13185.406656700663;13899.235542045284;13913.51302704441;14654.780178297548;14978.850211497745;15408.691826163638;13127.474901003852;13904.443822247402;13972.161670299814;14026.859731402556;14129.788053179416;12949.296363799247;13638.522651707142;13784.931075344559;13825.585232443043;13992.860071399564;12834.422450989541;13682.726345472836;13724.862751372359;13839.377228024561;14016.159030458206;9293.25653947669;9452.243820494206;9767.755806104904;9859.950700246452;9888.357256778287;9076.954615226881;9357.251419886257;10319.638812641522;10399.428031458343;11079.12952542217 02:29:49 INFO - PROCESS | 1646 | __end_tp_report 02:29:49 INFO - PROCESS | 1646 | __start_cc_report 02:29:49 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2126 02:29:49 INFO - PROCESS | 1646 | __end_cc_report 02:29:49 INFO - PROCESS | 1646 | __startTimestamp1490866189674__endTimestamp 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | ------- Summary: start ------- 02:29:49 INFO - PROCESS | 1646 | Number of tests: 6 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5885.69 Median:6223.56 stddev:671.27 (10.8%) stddev-sans-first:644.05 02:29:49 INFO - PROCESS | 1646 | Values: 3386.0 3392.0 3395.6 3397.7 3453.5 5907.0 5924.8 5942.4 5946.5 5948.2 5913.5 5982.3 5982.5 5996.7 6005.9 5307.8 5331.2 5334.3 5381.4 5415.0 5257.0 5261.7 5451.8 5453.6 5492.2 5277.1 5321.2 5329.8 5337.2 5343.9 5348.6 5350.4 5357.4 5358.2 5366.5 4957.5 5200.4 5287.4 5304.1 5333.8 5174.6 5937.8 5950.4 5964.6 5970.1 6236.9 6280.9 6289.3 6302.9 6311.5 6327.2 6338.3 6339.8 6343.7 6345.0 5013.9 6066.4 6073.1 6074.9 6120.4 6194.6 6236.2 6419.9 6442.4 6481.6 6241.8 6258.3 6295.1 6303.1 6311.0 6309.1 6312.7 6313.6 6319.1 6322.1 5219.3 6288.0 6298.6 6303.8 6309.6 6203.1 6240.9 6293.2 6331.1 6350.6 4386.4 5082.7 5161.5 5162.4 5165.5 4512.7 4523.7 4542.0 4554.9 4559.1 6023.2 6079.2 6081.2 6096.4 6108.6 6245.2 6269.4 6287.3 6296.8 6313.9 5987.0 6018.3 6104.5 6110.5 6131.1 4753.2 5582.0 5642.6 5651.7 5675.1 6588.5 6596.4 6597.3 6603.0 6610.0 6223.6 6266.7 6271.5 6326.9 6335.7 6520.9 6555.9 6563.9 6570.8 6583.1 6292.9 6298.1 6323.7 6326.1 6329.1 6232.3 6236.2 6301.7 6303.0 6319.7 5885.3 6240.2 6254.0 6287.7 6288.1 6287.5 6300.5 6316.3 6322.8 6325.7 6219.7 6227.2 6265.5 6269.2 6275.3 6124.9 6140.2 6239.2 6257.2 6291.5 6238.1 6239.5 6253.8 6254.6 6255.8 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:54447.31 Median:31645.95 stddev:108517.73 (342.9%) stddev-sans-first:108747.10 02:29:49 INFO - PROCESS | 1646 | Values: 694.2 776.8 798.8 863.3 873.7 38381.4 39166.6 41175.2 41383.0 41391.4 40087.0 40338.2 40474.4 40534.6 40546.6 7291.0 8913.9 9050.3 9061.9 9063.8 7368.3 9064.7 11078.0 11146.5 11175.3 10908.5 10918.4 10938.9 10972.8 11006.2 7236.2 10935.9 10950.4 10979.7 10983.6 7313.0 10556.9 10810.2 10885.7 10943.2 38291.2 38538.6 38555.8 38583.6 38608.6 3725.3 3840.2 3845.8 3865.4 3894.3 27026.7 27761.9 28100.7 28720.3 28748.7 2970.2 3008.4 3014.7 3215.3 3220.1 340846.0 340951.0 341195.0 341251.0 341449.0 50271.5 50426.0 50527.5 50589.7 50651.0 54071.2 54101.0 54109.0 54200.0 54236.7 12344.8 14762.3 14878.9 14895.6 14896.2 12824.9 12828.4 12829.9 12838.4 12851.6 10582.6 11955.0 11959.3 12086.4 12102.3 5163.9 5209.1 5227.1 5228.7 5229.4 1057.5 1136.8 1138.3 1153.3 1159.2 23634.5 24597.4 26382.3 26822.5 26883.9 597.0 1043.6 1066.6 1085.0 1116.6 13069.3 13203.9 13370.5 13375.1 13414.0 462100.0 465445.0 465453.7 466233.0 468080.0 56372.7 56398.6 56414.7 56433.0 56879.0 1412.1 1450.6 1457.2 1457.2 1458.8 22609.7 23711.2 24322.8 24944.4 25242.4 44737.6 44936.1 44992.0 45014.8 45130.5 356979.0 422654.0 422953.0 424906.0 425961.0 31402.9 31519.7 31645.5 31646.4 31653.9 41916.6 42034.4 42262.0 42529.6 42814.9 25989.5 29159.8 29360.6 29953.1 30105.0 28067.3 30094.9 30300.4 30390.0 30473.7 27913.2 29223.4 34079.0 35829.0 35939.6 29592.8 29647.4 30536.8 31901.7 31904.0 24764.0 24780.4 24877.6 25301.4 25312.9 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:38298.11 Median:23947.50 stddev:102067.90 (426.2%) stddev-sans-first:102314.53 02:29:49 INFO - PROCESS | 1646 | Values: 388.6 406.6 424.6 428.0 446.5 10158.5 15011.7 21182.0 21744.9 21887.2 21842.6 22010.8 22562.7 22909.3 23191.0 6575.2 6612.9 6761.7 6849.6 6872.1 4192.1 4486.0 5876.9 6615.9 6779.9 4458.0 7805.4 7832.3 7846.6 7847.8 7545.7 7664.0 7731.5 7758.4 7792.2 7277.3 7481.4 7519.8 7552.9 7556.9 24704.0 25730.2 26419.7 27312.0 27587.2 2890.6 2934.9 2936.6 2994.3 3053.8 15193.5 15567.5 15912.1 16044.8 16495.7 2015.9 2031.2 2049.1 2053.1 2113.7 151080.0 153291.0 153811.2 156484.0 156823.0 17836.7 18159.9 20335.7 20581.6 20602.4 32354.7 32625.5 32670.7 32688.5 32691.8 8078.7 8727.8 10063.8 10344.2 10454.8 8405.8 8557.0 8571.9 8746.6 8786.9 8863.6 9174.2 9287.3 9319.4 9323.8 3744.3 3829.4 3831.5 3834.2 3842.2 701.3 800.4 872.1 886.6 905.6 20443.8 21104.2 21129.9 21168.8 21212.4 909.9 917.8 922.5 925.0 928.9 8835.9 10051.3 10728.4 10987.8 11012.8 362216.2 487707.0 683619.6 697707.0 698445.0 143062.3 152318.5 154332.0 155687.0 157185.4 1159.0 1205.2 1254.6 1255.6 1255.8 19377.9 19394.2 19821.7 19839.3 19863.4 58440.7 58806.1 60290.8 60369.7 60633.0 81003.0 82774.0 83401.6 84016.0 93650.5 11380.4 11426.9 11651.6 11787.8 11991.3 12841.4 12873.9 13036.3 13236.5 13272.7 11181.9 11234.0 11458.8 11630.1 11677.6 10669.9 10671.5 10761.4 10959.9 10970.5 11290.0 11653.7 11754.5 11803.4 11821.8 11544.8 11571.4 11752.9 11822.6 11932.9 9102.5 11146.3 11450.4 11501.3 11508.7 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:6614.12 Median:2431.90 stddev:4095.33 (168.4%) stddev-sans-first:4088.86 02:29:49 INFO - PROCESS | 1646 | Values: 1510.4 1515.6 1538.2 1559.4 1565.5 9730.5 10207.5 10208.5 10224.7 10227.5 10639.8 11014.9 11232.5 11247.7 11252.2 2031.9 2428.5 2428.9 2431.1 2431.4 2353.2 2419.7 2435.0 2443.8 2444.5 2349.1 2398.3 2404.4 2432.5 2434.7 2309.7 2344.4 2384.3 2388.9 2393.6 2314.3 2332.5 2338.4 2343.4 2344.9 10643.6 11141.8 11150.4 11173.3 11179.7 5775.3 5911.3 5934.0 5955.3 5965.6 3513.4 3621.0 3659.2 3686.7 3708.4 1186.1 1193.8 1223.5 1228.9 1249.4 13520.6 13844.7 14134.6 15302.3 15537.5 4003.6 4238.4 4319.4 4322.6 4372.7 11720.8 11804.2 11812.9 11817.6 11830.5 4624.6 5883.9 5884.5 5884.6 5884.9 5138.4 5231.8 5255.9 5306.8 5333.8 3753.8 3798.9 3847.2 3869.0 3891.7 1004.4 1018.9 1023.3 1031.3 1031.6 803.8 837.4 909.4 918.3 937.9 5810.6 6394.9 6498.4 6682.9 6824.1 997.5 1014.6 1031.9 1049.3 1085.4 4429.8 4434.2 4504.0 4676.9 4736.5 11557.6 13412.3 13830.0 13845.9 13933.4 12815.0 13290.7 13511.9 13554.3 13719.9 8616.7 8907.2 10332.1 10362.6 10377.1 5249.3 6020.9 6723.3 6767.7 6802.3 11703.2 11750.6 11857.9 11944.3 12088.1 11973.2 12042.9 12083.0 12113.8 12198.9 7818.9 8906.7 9120.3 9265.4 9279.5 10164.9 10182.1 10198.1 10292.1 10333.9 8667.0 8696.5 8700.6 8773.9 8786.4 8356.6 8518.3 8547.5 8579.7 8633.6 7508.8 7682.2 7810.1 7821.7 7827.8 5752.4 5760.2 5784.7 5829.1 5926.1 5819.3 5847.5 5874.5 5979.9 6112.9 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4525.36 Median:4874.98 stddev:1230.17 (25.2%) stddev-sans-first:1193.53 02:29:49 INFO - PROCESS | 1646 | Values: 375.5 375.7 376.5 385.1 385.3 4151.6 4453.9 5091.5 5144.5 5190.8 4535.3 4986.5 5084.9 5107.1 5121.3 3628.3 3644.8 4245.4 4248.3 4272.7 4040.7 4228.5 4239.3 4292.6 4298.2 3756.3 3843.8 3955.8 4239.4 4302.9 3938.7 4144.4 4171.9 4308.2 4359.2 3645.8 3763.9 3869.4 3896.8 3902.3 4386.6 4540.8 4660.6 4926.2 4989.8 4594.9 4880.6 4890.7 4905.5 4927.7 4220.5 4997.8 5425.8 5468.2 5494.3 3768.5 3932.7 4104.8 4375.7 4380.0 4697.9 5020.0 5224.9 5649.4 5778.6 4010.0 4366.0 4398.6 4422.9 4423.7 3910.7 4414.6 4524.8 4529.0 4557.4 4468.2 4604.5 4647.8 4746.4 4885.9 4709.7 5418.0 5481.4 5521.6 5540.4 1511.5 1658.7 1694.1 1721.2 1754.7 1319.7 1386.6 1405.9 1416.2 1422.7 4707.1 4736.7 5165.7 5176.3 5213.3 4917.8 5318.7 5354.1 5521.8 5708.4 4370.3 4847.3 4893.5 5091.7 5151.6 2732.7 2774.6 2903.8 2951.6 2952.6 4928.8 5154.7 5405.8 5823.4 5900.6 4495.6 5347.5 5539.0 5885.8 5912.3 5542.4 5636.7 5864.9 5925.8 5929.9 5282.9 5440.8 5614.8 5683.6 5717.3 4869.4 5217.2 5343.0 5590.4 5631.8 5151.6 5335.4 5673.5 5750.5 5805.7 3832.7 3904.6 4317.6 4515.5 4517.9 4834.4 5250.2 5421.6 5461.8 5675.5 4660.9 4713.6 5403.9 5498.5 5520.2 4906.0 5482.6 5529.8 5557.7 5565.2 4451.1 5189.6 5194.2 5302.3 5368.4 4852.8 4904.1 5529.7 5535.4 5541.3 4397.8 4926.7 4929.7 5429.5 5433.5 02:29:49 INFO - PROCESS | 1646 | 02:29:49 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20570.87 Median:26381.56 stddev:29799.04 (113.0%) stddev-sans-first:29845.26 02:29:49 INFO - PROCESS | 1646 | Values: 694.3 719.6 756.9 768.1 857.9 15454.4 15993.8 15994.9 16021.5 16048.3 14414.9 14446.5 14481.1 14515.1 14618.4 908.5 930.1 931.6 943.3 943.7 942.7 943.8 943.9 944.4 944.6 990.9 991.3 993.1 994.7 995.0 987.3 988.8 989.1 989.7 990.0 728.2 728.4 728.6 728.7 730.0 15774.1 16052.6 16096.2 16227.4 16472.2 14013.0 14146.3 14203.9 14269.7 14310.7 11135.6 11442.9 11715.7 11861.2 12355.2 3489.7 3635.8 3725.3 3806.5 3846.9 112130.0 116548.8 117843.0 118798.0 120377.4 10479.9 10678.9 10941.1 11237.8 11276.8 22855.7 23320.5 23344.2 23425.8 23493.0 7667.2 7672.8 7787.7 7824.9 7960.2 3868.3 4000.6 4029.3 4071.7 4091.6 3409.3 3472.7 3492.8 3496.8 3500.7 614.5 622.1 622.1 636.8 638.6 621.0 629.9 667.9 672.0 678.5 9564.2 9936.9 10861.9 11290.5 11701.2 566.6 572.1 621.5 656.9 709.3 4805.6 4983.9 4991.2 4996.0 5031.4 77175.7 93882.1 97251.0 100181.0 103309.0 87368.0 87539.0 89372.0 89770.6 90366.1 76857.8 77108.6 78693.0 79680.6 79747.0 8672.5 8695.4 8709.4 8727.8 8764.1 38886.8 47777.5 47957.5 48247.8 48902.1 68248.0 69275.0 69505.3 70797.3 72468.0 12237.6 12746.1 12813.0 12953.4 13185.4 13899.2 13913.5 14654.8 14978.9 15408.7 13127.5 13904.4 13972.2 14026.9 14129.8 12949.3 13638.5 13784.9 13825.6 13992.9 12834.4 13682.7 13724.9 13839.4 14016.2 9293.3 9452.2 9767.8 9860.0 9888.4 9077.0 9357.3 10319.6 10399.4 11079.1 02:29:49 INFO - PROCESS | 1646 | -------- Summary: end -------- 02:29:49 INFO - PROCESS | 1646 | 02:29:50 INFO - TEST-INFO | 1646: exit 0 02:29:50 INFO - TEST-OK | dromaeo_css | took 1121403ms 02:29:50 INFO - TEST-START | kraken 02:29:50 INFO - operating with platform_type : mac_ 02:29:50 INFO - Initialising browser for kraken test... 02:29:50 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpqNUHF8/profile http://localhost:49250/getInfo.html) 02:29:52 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 02:29:52 INFO - PROCESS | 1652 | colorDepth:24 02:29:52 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 02:29:52 INFO - PROCESS | 1652 | __metrics 02:29:52 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:29:52 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:53 INFO - TEST-INFO | 1652: exit 0 02:29:53 INFO - Browser initialized. 02:29:53 INFO - Running cycle 1/1 for kraken test... 02:29:53 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpqNUHF8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:05 INFO - PROCESS | 1654 | RSS: Main: 215105536 02:30:05 INFO - PROCESS | 1654 | 02:30:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 02:30:09 INFO - PROCESS | 1654 | RSS: Main: 267595776 02:30:09 INFO - PROCESS | 1654 | 02:30:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 02:30:12 INFO - PROCESS | 1654 | RSS: Main: 279265280 02:30:12 INFO - PROCESS | 1654 | 02:30:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 02:30:16 INFO - PROCESS | 1654 | RSS: Main: 376451072 02:30:16 INFO - PROCESS | 1654 | 02:30:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 02:30:18 INFO - PROCESS | 1654 | RSS: Main: 279121920 02:30:18 INFO - PROCESS | 1654 | 02:30:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:21 INFO - PROCESS | 1654 | RSS: Main: 280535040 02:30:21 INFO - PROCESS | 1654 | 02:30:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:25 INFO - PROCESS | 1654 | RSS: Main: 320626688 02:30:25 INFO - PROCESS | 1654 | 02:30:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:29 INFO - PROCESS | 1654 | RSS: Main: 321646592 02:30:29 INFO - PROCESS | 1654 | 02:30:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 02:30:32 INFO - PROCESS | 1654 | RSS: Main: 320774144 02:30:32 INFO - PROCESS | 1654 | 02:30:34 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:35 INFO - PROCESS | 1654 | RSS: Main: 294690816 02:30:35 INFO - PROCESS | 1654 | 02:30:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:37 INFO - PROCESS | 1654 | RSS: Main: 300011520 02:30:37 INFO - PROCESS | 1654 | 02:30:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:40 INFO - PROCESS | 1654 | RSS: Main: 302718976 02:30:40 INFO - PROCESS | 1654 | 02:30:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:43 INFO - PROCESS | 1654 | RSS: Main: 322416640 02:30:43 INFO - PROCESS | 1654 | 02:30:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:47 INFO - PROCESS | 1654 | RSS: Main: 315621376 02:30:47 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 02:30:49 INFO - PROCESS | 1654 | RSS: Main: 360427520 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | __start_tp_report 02:30:49 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 02:30:49 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 02:30:49 INFO - PROCESS | 1654 | |i|pagename|runs| 02:30:49 INFO - PROCESS | 1654 | |0;ai-astar;117;117;116;114;116;115;117;116;116;113 02:30:49 INFO - PROCESS | 1654 | |1;audio-beat-detection;144;108;107;144;135;110;91;129;161;137 02:30:49 INFO - PROCESS | 1654 | |2;audio-dft;187;187;183;189;184;185;185;186;185;186 02:30:49 INFO - PROCESS | 1654 | |3;audio-fft;82;62;61;92;64;59;64;61;76;61 02:30:49 INFO - PROCESS | 1654 | |4;audio-oscillator;91;70;86;69;70;67;82;68;68;83 02:30:49 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;91;91;91;91;134;133;92;90;90;91 02:30:49 INFO - PROCESS | 1654 | |6;imaging-darkroom;97;97;97;97;97;100;97;98;123;100 02:30:49 INFO - PROCESS | 1654 | |7;imaging-desaturate;86;83;84;84;86;85;86;96;127;129 02:30:49 INFO - PROCESS | 1654 | |8;json-parse-financial;60;60;60;61;63;64;64;64;63;63 02:30:49 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;55;56;67;66;61;58;58;58;59;60 02:30:49 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;84;85;83;84;85;93;98;104;75;82 02:30:49 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;139;137;137;134;133;137;140;127;193;145 02:30:49 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;163;164;163;162;215;163;164;164;161;161 02:30:49 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;65;65;67;79;78;80;79;64;63;64 02:30:49 INFO - PROCESS | 1654 | __end_tp_report 02:30:49 INFO - PROCESS | 1654 | __start_cc_report 02:30:49 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2158 02:30:49 INFO - PROCESS | 1654 | __end_cc_report 02:30:49 INFO - PROCESS | 1654 | __startTimestamp1490866249540__endTimestamp 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | ------- Summary: start ------- 02:30:49 INFO - PROCESS | 1654 | Number of tests: 14 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:1.34 (1.2%) stddev-sans-first:1.33 02:30:49 INFO - PROCESS | 1654 | Values: 117.0 117.0 116.0 114.0 116.0 115.0 117.0 116.0 116.0 113.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:140.50 stddev:21.72 (15.5%) stddev-sans-first:22.11 02:30:49 INFO - PROCESS | 1654 | Values: 144.0 108.0 107.0 144.0 135.0 110.0 91.0 129.0 161.0 137.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:185.70 Median:186.00 stddev:1.70 (0.9%) stddev-sans-first:1.74 02:30:49 INFO - PROCESS | 1654 | Values: 187.0 187.0 183.0 189.0 184.0 185.0 185.0 186.0 185.0 186.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:68.20 Median:64.00 stddev:11.21 (17.5%) stddev-sans-first:10.72 02:30:49 INFO - PROCESS | 1654 | Values: 82.0 62.0 61.0 92.0 64.0 59.0 64.0 61.0 76.0 61.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.00 stddev:9.05 (11.9%) stddev-sans-first:7.63 02:30:49 INFO - PROCESS | 1654 | Values: 91.0 70.0 86.0 69.0 70.0 67.0 82.0 68.0 68.0 83.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:91.00 stddev:17.98 (19.8%) stddev-sans-first:18.81 02:30:49 INFO - PROCESS | 1654 | Values: 91.0 91.0 91.0 91.0 134.0 133.0 92.0 90.0 90.0 91.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:97.00 stddev:8.07 (8.3%) stddev-sans-first:8.47 02:30:49 INFO - PROCESS | 1654 | Values: 97.0 97.0 97.0 97.0 97.0 100.0 97.0 98.0 123.0 100.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:85.50 stddev:17.98 (21.0%) stddev-sans-first:18.80 02:30:49 INFO - PROCESS | 1654 | Values: 86.0 83.0 84.0 84.0 86.0 85.0 86.0 96.0 127.0 129.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.67 02:30:49 INFO - PROCESS | 1654 | Values: 60.0 60.0 60.0 61.0 63.0 64.0 64.0 64.0 63.0 63.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.50 stddev:3.94 (6.6%) stddev-sans-first:3.77 02:30:49 INFO - PROCESS | 1654 | Values: 55.0 56.0 67.0 66.0 61.0 58.0 58.0 58.0 59.0 60.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.50 stddev:8.54 (10.1%) stddev-sans-first:8.97 02:30:49 INFO - PROCESS | 1654 | Values: 84.0 85.0 83.0 84.0 85.0 93.0 98.0 104.0 75.0 82.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:138.00 stddev:18.46 (13.4%) stddev-sans-first:19.55 02:30:49 INFO - PROCESS | 1654 | Values: 139.0 137.0 137.0 134.0 133.0 137.0 140.0 127.0 193.0 145.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:163.50 stddev:16.55 (10.1%) stddev-sans-first:17.46 02:30:49 INFO - PROCESS | 1654 | Values: 163.0 164.0 163.0 162.0 215.0 163.0 164.0 164.0 161.0 161.0 02:30:49 INFO - PROCESS | 1654 | 02:30:49 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:72.50 stddev:7.49 (10.3%) stddev-sans-first:7.68 02:30:49 INFO - PROCESS | 1654 | Values: 65.0 65.0 67.0 79.0 78.0 80.0 79.0 64.0 63.0 64.0 02:30:49 INFO - PROCESS | 1654 | -------- Summary: end -------- 02:30:49 INFO - PROCESS | 1654 | 02:30:50 INFO - TEST-INFO | 1654: exit 0 02:30:50 INFO - TEST-OK | kraken | took 60089ms 02:30:50 INFO - SUITE-END | took 1181s 02:30:50 INFO - Completed test suite (00:19:41) 02:30:50 INFO - javascript benchmark 02:30:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7617.754081520717, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3385.9888061556208, 3391.9660803391967, 3395.609504906935, 3397.6602339766027, 3453.464712969489, 5906.970465147673, 5924.822255332336, 5942.405759424067, 5946.4945479634225, 5948.167256584076, 5913.467787899099, 5982.312034116078, 5982.491488223495, 5996.670183139926, 6005.909911351333, 5307.814226502073, 5331.200319952019, 5334.253204551366, 5381.4349493303225, 5415.0, 5257.027449921758, 5261.657992230493, 5451.754671039813, 5453.563714902798, 5492.176173573956, 5277.102892508283, 5321.228421878825, 5329.760160792774, 5337.1994200869985, 5343.919841202385, 5348.598855085884, 5350.384705758829, 5357.4374690657305, 5358.169483730008, 5366.543843773284, 4957.487966170316, 5200.427952925175, 5287.418383977798, 5304.124819404794, 5333.759980800874, 5174.637775355726, 5937.792177273818, 5950.375210602911, 5964.642121472682, 5970.13433052205, 6236.906446403307, 6280.905786413207, 6289.339619339949, 6302.873942521124, 6311.526635502356, 6327.17746692927, 6338.271098823649, 6339.841503962438, 6343.746250149989, 6345.016522439029, 5013.949860501385, 6066.393360663942, 6073.149759033695, 6074.8785024299705, 6120.387961203888, 6194.628322300587, 6236.158118653923, 6419.935800642027, 6442.355764423567, 6481.578697384655, 6241.78153764616, 6258.280297765724, 6295.087212354183, 6303.117563541108, 6310.968445157837, 6309.116723658692, 6312.715927783261, 6313.621182729051, 6319.115323854664, 6322.083297921776, 5219.347581552306, 6288.025356069817, 6298.590591611531, 6303.810885673437, 6309.589876658002, 6203.131561581382, 6240.937590624127, 6293.1504246927, 6331.05034244867, 6350.587211831308, 4386.429764130643, 5082.669626474268, 5161.483851614808, 5162.406323272797, 5165.535101840853, 4512.706674066175, 4523.705959112647, 4541.9545804542195, 4554.908901821945, 4559.133764584718, 6023.247094113236, 6079.179310793074, 6081.239845019372, 6096.359882212392, 6108.5723999319625, 6245.219347581552, 6269.404406581368, 6287.2769631492965, 6296.811095667137, 6313.905291420632, 5987.0, 6018.307894592178, 6104.4505994460715, 6110.541709371815, 6131.14164017038, 4753.239481682914, 5581.972090139523, 5642.633228840113, 5651.717414129359, 5675.063614503643, 6588.472922166311, 6596.439302659328, 6597.3072827352435, 6603.0, 6609.966950165219, 6223.564350495421, 6266.68666566679, 6271.4669253114, 6326.873462530815, 6335.683215839097, 6520.902186467112, 6555.868882622225, 6563.868722625425, 6570.8028759137305, 6583.144191255106, 6292.874142517216, 6298.0867774171575, 6323.747050117944, 6326.145970294136, 6329.145565348619, 6232.25212974446, 6236.158118653923, 6301.747930082745, 6303.0, 6319.715612797343, 5885.323187833454, 6240.157578726996, 6253.96873015632, 6287.654179020198, 6288.088227207121, 6287.46556542699, 6300.495960323072, 6316.336784637547, 6322.810315690536, 6325.652089135142, 6219.657918814509, 6227.159333490102, 6265.49876009909, 6269.153664255267, 6275.278342990432, 6124.938750612437, 6140.19751335002, 6239.188905442445, 6257.217847769029, 6291.528135389773, 6238.095476155841, 6239.4696450800375, 6253.78111766086, 6254.562180647311, 6255.78104766331], "value": 5842.261855619338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.1531331775234, 776.8446310737854, 798.8402319536094, 863.25328590769, 873.6854732296376, 38381.424278635845, 39166.60833391665, 41175.176496470056, 41382.96542586437, 41391.37912931301, 40087.0, 40338.19323613526, 40474.39288410669, 40534.58128965487, 40546.59453405465, 7291.0, 8913.910860891388, 9050.275977921783, 9061.864072038925, 9063.773405664879, 7368.263173682616, 9064.728058158265, 11078.002979731822, 11146.498407571638, 11175.329480231172, 10908.454577271144, 10918.399488028155, 10938.890611093866, 10972.780544389107, 11006.174536909724, 7236.204017558064, 10935.890641093567, 10950.39772812499, 10979.670609881716, 10983.560657573687, 7313.0, 10556.947215263952, 10810.243282970196, 10885.673429797118, 10943.23397362185, 38291.234175316335, 38538.61461385378, 38555.807220963994, 38583.61416385856, 38608.61391386078, 3725.329440700673, 3840.2127563849344, 3845.807709614536, 3865.43951127085, 3894.2600905827803, 27026.729732702617, 27761.889524419, 28100.718992810016, 28720.281992950135, 28748.712512874812, 2970.212893583202, 3008.443437963984, 3014.6985301469895, 3215.26049008727, 3220.0500852248642, 340846.0, 340951.0, 341194.9999999975, 341251.0, 341449.0, 50271.49728502741, 50426.0, 50527.49472505302, 50589.74705126451, 50651.0, 54071.18893216605, 54101.0, 54109.0, 54200.0, 54236.728816355666, 12344.75310493785, 14762.335694893756, 14878.851211487747, 14895.553133406016, 14896.180710060835, 12824.909882660078, 12828.422720977578, 12829.93585032069, 12838.358082096045, 12851.614451566467, 10582.57669693219, 11955.0, 11959.342236176919, 12086.39568021613, 12102.273863568214, 5163.922541161885, 5209.088409528317, 5227.111391063529, 5228.712420816892, 5229.424763276036, 1057.5399701130034, 1136.812425949709, 1138.322697994692, 1153.3195414705365, 1159.1538177130574, 23634.527309453715, 24597.38506537351, 26382.340441488734, 26822.463550729266, 26883.865580671973, 597.0070048821909, 1043.5773511727762, 1066.6373433032807, 1084.9945750271197, 1116.5757012335262, 13069.346532673328, 13203.867961320457, 13370.46518139283, 13375.063745537718, 13414.0, 462100.0, 465445.0, 465453.6727316409, 466233.0, 468080.0, 56372.71813640906, 56398.59003524945, 56414.71792641011, 56433.0, 56879.0, 1412.0750908155176, 1450.6010847016944, 1457.205822826541, 1457.2203870929002, 1458.8322342930487, 22609.660855087517, 23711.1701090461, 24322.75677243205, 24944.378615389942, 25242.368940775894, 44737.55262447334, 44936.101277973605, 44992.0, 45014.77492612516, 45130.54869451263, 356979.0, 422654.0, 422953.0, 424906.0, 425961.0, 31402.900898468444, 31519.684803151675, 31645.525317119802, 31646.36707265888, 31653.892113775906, 41916.58083419127, 42034.369484458366, 42262.0, 42529.57470425256, 42814.929626758334, 25989.480210396065, 29159.833606655495, 29360.559591605717, 29953.101406957827, 30105.0, 28067.298317542223, 30094.946676866206, 30300.393992120476, 30390.0, 30473.695263047084, 27913.162605121877, 29223.41553168882, 34079.0, 35829.0, 35939.64060359468, 29592.816287348265, 29647.407051859274, 30536.84731576328, 31901.6809831908, 31904.042878713677, 24764.0, 24780.38049048788, 24877.626835597843, 25301.367465813502, 25312.873435632704], "value": 18365.255897183688, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.58421489006776, 406.59137566745414, 424.6326927207964, 427.9721818081824, 446.47093194564445, 10158.54286557105, 15011.699766004687, 21182.04680789366, 21744.8912755436, 21887.233946811866, 21842.563148737056, 22010.779892201073, 22562.661560076613, 22909.312720618407, 23191.0, 6575.178102737158, 6612.933870661304, 6761.729530818761, 6849.554778939378, 6872.072270243503, 4192.119654872466, 4486.035502366991, 5876.882462350751, 6615.900761488581, 6779.864402711943, 4457.955420445803, 7805.4145939054515, 7832.255935686101, 7846.568438735867, 7847.843043139133, 7545.69817207311, 7664.0, 7731.45879788415, 7758.418118641124, 7792.220777922191, 7277.3086556777025, 7481.364084052862, 7519.849603007964, 7552.8867066994035, 7556.924430755677, 24704.0, 25730.22809315705, 26419.73580264192, 27312.0, 27587.206831555886, 2890.609767681357, 2934.89727859526, 2936.5741967414606, 2994.2813724705916, 3053.7862349635534, 15193.468228611946, 15567.455139070078, 15912.124833134172, 16044.839551604451, 16495.670086598322, 2015.8689685170564, 2031.1672214392029, 2049.0867012981835, 2053.147943603403, 2113.7252157219464, 151080.0, 153291.0, 153811.23094384567, 156484.0, 156823.0, 17836.732449013274, 18159.909200453912, 20335.694964575545, 20581.58836823255, 20602.381928542167, 32354.676453235636, 32625.51061734076, 32670.67329326724, 32688.509672354932, 32691.836540817145, 8078.676852925817, 8727.81434776302, 10063.798724025624, 10344.172466202686, 10454.843177352346, 8405.831883362298, 8557.0, 8571.871421928676, 8746.562671866508, 8786.912130878738, 8863.626137948628, 9174.20186843006, 9287.309908496301, 9319.440833550008, 9323.766905827273, 3744.3260213161348, 3829.3681542545723, 3831.4635950966886, 3834.1948190880225, 3842.193139440749, 701.2951983256794, 800.4116974024088, 872.1017352127319, 886.6453418632599, 905.6060613633091, 20443.795562044488, 21104.155833766785, 21129.943502824797, 21168.78831211699, 21212.363629091153, 909.8908131024319, 917.7705573606598, 922.524899676667, 924.9722508324761, 928.9024652411534, 8835.895513060867, 10051.296409251428, 10728.409937453358, 10987.835182472269, 11012.779744405067, 362216.188919059, 487707.0, 683619.5819020873, 697707.0, 698445.0, 143062.284688578, 152318.47681523266, 154332.0, 155687.0, 157185.42516598644, 1158.9594364197212, 1205.2467207995003, 1254.6110705681085, 1255.617036803802, 1255.8241846141548, 19377.903110484356, 19394.2242310306, 19821.702674459608, 19839.30562430308, 19863.404097877086, 58440.707796460745, 58806.11790823226, 60290.79418411695, 60369.69815151072, 60633.0, 81003.0, 82774.0, 83401.58299208707, 84016.0, 93650.53174734356, 11380.43097845121, 11426.885731142582, 11651.592194273499, 11787.764244715228, 11991.340476273888, 12841.35793210317, 12873.935630321788, 13036.283004434468, 13236.470541178245, 13272.668183295495, 11181.944090279496, 11233.96814989225, 11458.82811757841, 11630.069594432594, 11677.591284305008, 10669.946650266698, 10671.519781609692, 10761.408122553335, 10959.890401095887, 10970.451477425937, 11290.040346570633, 11653.708657283636, 11754.529818807152, 11803.350815705218, 11821.822672659744, 11544.826827597424, 11571.363575003455, 11752.94123529411, 11822.586209482626, 11932.880671193177, 9102.499362535124, 11146.275492092987, 11450.427478625868, 11501.252418592765, 11508.712282193012], "value": 11355.331400614949, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.3807438950018, 1515.5907904865687, 1538.2385719069061, 1559.3606621285269, 1565.5146904459618, 9730.513474326292, 10207.489625518712, 10208.540615672304, 10224.693259202217, 10227.48862556871, 10639.840402393951, 11014.944925275362, 11232.4945377458, 11247.718807029829, 11252.212345135824, 2031.8984050797476, 2428.514297140579, 2428.9271321860374, 2431.124795073772, 2431.3556907419547, 2353.211674089182, 2419.6733440985417, 2435.025989604155, 2443.841150325223, 2444.4622183119686, 2349.0955981946904, 2398.256540472459, 2404.362843846382, 2432.4526981429126, 2434.7078350597953, 2309.6881920940627, 2344.4373350395954, 2384.29663249341, 2388.916387926423, 2393.628987506939, 2314.305708287507, 2332.486852892361, 2338.4153961509624, 2343.4492894169857, 2344.871032093234, 10643.57425702971, 11141.832872506919, 11150.386728729916, 11173.273737207055, 11179.720506987309, 5775.335836378828, 5911.349751527328, 5934.0, 5955.34491205967, 5965.55258355625, 3513.437849944022, 3621.040424287566, 3659.2315613721153, 3686.7419280650365, 3708.388115960863, 1186.0985650905288, 1193.8448001759716, 1223.4616768621777, 1228.8525376954822, 1249.4065318973505, 13520.594382168452, 13844.723105537832, 14134.646633834134, 15302.311395987208, 15537.456189033443, 4003.599640035973, 4238.385434112037, 4319.438472998553, 4322.567743225715, 4372.737635741865, 11720.765584688259, 11804.17370784037, 11812.881871181178, 11817.645470635895, 11830.467628956718, 4624.606908412756, 5883.852903677357, 5884.47039766423, 5884.617499862581, 5884.852878678067, 5138.434772175057, 5231.764570594332, 5255.921161182585, 5306.7611957462, 5333.759980800874, 3753.774773513543, 3798.9050273742823, 3847.153626202231, 3869.0, 3891.7081218908697, 1004.4124187350482, 1018.9490525473697, 1023.3194925374692, 1031.28841099641, 1031.6028329093353, 803.843250566134, 837.4263629413749, 909.3861643390685, 918.3296193778579, 937.8827646544182, 5810.593258471867, 6394.912864812993, 6498.447631951242, 6682.866342673119, 6824.078749368871, 997.486294558303, 1014.6043043213152, 1031.9122874555746, 1049.2969710294121, 1085.3867564825848, 4429.75636339998, 4434.17967675981, 4503.954960450354, 4676.929846052312, 4736.455307639666, 11557.595484158013, 13412.262325572186, 13830.0, 13845.930770346084, 13933.442662293597, 12815.0, 13290.66773330655, 13511.864881351257, 13554.322283885964, 13719.862801372059, 8616.698415555426, 8907.153820387053, 10332.070113689804, 10362.585496580203, 10377.066064054121, 5249.291345668286, 6020.909686354796, 6723.2604413515455, 6767.661616919233, 6802.319768023158, 11703.180777345844, 11750.647480575597, 11857.881421185677, 11944.283342999448, 12088.093392995737, 11973.221740586834, 12042.879571204176, 12083.0, 12113.75772484563, 12198.878011219775, 7818.92181078182, 8906.73279801607, 9120.315976301672, 9265.44407335562, 9279.536023198949, 10164.949175254076, 10182.083612474913, 10198.082172604501, 10292.125169360688, 10333.948330258301, 8667.0, 8696.521691306785, 8700.564971751513, 8773.912260877309, 8786.428882122642, 8356.582170891552, 8518.275946544612, 8547.529885856338, 8579.699710510102, 8633.56832158377, 7508.774736757906, 7682.231776822273, 7810.140884502586, 7821.726239581587, 7827.84344313122, 5752.395998420106, 5760.1935728998815, 5784.739686714024, 5829.125631155191, 5926.111083337534, 5819.330776960704, 5847.532197424281, 5874.500667443315, 5979.910301345571, 6112.908306375497], "value": 5069.782514180329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4555893953767, 375.7182113414939, 376.51993708022286, 385.1219220177992, 385.2987562636002, 4151.584841515847, 4453.86214616984, 5091.541761241488, 5144.459831717662, 5190.818321358754, 4535.299262776459, 4986.476419975905, 5084.949150508493, 5107.084843183806, 5121.308623335848, 3628.2924829658227, 3644.763090399129, 4245.405643209953, 4248.320268756999, 4272.658187345012, 4040.6665800285837, 4228.471441069866, 4239.342901850203, 4292.61366477017, 4298.204832106055, 3756.3050835595363, 3843.7501562398493, 3955.8417663293576, 4239.427677263576, 4302.880411701507, 3938.6849052075763, 4144.378343248507, 4171.874843754677, 4308.18144552534, 4359.215341238576, 3645.7994810285422, 3763.9272807250077, 3869.361555343365, 3896.8246428910766, 3902.2585708715255, 4386.605205531518, 4540.841070562515, 4660.627149828006, 4926.236433352836, 4989.775460104304, 4594.931076033862, 4880.585150262232, 4890.706557606555, 4905.509449055102, 4927.728974906378, 4220.493540775096, 4997.775100120503, 5425.83344580917, 5468.234447177399, 5494.313210848644, 3768.4724138620613, 3932.6825513453027, 4104.753714777123, 4375.671824613167, 4380.0, 4697.88255293617, 5019.9709059643055, 5224.947750522522, 5649.389923871718, 5778.566607504412, 4009.957411073142, 4366.039471316305, 4398.64810815134, 4422.938494761234, 4423.717122034638, 3910.667593254548, 4414.646828253732, 4524.796384162721, 4528.954710452919, 4557.430321209848, 4468.173387923244, 4604.539546045368, 4647.790849411717, 4746.406699162605, 4885.877853053631, 4709.693869898446, 5417.972910135424, 5481.424450432647, 5521.585881058856, 5540.445955404427, 1511.4709851551868, 1658.6599747051825, 1694.1359906447553, 1721.2013445949012, 1754.7101033151605, 1319.7096638739463, 1386.5632325817537, 1405.868276037779, 1416.199847086393, 1422.69412076402, 4707.081609402193, 4736.692115012514, 5165.690058596496, 5176.343570057621, 5213.3222681051975, 4917.754112294371, 5318.73406329682, 5354.11657076578, 5521.779128834802, 5708.40061793514, 4370.2570563004365, 4847.345608342899, 4893.510648935149, 5091.719955402488, 5151.5878729701535, 2732.7130651281727, 2774.569941659046, 2903.8257704537373, 2951.642244567523, 2952.601398811176, 4928.835134311573, 5154.742262886841, 5405.810721641233, 5823.359430462646, 5900.557458190653, 4495.595396414338, 5347.545458636059, 5539.002979463655, 5885.793997210163, 5912.3496415394275, 5542.445755424425, 5636.689982050944, 5864.853378665567, 5925.822225333247, 5929.911051334234, 5282.8943421132135, 5440.836774896601, 5614.820887613483, 5683.60214784961, 5717.342505611908, 4869.366982292421, 5217.2434996925995, 5343.0, 5590.413006634245, 5631.774729010794, 5151.562117220078, 5335.439778823323, 5673.461021202979, 5750.482456578928, 5805.680687562224, 3832.73170878047, 3904.570497245244, 4317.568243175658, 4515.5484451554585, 4517.864464066083, 4834.371531700997, 5250.18622113573, 5421.647592906448, 5461.754221059982, 5675.517581005661, 4660.883477913079, 4713.62291016711, 5403.918941215964, 5498.45015498447, 5520.171974203901, 4905.975470122769, 5482.5613950883035, 5529.755804943856, 5557.749901254534, 5565.248691426606, 4451.063787252556, 5189.558887494454, 5194.246834209094, 5302.28419163408, 5368.382635996911, 4852.781624826962, 4904.125740664835, 5529.723513824373, 5535.418781027934, 5541.251930989426, 4397.824087036611, 4926.679765815211, 4929.679570828028, 5429.457054294539, 5433.483819037185], "value": 4186.052580027948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.271015433795, 719.6042176802757, 756.9115235816578, 768.1089935674619, 857.8541647919851, 15454.381824727012, 15993.84006159938, 15994.920025399857, 16021.519354419372, 16048.27782749776, 14414.918881083935, 14446.494372696958, 14481.131132132054, 14515.129092254472, 14618.415263389452, 908.5411867007168, 930.1117432851644, 931.6040682709855, 943.3160958305208, 943.688582767685, 942.7407462947675, 943.7546237978141, 943.9197668198211, 944.3578366710634, 944.6174299408716, 990.8662330585387, 991.3407583956661, 993.101243374747, 994.6966175316526, 995.0397866059251, 987.2990176974286, 988.7528117970471, 989.1345073061071, 989.6783545347755, 990.0495524296684, 728.155339805828, 728.4245446097576, 728.5701436152696, 728.7085165933617, 730.0, 15774.132422716746, 16052.59868503285, 16096.195190240558, 16227.350905963747, 16472.176391180394, 14013.0, 14146.29268536569, 14203.857961420461, 14269.714605707932, 14310.71378572433, 11135.554577816878, 11442.942785286103, 11715.7071073223, 11861.229020113666, 12355.196912200678, 3489.7289352553184, 3635.800030998294, 3725.2921944830396, 3806.505154329947, 3846.8653597123966, 112130.0, 116548.8345116555, 117843.0, 118798.0, 120377.39811300975, 10479.94760026195, 10678.946605266923, 10941.12471002318, 11237.83143252852, 11276.774464510663, 22855.657165142537, 23320.53358932812, 23344.182953596544, 23425.76574234236, 23493.0, 7667.233276672288, 7672.80817979555, 7787.727429539939, 7824.921750782533, 7960.164182760843, 3868.3037053330672, 4000.6399424051974, 4029.2658212758556, 4071.6742660587674, 4091.590840915944, 3409.2670075933793, 3472.73954453417, 3492.7904325740537, 3496.8251587420527, 3500.6674365935196, 614.4899733221415, 622.1103821535248, 622.1197006236216, 636.7707625254905, 638.581728967527, 620.965846878417, 629.9275583307979, 667.9298673639198, 671.9832004199836, 678.504691575153, 9564.196698384212, 9936.850947235796, 10861.945690271656, 11290.54837806495, 11701.180917335705, 566.6143307858775, 572.1160806553884, 621.4996927473337, 656.8719099775593, 709.2552819539463, 4805.591524720368, 4983.9252411213865, 4991.226359914219, 4995.950040499549, 5031.4213865405945, 77175.68472945821, 93882.06117938732, 97251.0, 100181.0, 103309.0, 87368.0, 87539.0, 89372.0, 89770.55114724385, 90366.09633903709, 76857.84713229306, 77108.61445692848, 78693.0, 79680.60159699165, 79747.0, 8672.523011234443, 8695.434796738191, 8709.433886797338, 8727.825443491221, 8764.07190418107, 38886.80556597199, 47777.522224778695, 47957.52042479531, 48247.75876120597, 48902.10978902081, 68248.0, 69275.0, 69505.30494694988, 70797.29202707906, 72468.0, 12237.632871013884, 12746.10777245584, 12812.974962003203, 12953.417096230503, 13185.406656700663, 13899.235542045284, 13913.51302704441, 14654.780178297548, 14978.850211497745, 15408.691826163638, 13127.474901003852, 13904.443822247402, 13972.161670299814, 14026.859731402556, 14129.788053179416, 12949.296363799247, 13638.522651707142, 13784.931075344559, 13825.585232443043, 13992.860071399564, 12834.422450989541, 13682.726345472836, 13724.862751372359, 13839.377228024561, 14016.159030458206, 9293.25653947669, 9452.243820494206, 9767.755806104904, 9859.950700246452, 9888.357256778287, 9076.954615226881, 9357.251419886257, 10319.638812641522, 10399.428031458343, 11079.12952542217], "value": 7556.989729236273, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 114.0, 116.0, 115.0, 117.0, 116.0, 116.0, 113.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 107.0, 144.0, 135.0, 110.0, 91.0, 129.0, 161.0, 137.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 183.0, 189.0, 184.0, 185.0, 185.0, 186.0, 185.0, 186.0], "value": 185.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 61.0, 92.0, 64.0, 59.0, 64.0, 61.0, 76.0, 61.0], "value": 68.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 86.0, 69.0, 70.0, 67.0, 82.0, 68.0, 68.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 91.0, 91.0, 134.0, 133.0, 92.0, 90.0, 90.0, 91.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 100.0, 97.0, 98.0, 123.0, 100.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 84.0, 86.0, 85.0, 86.0, 96.0, 127.0, 129.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 67.0, 66.0, 61.0, 58.0, 58.0, 58.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 84.0, 85.0, 93.0, 98.0, 104.0, 75.0, 82.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 137.0, 134.0, 133.0, 137.0, 140.0, 127.0, 193.0, 145.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 215.0, 163.0, 164.0, 164.0, 161.0, 161.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 79.0, 78.0, 80.0, 79.0, 64.0, 63.0, 64.0], "value": 70.4, "unit": "score"}]}]} 02:30:50 INFO - Return code: 0 02:30:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:50 ERROR - # TBPL SUCCESS # 02:30:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:30:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:30:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:30:50 INFO - 2017-03-30 02:30:50.885 screenresolution[1659:10152] starting screenresolution argv=screenresolution get 02:30:50 INFO - 2017-03-30 02:30:50.888 screenresolution[1659:10152] Display 0: 1600x1200x32@60 02:30:50 INFO - 2017-03-30 02:30:50.894 screenresolution[1660:10155] starting screenresolution argv=screenresolution list 02:30:50 INFO - Available Modes on Display 0 02:30:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:30:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:30:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:30:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:30:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:30:51 INFO - Intel Iris: 02:30:51 INFO - Chipset Model: Intel Iris 02:30:51 INFO - Type: GPU 02:30:51 INFO - Bus: Built-In 02:30:51 INFO - VRAM (Dynamic, Max): 1536 MB 02:30:51 INFO - Vendor: Intel (0x8086) 02:30:51 INFO - Device ID: 0x0a2e 02:30:51 INFO - Revision ID: 0x0009 02:30:51 INFO - Displays: 02:30:51 INFO - Display: 02:30:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:30:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:30:51 INFO - Display Serial Number: 1600x1200 60 02:30:51 INFO - Main Display: Yes 02:30:51 INFO - Mirror: Off 02:30:51 INFO - Online: Yes 02:30:51 INFO - Rotation: Supported 02:30:51 INFO - Return code: 0 02:30:51 INFO - Running post-action listener: _resource_record_post_action 02:30:51 INFO - [mozharness: 2017-03-30 09:30:51.129195Z] Finished run-tests step (success) 02:30:51 INFO - Running post-run listener: _resource_record_post_run 02:30:51 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 32418816; Write bytes: 510316544; Read time: 309; Write time: 1896 02:30:51 INFO - TinderboxPrint: CPU usage
54.0% 02:30:51 INFO - TinderboxPrint: I/O read bytes / time
32,418,816 / 309 02:30:51 INFO - TinderboxPrint: I/O write bytes / time
510,316,544 / 1,896 02:30:51 INFO - TinderboxPrint: CPU idle
2,215.1 (46.0%) 02:30:51 INFO - TinderboxPrint: CPU system
966.2 (20.1%) 02:30:51 INFO - TinderboxPrint: CPU user
1,632.4 (33.9%) 02:30:51 INFO - TinderboxPrint: Swap in / out
236,396,544 / 0 02:30:51 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 196964864; Write bytes: 191158272; Read time: 15690; Write time: 462 02:30:51 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 31489024; Write bytes: 299386880; Read time: 291; Write time: 1377 02:30:51 INFO - Running post-run listener: _upload_blobber_files 02:30:51 INFO - Blob upload gear active. 02:30:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:51 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 02:30:51 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'] 02:30:51 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 02:30:52 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:53 INFO - (blobuploader) - INFO - Done attempting. 02:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:54 INFO - (blobuploader) - INFO - Done attempting. 02:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:55 INFO - (blobuploader) - INFO - Done attempting. 02:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:57 INFO - (blobuploader) - INFO - Done attempting. 02:30:57 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:57 INFO - Return code: 0 02:30:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d44e115d849f5c7fcfeabb3f4260c695635bb2c00015b0ee88add648b4f6142e82570247c09678b80667118f4a2a7f4cfb80fefa6a177131098785840384690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08414f3cf5410abf86d7fb81a3670a02ecedf1d3c162efabaa5edd91bf0e56cb7fea1b9d98b64bce0edfc1a8e0283c57eb8d25a385efffa6db322eaea9580194", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f6add0507735868651a4ddbba61c9cf7f46c0cd087c03fa630a95a6633efd410768958151abad24a9d8246c34556e222dd2166ece52e8bccb4bd9b3f692195", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad39301b6dea9462441d0aad15cba63a1c3ee3ed9f4222551da3de31b0ccba952bb7f09b770bf77455dd006e60f05e4a40ca205a59af1224b84a02462bdfce"} 02:30:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:57 INFO - Contents: 02:30:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d44e115d849f5c7fcfeabb3f4260c695635bb2c00015b0ee88add648b4f6142e82570247c09678b80667118f4a2a7f4cfb80fefa6a177131098785840384690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08414f3cf5410abf86d7fb81a3670a02ecedf1d3c162efabaa5edd91bf0e56cb7fea1b9d98b64bce0edfc1a8e0283c57eb8d25a385efffa6db322eaea9580194", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f6add0507735868651a4ddbba61c9cf7f46c0cd087c03fa630a95a6633efd410768958151abad24a9d8246c34556e222dd2166ece52e8bccb4bd9b3f692195", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad39301b6dea9462441d0aad15cba63a1c3ee3ed9f4222551da3de31b0ccba952bb7f09b770bf77455dd006e60f05e4a40ca205a59af1224b84a02462bdfce"} 02:30:57 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:57 INFO - Copying logs to upload dir... 02:30:57 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1389.661410 ========= master_lag: 2.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 11 secs) (at 2017-03-30 02:30:59.557146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 02:30:59.563278) ========= 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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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/2d44e115d849f5c7fcfeabb3f4260c695635bb2c00015b0ee88add648b4f6142e82570247c09678b80667118f4a2a7f4cfb80fefa6a177131098785840384690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08414f3cf5410abf86d7fb81a3670a02ecedf1d3c162efabaa5edd91bf0e56cb7fea1b9d98b64bce0edfc1a8e0283c57eb8d25a385efffa6db322eaea9580194", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f6add0507735868651a4ddbba61c9cf7f46c0cd087c03fa630a95a6633efd410768958151abad24a9d8246c34556e222dd2166ece52e8bccb4bd9b3f692195", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad39301b6dea9462441d0aad15cba63a1c3ee3ed9f4222551da3de31b0ccba952bb7f09b770bf77455dd006e60f05e4a40ca205a59af1224b84a02462bdfce"} build_url:https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011106 build_url: 'https://queue.taskcluster.net/v1/task/cliBIH9eT96j4Xc6F6-D6w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d44e115d849f5c7fcfeabb3f4260c695635bb2c00015b0ee88add648b4f6142e82570247c09678b80667118f4a2a7f4cfb80fefa6a177131098785840384690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08414f3cf5410abf86d7fb81a3670a02ecedf1d3c162efabaa5edd91bf0e56cb7fea1b9d98b64bce0edfc1a8e0283c57eb8d25a385efffa6db322eaea9580194", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f6add0507735868651a4ddbba61c9cf7f46c0cd087c03fa630a95a6633efd410768958151abad24a9d8246c34556e222dd2166ece52e8bccb4bd9b3f692195", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad39301b6dea9462441d0aad15cba63a1c3ee3ed9f4222551da3de31b0ccba952bb7f09b770bf77455dd006e60f05e4a40ca205a59af1224b84a02462bdfce"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 02:30:59.600643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 02:30:59.601023) ========= 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.0zxHJoVbl4/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.gFkaZYmiTs/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.005201 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 02:30:59.650659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 02:30:59.651006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 02:30:59.651344) ========= ========= Total master_lag: 2.20 =========