builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0250 starttime: 1485230912.89 results: success (0) buildid: 20170123184343 builduid: 3c4cb1eba744465ca30c32564d6df9a7 revision: c491cc07665742cee31f47c59bf986b1bc2d08db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:32.892571) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:32.893055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:32.893332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:32.919325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:32.919633) ========= 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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-23 20:08:32-- 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% 54.3M=0s 2017-01-23 20:08:33 (54.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079212 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:33.025428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:33.025874) ========= 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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.023447 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:33.075288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 20:08:33.075825) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c491cc07665742cee31f47c59bf986b1bc2d08db --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c491cc07665742cee31f47c59bf986b1bc2d08db --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rkRHYpXxI6/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.OuiAm5SIGP/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-23 20:08:33,187 truncating revision to first 12 chars 2017-01-23 20:08:33,187 Setting DEBUG logging. 2017-01-23 20:08:33,187 attempt 1/10 2017-01-23 20:08:33,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c491cc076657?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 20:08:34,285 unpacking tar archive at: mozilla-central-c491cc076657/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392107 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 20:08:34.496079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:34.496520) ========= script_repo_revision: c491cc07665742cee31f47c59bf986b1bc2d08db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:34.496914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:34.497248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:08:34.516744) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-01-23 20:08:34.517043) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rkRHYpXxI6/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.OuiAm5SIGP/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:08:34 INFO - MultiFileLogger online at 20170123 20:08:34 in /builds/slave/test 20:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:34 INFO - {'append_to_log': False, 20:08:34 INFO - 'base_work_dir': '/builds/slave/test', 20:08:34 INFO - 'blob_upload_branch': 'Firefox', 20:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:34 INFO - 'branch': 'Firefox', 20:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:34 INFO - 'config_files': ('talos/mac_config.py',), 20:08:34 INFO - 'default_actions': ('clobber', 20:08:34 INFO - 'read-buildbot-config', 20:08:34 INFO - 'download-and-extract', 20:08:34 INFO - 'populate-webroot', 20:08:34 INFO - 'create-virtualenv', 20:08:34 INFO - 'install', 20:08:34 INFO - 'run-tests'), 20:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:34 INFO - 'download_minidump_stackwalk': True, 20:08:34 INFO - 'download_symbols': 'ondemand', 20:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:34 INFO - 'installer_path': 'installer.exe', 20:08:34 INFO - 'log_level': 'info', 20:08:34 INFO - 'log_name': 'talos', 20:08:34 INFO - 'log_to_console': True, 20:08:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:08:34 INFO - 'opt_config_files': (), 20:08:34 INFO - 'pip_index': False, 20:08:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:34 INFO - 'cmd': ('bash', 20:08:34 INFO - '-c', 20:08:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:34 INFO - 'enabled': True, 20:08:34 INFO - 'halt_on_failure': False, 20:08:34 INFO - 'name': 'check_screen_resolution'},), 20:08:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:34 INFO - 'cmd': ('bash', 20:08:34 INFO - '-c', 20:08:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:34 INFO - 'enabled': True, 20:08:34 INFO - 'halt_on_failure': False, 20:08:34 INFO - 'name': 'check_screen_resolution'},), 20:08:34 INFO - 'run_cmd_checks_enabled': True, 20:08:34 INFO - 'sps_profile': False, 20:08:34 INFO - 'sps_profile_interval': 0, 20:08:34 INFO - 'suite': 'dromaeojs', 20:08:34 INFO - 'system_bits': '32', 20:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:34 INFO - 'title': 't-yosemite-r7-0250', 20:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:34 INFO - 'use_talos_json': True, 20:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:34 INFO - 'work_dir': 'build'} 20:08:34 INFO - [mozharness: 2017-01-24 04:08:34.728588Z] Running clobber step. 20:08:34 INFO - Running pre-action listener: _resource_record_pre_action 20:08:34 INFO - Running main action method: clobber 20:08:34 INFO - rmtree: /builds/slave/test/build 20:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:37 INFO - Running post-action listener: _resource_record_post_action 20:08:37 INFO - [mozharness: 2017-01-24 04:08:37.019567Z] Finished clobber step (success) 20:08:37 INFO - [mozharness: 2017-01-24 04:08:37.019702Z] Running read-buildbot-config step. 20:08:37 INFO - Running pre-action listener: _resource_record_pre_action 20:08:37 INFO - Running main action method: read_buildbot_config 20:08:37 INFO - Using buildbot properties: 20:08:37 INFO - { 20:08:37 INFO - "project": "", 20:08:37 INFO - "product": "firefox", 20:08:37 INFO - "script_repo_revision": "production", 20:08:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 20:08:37 INFO - "repository": "", 20:08:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 20:08:37 INFO - "buildid": "20170123184343", 20:08:37 INFO - "pgo_build": "False", 20:08:37 INFO - "basedir": "/builds/slave/test", 20:08:37 INFO - "buildnumber": 35, 20:08:37 INFO - "slavename": "t-yosemite-r7-0250", 20:08:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:08:37 INFO - "platform": "yosemite_r7", 20:08:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:08:37 INFO - "branch": "mozilla-central", 20:08:37 INFO - "repo_path": "mozilla-central", 20:08:37 INFO - "revision": "c491cc07665742cee31f47c59bf986b1bc2d08db", 20:08:37 INFO - "stage_platform": "macosx64", 20:08:37 INFO - "builduid": "3c4cb1eba744465ca30c32564d6df9a7", 20:08:37 INFO - "slavebuilddir": "test" 20:08:37 INFO - } 20:08:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 20:08:37 INFO - Running post-action listener: _resource_record_post_action 20:08:37 INFO - [mozharness: 2017-01-24 04:08:37.023043Z] Finished read-buildbot-config step (success) 20:08:37 INFO - [mozharness: 2017-01-24 04:08:37.023178Z] Running download-and-extract step. 20:08:37 INFO - Running pre-action listener: _resource_record_pre_action 20:08:37 INFO - Running main action method: download_and_extract 20:08:37 INFO - mkdir: /builds/slave/test/build/tests 20:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:37 INFO - trying https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 20:08:37 INFO - Downloading https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 20:08:38 INFO - Downloaded 1199 bytes. 20:08:38 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:08:38 INFO - Using the following test package requirements: 20:08:38 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:08:38 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 20:08:38 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 20:08:38 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'jsshell-mac.zip'], 20:08:38 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 20:08:38 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:08:38 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 20:08:38 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 20:08:38 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 20:08:38 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:08:38 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 20:08:38 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:08:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:08:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:08:38 INFO - Fetch https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:08:42 INFO - Expected file size: 16351058 20:08:42 INFO - Obtained file size: 16351058 20:08:49 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:08:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:08:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:08:49 INFO - Fetch https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:08:51 INFO - Expected file size: 16351058 20:08:51 INFO - Obtained file size: 16351058 20:08:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 20:08:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:08:57 INFO - Fetch https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 20:08:58 INFO - Expected file size: 14403485 20:08:58 INFO - Obtained file size: 14403485 20:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:59 INFO - trying https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:08:59 INFO - Downloading https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 20:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 20:09:02 INFO - Downloaded 69976595 bytes. 20:09:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:09:02 INFO - mkdir: /builds/slave/test/properties 20:09:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:02 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:02 INFO - Contents: 20:09:02 INFO - build_url:https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:09:03 INFO - Running post-action listener: _resource_record_post_action 20:09:03 INFO - Running post-action listener: set_extra_try_arguments 20:09:03 INFO - [mozharness: 2017-01-24 04:09:03.144648Z] Finished download-and-extract step (success) 20:09:03 INFO - [mozharness: 2017-01-24 04:09:03.144769Z] Running populate-webroot step. 20:09:03 INFO - Running pre-action listener: _resource_record_pre_action 20:09:03 INFO - Running main action method: populate_webroot 20:09:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:03 INFO - '--tppagecycles', 20:09:03 INFO - '7'], 20:09:03 INFO - 'tests': ['tsvgm']}}, 20:09:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:09:03 INFO - 'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:09:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:09:03 INFO - 'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['damp', 'tps']}, 20:09:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:09:03 INFO - 'tests': ['damp', 'tps']}, 20:09:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['dromaeo_dom']}, 20:09:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['basic_compositor_video']}, 20:09:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:09:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['a11yr', 20:09:03 INFO - 'ts_paint', 20:09:03 INFO - 'tpaint', 20:09:03 INFO - 'sessionrestore', 20:09:03 INFO - 'sessionrestore_no_auto_restore', 20:09:03 INFO - 'tabpaint']}, 20:09:03 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:03 INFO - 'ts_paint', 20:09:03 INFO - 'tpaint', 20:09:03 INFO - 'sessionrestore', 20:09:03 INFO - 'sessionrestore_no_auto_restore', 20:09:03 INFO - 'tabpaint']}, 20:09:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:03 INFO - 'ts_paint', 20:09:03 INFO - 'tpaint', 20:09:03 INFO - 'sessionrestore', 20:09:03 INFO - 'sessionrestore_no_auto_restore', 20:09:03 INFO - 'tabpaint']}, 20:09:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:03 INFO - 'ts_paint', 20:09:03 INFO - 'tpaint', 20:09:03 INFO - 'sessionrestore', 20:09:03 INFO - 'sessionrestore_no_auto_restore', 20:09:03 INFO - 'tabpaint']}, 20:09:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['a11yr', 20:09:03 INFO - 'ts_paint', 20:09:03 INFO - 'tpaint', 20:09:03 INFO - 'sessionrestore', 20:09:03 INFO - 'sessionrestore_no_auto_restore', 20:09:03 INFO - 'tabpaint']}, 20:09:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['a11yr', 20:09:03 INFO - 'ts_paint', 20:09:03 INFO - 'tpaint', 20:09:03 INFO - 'sessionrestore', 20:09:03 INFO - 'sessionrestore_no_auto_restore', 20:09:03 INFO - 'tabpaint']}, 20:09:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['tsvgx', 20:09:03 INFO - 'tsvgr_opacity', 20:09:03 INFO - 'tart', 20:09:03 INFO - 'tscrollx', 20:09:03 INFO - 'cart', 20:09:03 INFO - 'tsvg_static']}, 20:09:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:03 INFO - 'tsvgr_opacity', 20:09:03 INFO - 'tart', 20:09:03 INFO - 'tscrollx', 20:09:03 INFO - 'cart', 20:09:03 INFO - 'tsvg_static']}, 20:09:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:09:03 INFO - 'talos_options': ['--disable-e10s'], 20:09:03 INFO - 'tests': ['tp5o']}, 20:09:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:09:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:09:03 INFO - 'talos_options': ['--disable-e10s', 20:09:03 INFO - '--xperf_path', 20:09:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:03 INFO - 'tests': ['tp5n']}, 20:09:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:09:03 INFO - 'talos_options': ['--xperf_path', 20:09:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:03 INFO - 'tests': ['tp5n']}}, 20:09:03 INFO - 'talos.zip': {'path': '', 20:09:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:03 INFO - Running post-action listener: _resource_record_post_action 20:09:03 INFO - [mozharness: 2017-01-24 04:09:03.163694Z] Finished populate-webroot step (success) 20:09:03 INFO - [mozharness: 2017-01-24 04:09:03.163827Z] Running create-virtualenv step. 20:09:03 INFO - Running pre-action listener: _resource_record_pre_action 20:09:03 INFO - Running main action method: create_virtualenv 20:09:03 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:03 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 20:09:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:03 INFO - Using real prefix '/tools/python27' 20:09:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:06 INFO - Installing pip.................done. 20:09:06 INFO - Return code: 0 20:09:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:09:07 INFO - Reading from file tmpfile_stdout 20:09:07 INFO - Output received: 20:09:07 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) 20:09:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:07 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 20:09:07 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 20:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:07 INFO - 'HOME': '/Users/cltbld', 20:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:07 INFO - 'LOGNAME': 'cltbld', 20:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:07 INFO - 'MOZ_NO_REMOTE': '1', 20:09:07 INFO - 'NO_EM_RESTART': '1', 20:09:07 INFO - 'PAGER': '/bin/cat', 20:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:07 INFO - 'PWD': '/builds/slave/test', 20:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:07 INFO - 'SHELL': '/bin/bash', 20:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:07 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:07 INFO - 'USER': 'cltbld', 20:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:07 INFO - 'XPC_FLAGS': '0x0', 20:09:07 INFO - 'XPC_SERVICE_NAME': '0', 20:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:07 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 20:09:07 INFO - Cleaning up... 20:09:07 INFO - Return code: 0 20:09:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:07 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 20:09:07 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 20:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:07 INFO - 'HOME': '/Users/cltbld', 20:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:07 INFO - 'LOGNAME': 'cltbld', 20:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:07 INFO - 'MOZ_NO_REMOTE': '1', 20:09:07 INFO - 'NO_EM_RESTART': '1', 20:09:07 INFO - 'PAGER': '/bin/cat', 20:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:07 INFO - 'PWD': '/builds/slave/test', 20:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:07 INFO - 'SHELL': '/bin/bash', 20:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:07 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:07 INFO - 'USER': 'cltbld', 20:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:07 INFO - 'XPC_FLAGS': '0x0', 20:09:07 INFO - 'XPC_SERVICE_NAME': '0', 20:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:07 INFO - Downloading/unpacking psutil>=3.1.1 20:09:07 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 20:09:07 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 20:09:07 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 20:09:07 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 20:09:07 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 20:09:07 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 20:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:11 INFO - Installing collected packages: psutil 20:09:11 INFO - Running setup.py install for psutil 20:09:11 INFO - building 'psutil._psutil_osx' extension 20:09:11 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 20:09:11 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 20:09:11 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 20:09:11 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 20:09:12 INFO - building 'psutil._psutil_posix' extension 20:09:12 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 20:09:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:09:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:09:12 INFO - ^ 20:09:12 INFO - 1 warning generated. 20:09:12 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 20:09:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:12 INFO - Successfully installed psutil 20:09:12 INFO - Cleaning up... 20:09:12 INFO - Return code: 0 20:09:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:12 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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:12 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 20:09:12 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 20:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:12 INFO - 'HOME': '/Users/cltbld', 20:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:12 INFO - 'LOGNAME': 'cltbld', 20:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:12 INFO - 'MOZ_NO_REMOTE': '1', 20:09:12 INFO - 'NO_EM_RESTART': '1', 20:09:12 INFO - 'PAGER': '/bin/cat', 20:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:12 INFO - 'PWD': '/builds/slave/test', 20:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:12 INFO - 'SHELL': '/bin/bash', 20:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:12 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:12 INFO - 'USER': 'cltbld', 20:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:12 INFO - 'XPC_FLAGS': '0x0', 20:09:12 INFO - 'XPC_SERVICE_NAME': '0', 20:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09:12 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 20:09:12 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 20:09:12 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 20:09:12 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 20:09:12 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 20:09:12 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 20:09:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:15 INFO - Installing collected packages: mozsystemmonitor 20:09:15 INFO - Running setup.py install for mozsystemmonitor 20:09:15 INFO - Successfully installed mozsystemmonitor 20:09:15 INFO - Cleaning up... 20:09:15 INFO - Return code: 0 20:09:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:15 INFO - 'HOME': '/Users/cltbld', 20:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:15 INFO - 'LOGNAME': 'cltbld', 20:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:15 INFO - 'MOZ_NO_REMOTE': '1', 20:09:15 INFO - 'NO_EM_RESTART': '1', 20:09:15 INFO - 'PAGER': '/bin/cat', 20:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:15 INFO - 'PWD': '/builds/slave/test', 20:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:15 INFO - 'SHELL': '/bin/bash', 20:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:15 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:15 INFO - 'USER': 'cltbld', 20:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:15 INFO - 'XPC_FLAGS': '0x0', 20:09:15 INFO - 'XPC_SERVICE_NAME': '0', 20:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:15 INFO - Downloading/unpacking jsonschema==2.5.1 20:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:18 INFO - warning: no files found matching '*.txt' 20:09:18 INFO - no previously-included directories found matching 'build' 20:09:18 INFO - no previously-included directories found matching 'dist' 20:09:18 INFO - no previously-included directories found matching '.git*' 20:09:18 INFO - Installing collected packages: jsonschema, functools32 20:09:18 INFO - Running setup.py install for functools32 20:09:18 INFO - warning: no files found matching '*.txt' 20:09:18 INFO - no previously-included directories found matching 'build' 20:09:18 INFO - no previously-included directories found matching 'dist' 20:09:18 INFO - no previously-included directories found matching '.git*' 20:09:19 INFO - Successfully installed jsonschema functools32 20:09:19 INFO - Cleaning up... 20:09:19 INFO - Return code: 0 20:09:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:09:19 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')]} 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:19 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')]} 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:19 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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:19 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 20:09:19 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 20:09:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:19 INFO - 'HOME': '/Users/cltbld', 20:09:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:19 INFO - 'LOGNAME': 'cltbld', 20:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:19 INFO - 'MOZ_NO_REMOTE': '1', 20:09:19 INFO - 'NO_EM_RESTART': '1', 20:09:19 INFO - 'PAGER': '/bin/cat', 20:09:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:19 INFO - 'PWD': '/builds/slave/test', 20:09:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:19 INFO - 'SHELL': '/bin/bash', 20:09:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:19 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:19 INFO - 'USER': 'cltbld', 20:09:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:19 INFO - 'XPC_FLAGS': '0x0', 20:09:19 INFO - 'XPC_SERVICE_NAME': '0', 20:09:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:09:19 INFO - Cleaning up... 20:09:19 INFO - Return code: 0 20:09:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:19 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')]} 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:19 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')]} 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:19 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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:19 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 20:09:19 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 20:09:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:19 INFO - 'HOME': '/Users/cltbld', 20:09:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:19 INFO - 'LOGNAME': 'cltbld', 20:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:19 INFO - 'MOZ_NO_REMOTE': '1', 20:09:19 INFO - 'NO_EM_RESTART': '1', 20:09:19 INFO - 'PAGER': '/bin/cat', 20:09:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:19 INFO - 'PWD': '/builds/slave/test', 20:09:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:19 INFO - 'SHELL': '/bin/bash', 20:09:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:19 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:19 INFO - 'USER': 'cltbld', 20:09:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:19 INFO - 'XPC_FLAGS': '0x0', 20:09:19 INFO - 'XPC_SERVICE_NAME': '0', 20:09:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:19 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:19 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 20:09:19 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 20:09:19 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 20:09:19 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 20:09:19 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 20:09:19 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 20:09:22 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:23 INFO - Downloading docopt-0.6.1.tar.gz 20:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:23 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:23 INFO - Running setup.py install for blobuploader 20:09:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:23 INFO - Running setup.py install for requests 20:09:24 INFO - Running setup.py install for docopt 20:09:24 INFO - Successfully installed blobuploader requests docopt 20:09:24 INFO - Cleaning up... 20:09:24 INFO - Return code: 0 20:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09: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 20:09: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 20:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:24 INFO - 'HOME': '/Users/cltbld', 20:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:24 INFO - 'LOGNAME': 'cltbld', 20:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:24 INFO - 'MOZ_NO_REMOTE': '1', 20:09:24 INFO - 'NO_EM_RESTART': '1', 20:09:24 INFO - 'PAGER': '/bin/cat', 20:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:24 INFO - 'PWD': '/builds/slave/test', 20:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:24 INFO - 'SHELL': '/bin/bash', 20:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:24 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:24 INFO - 'USER': 'cltbld', 20:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:24 INFO - 'XPC_FLAGS': '0x0', 20:09:24 INFO - 'XPC_SERVICE_NAME': '0', 20:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:24 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-2nfcJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:24 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-96wzsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:24 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-VELB90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-V6uwi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-MkZuhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-gWiX1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-phM5XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-DtCXVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-E7fwDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-A53L9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-g4ZdL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-VLjkde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:25 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-QlKnGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-eUVEWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-2WH5dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-76G_wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-pw77Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:26 INFO - Running setup.py install for manifestparser 20:09:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:26 INFO - Running setup.py install for mozcrash 20:09:26 INFO - Running setup.py install for mozdebug 20:09:26 INFO - Running setup.py install for mozdevice 20:09:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozfile 20:09:27 INFO - Running setup.py install for mozhttpd 20:09:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozinfo 20:09:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozInstall 20:09:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozleak 20:09:27 INFO - Running setup.py install for mozlog 20:09:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for moznetwork 20:09:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:28 INFO - Running setup.py install for mozprocess 20:09:28 INFO - Running setup.py install for mozprofile 20:09:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:28 INFO - Running setup.py install for mozrunner 20:09:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:28 INFO - Running setup.py install for mozscreenshot 20:09:28 INFO - Running setup.py install for moztest 20:09:28 INFO - Running setup.py install for mozversion 20:09:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:29 INFO - Cleaning up... 20:09:29 INFO - Return code: 0 20:09:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09: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 20:09: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 20:09:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:29 INFO - 'HOME': '/Users/cltbld', 20:09:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:29 INFO - 'LOGNAME': 'cltbld', 20:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:29 INFO - 'MOZ_NO_REMOTE': '1', 20:09:29 INFO - 'NO_EM_RESTART': '1', 20:09:29 INFO - 'PAGER': '/bin/cat', 20:09:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:29 INFO - 'PWD': '/builds/slave/test', 20:09:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:29 INFO - 'SHELL': '/bin/bash', 20:09:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:29 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:29 INFO - 'USER': 'cltbld', 20:09:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:29 INFO - 'XPC_FLAGS': '0x0', 20:09:29 INFO - 'XPC_SERVICE_NAME': '0', 20:09:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:29 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-R43TN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09: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)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:29 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-FfDT6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09: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)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:29 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-VxuM_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:30 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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-bNtOFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:30 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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-5crvAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:30 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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Pz2Ytq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:30 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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ngWNhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09: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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-GR2qTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09: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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-uewSDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09: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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-rVaqrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09: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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-rvp7vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09: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)) 20:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-iayyAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-T7doYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-YSjJt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-yKJkXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-bdZQFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-IQ7pnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09: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)) 20:09: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)) 20:09: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)) 20:09: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)) 20:09: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)) 20:09: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)) 20:09:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:34 INFO - Downloading blessings-1.6.tar.gz 20:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:34 INFO - Installing collected packages: blessings 20:09:34 INFO - Running setup.py install for blessings 20:09:34 INFO - Successfully installed blessings 20:09:34 INFO - Cleaning up... 20:09:34 INFO - Return code: 0 20:09:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:35 INFO - Reading from file tmpfile_stdout 20:09:35 INFO - Current package versions: 20:09:35 INFO - blessings == 1.6 20:09:35 INFO - blobuploader == 1.2.4 20:09:35 INFO - docopt == 0.6.1 20:09:35 INFO - functools32 == 3.2.3-2 20:09:35 INFO - jsonschema == 2.5.1 20:09:35 INFO - manifestparser == 1.1 20:09:35 INFO - mozInstall == 1.12 20:09:35 INFO - mozcrash == 1.0 20:09:35 INFO - mozdebug == 0.1 20:09:35 INFO - mozdevice == 0.49 20:09:35 INFO - mozfile == 1.2 20:09:35 INFO - mozhttpd == 0.7 20:09:35 INFO - mozinfo == 0.9 20:09:35 INFO - mozleak == 0.1 20:09:35 INFO - mozlog == 3.4 20:09:35 INFO - moznetwork == 0.27 20:09:35 INFO - mozprocess == 0.24 20:09:35 INFO - mozprofile == 0.28 20:09:35 INFO - mozrunner == 6.13 20:09:35 INFO - mozscreenshot == 0.1 20:09:35 INFO - mozsystemmonitor == 0.3 20:09:35 INFO - moztest == 0.8 20:09:35 INFO - mozversion == 1.4 20:09:35 INFO - psutil == 3.1.1 20:09:35 INFO - requests == 1.2.3 20:09:35 INFO - wsgiref == 0.1.2 20:09:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:35 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')]} 20:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:35 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')]} 20:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:35 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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:35 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 20:09:35 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 20:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:35 INFO - 'HOME': '/Users/cltbld', 20:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:35 INFO - 'LOGNAME': 'cltbld', 20:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:35 INFO - 'MOZ_NO_REMOTE': '1', 20:09:35 INFO - 'NO_EM_RESTART': '1', 20:09:35 INFO - 'PAGER': '/bin/cat', 20:09:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:35 INFO - 'PWD': '/builds/slave/test', 20:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:35 INFO - 'SHELL': '/bin/bash', 20:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:35 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:35 INFO - 'USER': 'cltbld', 20:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:35 INFO - 'XPC_FLAGS': '0x0', 20:09:35 INFO - 'XPC_SERVICE_NAME': '0', 20:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 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)) 20:09:35 INFO - Cleaning up... 20:09:35 INFO - Return code: 0 20:09:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:35 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')]} 20:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:35 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')]} 20:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:35 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 0x10c4bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdc2da0720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, '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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 20:09:35 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 20:09:35 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 20:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:35 INFO - 'HOME': '/Users/cltbld', 20:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:35 INFO - 'LOGNAME': 'cltbld', 20:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:35 INFO - 'MOZ_NO_REMOTE': '1', 20:09:35 INFO - 'NO_EM_RESTART': '1', 20:09:35 INFO - 'PAGER': '/bin/cat', 20:09:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:35 INFO - 'PWD': '/builds/slave/test', 20:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:35 INFO - 'SHELL': '/bin/bash', 20:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:35 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:35 INFO - 'USER': 'cltbld', 20:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:35 INFO - 'XPC_FLAGS': '0x0', 20:09:35 INFO - 'XPC_SERVICE_NAME': '0', 20:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:09:35 INFO - Cleaning up... 20:09:35 INFO - Return code: 0 20:09:35 INFO - Running post-action listener: _resource_record_post_action 20:09:35 INFO - Running post-action listener: _start_resource_monitoring 20:09:35 INFO - Starting resource monitoring. 20:09:35 INFO - [mozharness: 2017-01-24 04:09:35.644463Z] Finished create-virtualenv step (success) 20:09:35 INFO - [mozharness: 2017-01-24 04:09:35.645399Z] Running install step. 20:09:35 INFO - Running pre-action listener: _resource_record_pre_action 20:09:35 INFO - Running main action method: install 20:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:35 INFO - Reading from file tmpfile_stdout 20:09:35 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:36 INFO - Reading from file tmpfile_stdout 20:09:36 INFO - Output received: 20:09:36 INFO - Usage: mozinstall [options] installer 20:09:36 INFO - Options: 20:09:36 INFO - -h, --help show this help message and exit 20:09:36 INFO - -d DEST, --destination=DEST 20:09:36 INFO - Directory to install application into. [default: 20:09:36 INFO - "/builds/slave/test"] 20:09:36 INFO - --app=APP Application being installed. [default: firefox] 20:09:36 INFO - mkdir: /builds/slave/test/build/application 20:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:09:58 INFO - Reading from file tmpfile_stdout 20:09:58 INFO - Output received: 20:09:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:09:58 INFO - Running post-action listener: _resource_record_post_action 20:09:58 INFO - [mozharness: 2017-01-24 04:09:58.121766Z] Finished install step (success) 20:09:58 INFO - [mozharness: 2017-01-24 04:09:58.121928Z] Running run-tests step. 20:09:58 INFO - Running pre-action listener: _resource_record_pre_action 20:09:58 INFO - Running main action method: run_tests 20:09:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:58 INFO - 2017-01-23 20:09:58.136 screenresolution[1618:7293] starting screenresolution argv=screenresolution get 20:09:58 INFO - 2017-01-23 20:09:58.139 screenresolution[1618:7293] Display 0: 1600x1200x32@60 20:09:58 INFO - 2017-01-23 20:09:58.144 screenresolution[1619:7296] starting screenresolution argv=screenresolution list 20:09:58 INFO - Available Modes on Display 0 20:09:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:58 INFO - Intel Iris: 20:09:58 INFO - Chipset Model: Intel Iris 20:09:58 INFO - Type: GPU 20:09:58 INFO - Bus: Built-In 20:09:58 INFO - VRAM (Dynamic, Max): 1536 MB 20:09:58 INFO - Vendor: Intel (0x8086) 20:09:58 INFO - Device ID: 0x0a2e 20:09:58 INFO - Revision ID: 0x0009 20:09:58 INFO - Displays: 20:09:58 INFO - Display: 20:09:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:58 INFO - Display Serial Number: 1600x1200 60 20:09:58 INFO - Main Display: Yes 20:09:58 INFO - Mirror: Off 20:09:58 INFO - Online: Yes 20:09:58 INFO - Rotation: Supported 20:09:58 INFO - Return code: 0 20:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:58 INFO - Python 2.7.3 20:09:58 INFO - Return code: 0 20:09:58 INFO - grabbing minidump binary from tooltool 20:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:58 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 0x10c29bd30>, '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 0x10c1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c290be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:58 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 20:09:58 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 20:09:58 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 20:09:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:58 INFO - Return code: 0 20:09:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:09:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:09:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 20:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0250 --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 20:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkRHYpXxI6/Render', 20:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:58 INFO - 'HOME': '/Users/cltbld', 20:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:58 INFO - 'LOGNAME': 'cltbld', 20:09:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:58 INFO - 'MOZ_NO_REMOTE': '1', 20:09:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:58 INFO - 'NO_EM_RESTART': '1', 20:09:58 INFO - 'PAGER': '/bin/cat', 20:09:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:58 INFO - 'PWD': '/builds/slave/test', 20:09:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:58 INFO - 'SHELL': '/bin/bash', 20:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OuiAm5SIGP/Listeners', 20:09:58 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 20:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:58 INFO - 'USER': 'cltbld', 20:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:58 INFO - 'XPC_FLAGS': '0x0', 20:09:58 INFO - 'XPC_SERVICE_NAME': '0', 20:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 20:09:58 INFO - mozversion application_buildid: 20170123184343 20:09:58 INFO - mozversion application_changeset: c491cc07665742cee31f47c59bf986b1bc2d08db 20:09:58 INFO - mozversion application_display_name: Nightly 20:09:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:58 INFO - mozversion application_name: Firefox 20:09:58 INFO - mozversion application_remotingname: firefox 20:09:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:09:58 INFO - mozversion application_vendor: Mozilla 20:09:58 INFO - mozversion application_version: 54.0a1 20:09:58 INFO - mozversion platform_buildid: 20170123184343 20:09:58 INFO - mozversion platform_changeset: c491cc07665742cee31f47c59bf986b1bc2d08db 20:09:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:09:58 INFO - mozversion platform_version: 54.0a1 20:09:58 INFO - using testdate: 1485230998 20:09:58 INFO - actual date: 1485230998 20:09:58 INFO - starting webserver on 'localhost:49237' 20:09:58 INFO - SUITE-START | Running 2 tests 20:09:58 INFO - TEST-START | dromaeo_css 20:09:58 INFO - operating with platform_type : mac_ 20:09:58 INFO - Initialising browser for dromaeo_css test... 20:09:58 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpGAtlqY/profile http://localhost:49237/getInfo.html) 20:10:01 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 20:10:01 INFO - PROCESS | 1629 | colorDepth:24 20:10:01 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 20:10:01 INFO - PROCESS | 1629 | __metrics 20:10:01 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 20:10:01 INFO - PROCESS | 1629 | 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" 20:10:01 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:02 INFO - TEST-INFO | 1629: exit 0 20:10:02 INFO - Browser initialized. 20:10:02 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:02 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpGAtlqY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:14 INFO - PROCESS | 1631 | RSS: Main: 236240896 20:10:14 INFO - PROCESS | 1631 | 20:13:17 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 20:13:19 INFO - PROCESS | 1631 | RSS: Main: 383180800 20:13:19 INFO - PROCESS | 1631 | 20:15:04 INFO - PROCESS | 1631 | ************************* 20:15:04 INFO - PROCESS | 1631 | A coding exception was thrown and uncaught in a Task. 20:15:04 INFO - PROCESS | 1631 | 20:15:04 ERROR - PROCESS | 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:15:04 INFO - PROCESS | 1631 | Full stack: 20:15:04 INFO - PROCESS | 1631 | ************************* 20:16:22 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 20:16:22 INFO - PROCESS | 1631 | RSS: Main: 368640000 20:16:22 INFO - PROCESS | 1631 | 20:19:25 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 20:19:25 INFO - PROCESS | 1631 | RSS: Main: 339083264 20:19:25 INFO - PROCESS | 1631 | 20:22:28 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 20:22:28 INFO - PROCESS | 1631 | RSS: Main: 338694144 20:22:28 INFO - PROCESS | 1631 | 20:25:32 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 20:25:33 INFO - PROCESS | 1631 | RSS: Main: 327589888 20:25:33 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 20:28:36 INFO - PROCESS | 1631 | RSS: Main: 552476672 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | __start_tp_report 20:28:36 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 20:28:36 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 20:28:36 INFO - PROCESS | 1631 | |i|pagename|runs| 20:28:36 INFO - PROCESS | 1631 | |0;dojo.html;3375.510550970108;3377.98311008445;3388.796672199667;3395.1512121969517;3420.43562812136;4279.48646162461;5704.942950570493;5708.65748055117;5754.280714910637;5787.536997040237;5718.370979192296;5720.427957204278;5753.367129615739;5797.420257974211;5835.124731290298;5190.662606930557;5194.142966410538;5229.398619158807;5262.02652509287;5285.497877701631;4386.583274588909;4453.51011388747;5348.866278343034;5366.597505187126;5368.221607866857;5191.584673226171;5210.895782084337;5304.549113325372;5324.680519168863;5326.600504962104;4640.721556706575;5230.8692282692855;5255;5260.842174734764;5280.287161233223;3802.8478860845535;5188.11801993662;5234.555062819665;5239.449857764918;5247.39654939683;5651.18057881609;5776.075827867563;5793.710314484259;5804.361520232771;5824.0390335594575;6183.165272688175;6256.343083976162;6283.560150789401;6288.654124023177;6309.179806625109;6300.716467758962;6338.904916426257;6381.585196962183;6382.744690212386;6392.041193820917;5918.940810591882;5926.7252145590455;5927.229460170151;5931.3178984417345;5941.732622032019;6221.5333849961435;6294.874102518015;6308.148399966038;6328.335524769925;6351.491880649537;6204.224471941007;6271.184745982993;6279.372062793684;6284.528660350492;6286.214223222098;6207.534434917399;6360.840978975562;6367.204099487564;6375.808725738235;6382.585131966407;6120.873812997669;6127.078295984317;6164.537659675542;6172.351903050205;6249.937500625027;6264.655443950626;6267.811965641038;6270.467010304175;6282.026285925689;6283.246010478681;4964.982178653368;4973.079980203674;4973.8010479581135;4978.975105124524;5011.699298042129;4329.242382583036;4349.652027837766;4398.8020539075815;4477.440319960005;4485.955140448554;5762;5771.192033115283;5774.653520788682;5805.535557155417;5870.5890587659305;6317.952995144681;6349.746010159542;6370.522210834206;6380.361963803675;6385.521085918482;5679.318481782213;5777.248957635565;5787.363390027093;5813.7383817728305;5860.882782344414;5462.672239665632;5488.25908502355;5507.284053073155;5518.420565840609;5519.9448005520235;6398.9040164397575;6402.327755585597;6410.294867564471;6412.711427985659;6455.870882582228;6359.236891573041;6363.236411630634;6365.204349456318;6367.713452894538;6382.32985536512;6231.22109736283;6298.307186209605;6306.9684651576445;6356.173697419306;6358.682065896779;6308.211473565804;6313.305536390902;6317.7157027932935;6332.366763323631;6341.936580634135;4952.504749525163;6354.142190804182;6366.713497892699;6371.522135839923;6382.106505089198;6040.607360521552;6066.545009124245;6070;6151.046587778901;6249.218847644044;6029.638221706711;6107.603005804608;6113.5979309659515;6143.818944274897;6145.84635384119;5090.803661139703;5429;5831.1544826000845;5934.169216309634;5935.673537955454;5580.35825880029;6055.061465472859;6102.337773232528;6122.825106970096;6137.6931153441255;6015.759369625166;6019.157317975574;6024.337322894566;6052.03167493199;6060.030395136757 20:28:36 INFO - PROCESS | 1631 | |1;ext.html;448.04566273836724;448.9528599497052;450.28854410032153;490.3209055458191;502.1588838695185;31384.529232061508;40834.387484187726;42872.78563607185;42943.14113717728;43011.56988430115;44334.89162770932;44709.32936005962;44741.32888006682;44876.3268550972;44950.550494495044;9308.953455232715;9383.343165978384;9477.81044379112;9517.143457088861;9524.999875013127;8447.324214062892;8636.740897773077;9381.95309023454;11342.43287835609;11606;11502.482388292505;11549.826752598718;11560;11576.95807377336;11602.187846850724;11436;11486.310821350746;11504.712382190428;11527.942360288187;11528.077753779677;8319.66721331146;8534.402591818574;11103.278286911405;11327.716807079807;11338.489767960462;41763.7911810442;41967.790161049306;42015.789921050506;42188.73433796991;42249.57750422487;4011.83952641894;4023.8189281482405;4028.4561584186054;4029.6977726670325;4059.188162367538;30084.79660813565;30706.53940190899;30955.999960261983;31139.688603113904;31473.37053258922;3145.3552021835467;3206.4388731971812;3249.707526322619;3308.669133086696;3355.8825441109443;456712;458252.7087364542;458828;460812;461811;62426;62648;62861.68569157125;62950.37049629536;62958;67373;67485.6625716878;67495.3250467489;67671;67799.32200678029;16213.837861621232;16427.58931026734;16432.589185270463;16443.917780411022;16475.258613362428;12590.622281331574;12615.621531354074;12633.2420054797;12637.925776308934;12639.052071094704;15544.76682849758;15947.252395687005;15949.006374203225;16305.918470407572;16343.91828040876;6677.165354330708;6699.598024118569;7652.961735191288;7732.9613351934;7778.49439786412;841.9223394055618;869.2567854484325;887.316766090107;902.1880307723102;906.9047749986156;26717.465650686878;30200.79196832146;30248.54627180594;30856.845715771728;30896.69103308983;1049.7952899184738;1053.131166787388;1092.852464917226;1105.287089827073;1180.6340034589305;15625.765613515807;15817.209139542976;15992.281312176958;16011.679766404606;16492.17539123039;573626;579503.1024844849;579710;580031;580275;61113;61351.38648613546;61388;61466;61501.69249153815;1234.370471059766;1413.5264686330195;1445.28458413082;1455.51240334487;1463.8316593591874;26017.739822601532;29647.258818528848;29732.554011689408;30502.389952201276;30574.388512230074;52414.47585524096;52781.73609132083;52878.4712152889;52913.47086529085;53121;484343.5782821063;495957;498246;500571;501898;40288.79855600703;40945;41045.58954410537;41252.58747412488;41273.79363103165;44007;45808.312875306234;46181.30728039149;46852.29721554248;46888.59334219979;38620.420693690176;38633.80683096567;39056.71138443159;39254.80372598119;39903.2019359617;33803;38456;38961.86546015038;39225.019374514726;39956.80021599874;37224;38204.23591528098;38269;38495.84512464631;38527.8441646751;27121.49737521084;28210.71789282081;32807.83596082004;34283.828580856934;34366;24433.51132977366;24753.752462475146;25227.605875373018;25300.620490692287;25424 20:28:36 INFO - PROCESS | 1631 | |2;jquery.html;333.65800054943685;366.3095065800964;386.43580372655936;397.6736093850971;419.25372836351306;14800.333984970675;15074.170920599376;17114.914425427873;20335.28826491073;20748.688769668468;20626.793732062673;21182.364529064154;21248.4687882803;21422;21574.568508629818;5271.971965466735;5795.217645617851;5888.941110588904;6146.877062458748;6159.3224745277985;4206.831726730927;5947.345791962881;6038.184845045928;6042.486388656969;6062.4543791058795;4372.715773474714;6256;6530.673466326689;6570.375814297634;6653.301403352651;5694.202811606378;6295.653739044351;6626.436752875988;6668.699908504129;6702.698378572976;5788.6816225107605;5808.186853840466;5808.535317174658;5814.767409303623;5815.505682017034;25707.871460642764;25803.870980645166;26055.609165862526;26078.73921260782;26109.738902611112;2786.233785708926;2787.1359878437747;2802.299425143714;2807.368342123006;2812.9578056329174;11991.880081199164;15574.454894078654;15737.606559835982;16064.59838504035;16171.91914040434;1570.9082187879428;1766.3464518128246;1805.3771448850125;1808.5388226002417;1809.5114319133893;131270;133519;134119;135119;136001.3199934004;9152.039035901134;11002.214036893976;11081.390523521284;11170.218084734153;11360.772784544262;14001.719965600834;14005.369758360897;14006;14023.78964315536;14049.578512644637;8312.625931833081;8392.4544904581;8468.237858592756;8482.830343393098;8634.78413039679;7033.402160816286;8410.78973025667;8445.408821382443;8578.528180950108;8592;5666.603337766399;6735.360140786617;6891.104156459628;6911.205211400653;6934.861302773917;1870.7474490943548;1904.095554611576;1904.6571617108775;1907.5421898744478;1909.5989842133308;1037.1754455208127;1040.861030582161;1045.9581616735397;1061.310148403544;1101.5373543111912;22427.43931401728;22727.659085113737;22733.43166420853;22834.657480137477;22867.656985145237;1065.737101534684;1070.6466865934224;1075.978480430387;1103.9282446641103;1107.6732363952653;11616.303021818718;11894.464749086139;11915.16593838423;11925;11945.044396448264;659148;664577;675937;687009;695917;93477.53261233651;101191.31534612147;133880;136182.8290302585;139713.3014334922;973.6835528453281;977.5454413697664;1039.719275795531;1042.2183362478142;1046.9528871200814;16497.587560311087;17287.13564321804;18472.891626502453;19960.107639735434;20028.499287517345;56918.86162276814;57571.42428575828;57633.13550296665;58127.54681133005;58640.413595865204;80689.3862122766;81110;81712.59143704243;82075;82102.3579528418;6977.895331570132;7736;8254.917450825415;8382.203690649378;8430.662773488992;11388.601398950997;12645.557405490763;12926.224426534438;12954.417051232529;13365.799513007507;10615;10854.620088296871;10999.120070394189;11116.833247501456;11336.489857956576;9410.623575056921;10759.30064545802;10972.561097556008;11180.217384782987;11408.885911140782;11141.331520108819;11409.315441073562;11457.026152777107;11535.019523340274;11566.363849988331;8312;8354.665813367397;8370.539620320696;8498.957505212435;8501.659933602587;8393.83212335762;10925.235233533895;11224.214304998899;11343.432828358715;11376.488058037574 20:28:36 INFO - PROCESS | 1631 | |3;mootools.html;1218.6587755428484;1412.964675883103;1420.8721215090645;1421.905133047554;1441.6612096157405;7974.68101275949;8312.127226641207;8327.250547450729;8349.457285276452;8374.120717324684;7248.565086094824;7547.05661792276;7549.207333230014;7838.92161078389;8093.2311430414165;1927.6433859735923;2262.739784924738;2298.6666933294746;2299.0688771047753;2305.43516838374;2270.4323919020244;2313.641385585237;2314.90740370385;2315.513742114158;2319.489712263299;2025.1595587831032;2106.3154474795674;2223.7998580127787;2271.375371772759;2296.1733775840685;2282.646189840561;2286.4855407533337;2286.9542609147807;2291.472961218912;2291.8854057297153;2224.2659922225625;2314.479242170515;2318.5362927414417;2321;2323.1520495019195;8242.752717418487;8306.916930830675;8307.08622051574;8316.792080197984;8317.085120636724;4974.676646017997;5122.462141475166;5123.129068058439;5124.180131178993;5129.333186685744;2788.344738986337;3135.937281254362;3274.836258187105;3356.8321583920706;3434.158631135363;1176.112035413266;1206.6078524479578;1206.7345184059493;1252.680566455557;1269.4033804112053;10556.208284378625;10670.253082284244;10707.518161682743;10709.892901070967;10735.570577176904;3935.2719746846924;4340.8697739067875;4565.840195593139;4639.837605683785;4664.277037059193;9318;9321.860172097424;9324.8601270981;9337.71986840396;9338.626454941726;5142.717150556755;5149.716765577929;5152.871178220575;5154.175331946871;5168.715720635326;3810.961890381116;4147.97926010368;4397.758123303249;4649.744264065509;4688.859334219979;3737.663610275088;3775.811209439517;3820.9617903821163;3862.420636904487;3871.399933010388;1141.1612464838338;1175.6369696909273;1258.0438866461554;1266.290877108822;1270.39021269791;780.2041917244379;852.6504133305315;898.6405437824923;902.2376092202079;929.0709290709291;5361.812336568201;5363.919541206885;5378.650387724785;5575.99632066232;5757.769689212469;804.5213098206558;997.1275134257525;1009.6567167163053;1048.7220886465093;1051.1170616682023;3258.364618899292;3721.981390093032;3833.1758671885123;3852.6917846572205;3865.16898866745;9659.951700241594;9847.80304393908;9958.153556947596;9959.352642078242;9977.850332245021;9688.32181747271;9871;9884.555195016097;9889.406635601887;9931.155851752683;7335.4131669466315;7736.187700291501;7739.574323412154;7807.68769249235;7813.648385822652;5342.9465705342445;5582.720863956867;5771.451712087345;5796;5807.332156801853;6849.657517124224;9073.50095744714;9093.54532273397;9115.589798459217;9232.907670923205;9144.862827057466;9312.301577381588;9316.161545460942;9402.247820174232;9464.716058518256;6594.901076483952;6767.966160169364;6861.965690171517;7101.893471598033;7251.8187045324285;7805.414593905593;7912.564808935564;7986.241307075818;7989.640466178919;8002.9599852000365;7057.576545407292;7071;7136.500444968802;7184.892226616709;7253.310935461122;6939.861202776017;6947.7220911162985;7015.263397343206;7089.822754430974;7132.536385134949;6247.96876015617;6266.060090986389;6355.459785918249;6413.647249401328;6420.133282006869;4926.975365123151;4965.1807451770055;5000.874978125576;5040.092783298895;5064.41759197697;4890.462049174517;4931.5315045070665;5031.974840125776;5074.238864170256;5150.845474635767 20:28:36 INFO - PROCESS | 1631 | |4;prototype.html;322.8918312365357;347.8034910275696;360.0692210635507;365.58323511197256;369.51777929801614;4951.702897826124;5122.66702664327;5131.743412829363;5146.6140039497095;5173.663711858727;4930.457649658535;5011.599072074235;5015.949840501594;5044;5103.974480127604;3328.6005679318396;3535.7171426285963;3825.3114439400897;4044.898877528056;4094.8362065517344;3922.960770392288;4060.8578699745517;4073.3299347267625;4085.5301640311445;4096.221717873609;3393.643667414923;3518.6833185013343;3987.342088555399;4029.1538776856896;4042.4946881639794;3839.596842331543;3985.9402108968243;3996.86010989614;4002.6197511236387;4028.67770578353;2667.42650330178;3170.952435713466;3581.391163502211;3591.8024508652015;3598.226381328027;4499.422958747803;4535.591796738277;4660.464046634646;4717.504662010474;5008.574271186953;4438.289873620205;4439.245328294198;4461.055703235881;4466.82132714691;4480.574345437179;5407.432219616923;5416.647917885325;5417.566594672456;5437.215250579504;5440.211169380417;3205.5031470122167;3451.620321764604;3530.5233793437815;3739.4951681522916;3756.8121593920196;5535.778568857281;5590.450064209256;5615;5657.2096695213895;5663.801766938137;3095.613048368954;3741.644543768338;3767.530663041416;3772.6227377262053;3777.527809023872;3249.644008094113;3363.226457914693;3773.547174339042;3813.675837553839;3833.4824798652385;4126.720716577871;4172.979135104305;4211.115665710174;4242.451505200641;4439.337546524131;4810.975945120252;5155.458676838878;5188;5391.514763671288;5423.593230507728;1154.0306142840054;1166.8040258734695;1196.7254873559632;1219.6523990662618;1252.486480542973;818.5170749257848;844.5650489997656;848.6011574560071;851.1190917400461;859.9269062129664;4697.271922851895;4728.172569800271;4768.809247630056;4778.948631301108;4856.8300109495995;4800.951990480051;4907.877303067452;5001.524855138756;5100.934121680725;5261.526462618306;4638.234691275901;5064.240363945438;5084.288199652052;5100.336956195745;5123.846284611468;2751.917442476729;2754.834709917411;2772.2514920971225;2779.2496026072845;2792.3158826087333;4422.977885110618;4686.687727436323;5051;5067.037262920034;5083.949160508421;5195.844124676266;5709.800156994485;5719.456651618089;5732.914006289909;5769.596128271065;5798.855028624318;5803.82588522345;5805.622634528742;5811.680357580289;5814.73833677494;5227.529522343008;5457.727113644222;5556.416576259435;5572.60991730575;5598.300212473441;4679.906401872012;5442.537384322377;5476.315460567429;5497;5536.335639723259;5138.922916156186;5734.3978882218435;5748.48263656273;5755.8561035974435;5773.04744717117;3335.8832440864453;3399.3201359728646;3777.62223777631;3790.9241815164096;3811.5045044144085;5146.816232266525;5589.860253493533;5602.4957753802355;5615.606907516598;5635.774569017357;5418.783248670009;5432.3159820455785;5440.809571664972;5466.3713672928125;5470.452954704498;5006.4743201963265;5349.251104845403;5365.704886231295;5431.619786614899;5438.74908770977;4932.556069953722;5027.472115427828;5178.32681751385;5184.559312458483;5286.629935904603;4591.5638014389915;5254.369475662945;5332.78668853257;5416.647917885325;5505.724713764376;5213.921791173059;5297.867553311198;5306.761195746123;5311.6271167807945;5345.33183352081 20:28:36 INFO - PROCESS | 1631 | |5;yui.html;699.4299645788682;720.5280541245486;721.5273995532928;778.6301506784274;835.5989125219894;14381.928090359546;14781.187034713086;14794;14797.3341199646;14807;14031.08797928134;14297.928510357433;14333.569992900204;14351.35418906149;14522.709545809077;675.5203805298244;700.9684564194598;702.2766550453042;848.4866655673321;869.9217070463673;874.5321253129576;877.6138499060424;884.9557522123868;890.1098901098901;890.1454603580538;939.0515579264958;942.9198518125934;943.259541260111;945.6642891773424;946.011418068117;718.5760401363168;937.1565590968183;938.1369140390823;938.7887725261829;938.8732521109699;550.9366422861382;665.0523004718257;686.0121425147771;691.7647999680133;693.012457248419;14724;14774.187419691913;14778.48275310359;14792.11247325164;14811.259437028213;13475.865241347658;13488.865111348958;13505.324733763273;13548.45806167752;13552.932235338858;12027.097967652373;12152.331621760799;12159.635210943687;12375.443105060203;12709.428075736614;4256.340267258549;4448.043670610802;4464.352668863029;4493.4832494263255;4521.728696278234;91571;94917.52541237319;95187;95675.7133331342;96804.0319596802;10569.577216911237;10829.891701082888;10833.566657333618;10974.835377469344;11143.256283996023;20554.177832886817;20953.26663566768;21096.89451552763;21114.944252787605;21387.89306053491;7638.083429988437;7803.219678032265;7864.9606751965875;7869.291763741291;7903.56530390834;4209.17921005401;4234.491860976703;4291.570842915746;4302.591253830881;4399.890002749893;3302.6036875575087;3307.5038744188564;3310.6027276726945;3372.460406334975;3389.1018879996823;658.4370363339372;662.6620423584006;673.0980486148584;690.8169335126196;707.900893874858;583.8511179649163;636.3382082634009;644.7324360390479;689.7137687859582;719.6725489902186;9505.524723763785;10215.23385746072;10340.22581757668;10395.94802026;10500.684979450629;637.31689586839;672.2638710611873;677.9661016949133;700.8808502554577;704.2288693880296;5003.1238285642885;5011.248312753116;5019.447860735316;5033.194688849767;5046.44489106198;73301.6334918322;91043;93213.5339323299;93360;97350;77270.61364693141;83122.16877831265;83425.16574834296;83801.65867655749;86742;75326.87009694969;76476.61761691156;76878;77263;79495.60252198817;8216.548089855116;9350.158485736316;10572.788544229226;10886.67339979802;10905.127589792955;46414;47021.82445438755;47193.292100619205;48057.03885922332;48373.758131210525;62872;63321;65675.67162164158;65899.34100658933;67607;10989.61536346224;11553.364564948672;12845.486180552673;13007.934960325138;13597.86402135966;12710.428030738454;12784.61646150617;13341.866581334063;14751;15241.771373429629;14053.508127215498;14062.648433789238;14214.50249241313;14328.85369170443;14346.856531434969;13635.454581817014;13932.860671393157;13969.860301396857;14205.431782728576;14496.637584060483;13297.734045318846;13577.389017494039;13652.726945461234;13830.962677799003;14257;10985.747921675877;11101.38942358178;11209.684271555347;11338.60314888975;11436.370999595103;8373.078961314372;8957.193852553302;10045.447500387549;10569.524371403151;10868.61959831402 20:28:36 INFO - PROCESS | 1631 | __end_tp_report 20:28:36 INFO - PROCESS | 1631 | __start_cc_report 20:28:36 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,1674 20:28:36 INFO - PROCESS | 1631 | __end_cc_report 20:28:36 INFO - PROCESS | 1631 | __startTimestamp1485232116724__endTimestamp 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | ------- Summary: start ------- 20:28:36 INFO - PROCESS | 1631 | Number of tests: 6 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5759.67 Median:6015.76 stddev:700.33 (11.6%) stddev-sans-first:677.04 20:28:36 INFO - PROCESS | 1631 | Values: 3375.5 3378.0 3388.8 3395.2 3420.4 4279.5 5704.9 5708.7 5754.3 5787.5 5718.4 5720.4 5753.4 5797.4 5835.1 5190.7 5194.1 5229.4 5262.0 5285.5 4386.6 4453.5 5348.9 5366.6 5368.2 5191.6 5210.9 5304.5 5324.7 5326.6 4640.7 5230.9 5255.0 5260.8 5280.3 3802.8 5188.1 5234.6 5239.4 5247.4 5651.2 5776.1 5793.7 5804.4 5824.0 6183.2 6256.3 6283.6 6288.7 6309.2 6300.7 6338.9 6381.6 6382.7 6392.0 5918.9 5926.7 5927.2 5931.3 5941.7 6221.5 6294.9 6308.1 6328.3 6351.5 6204.2 6271.2 6279.4 6284.5 6286.2 6207.5 6360.8 6367.2 6375.8 6382.6 6120.9 6127.1 6164.5 6172.4 6249.9 6264.7 6267.8 6270.5 6282.0 6283.2 4965.0 4973.1 4973.8 4979.0 5011.7 4329.2 4349.7 4398.8 4477.4 4486.0 5762.0 5771.2 5774.7 5805.5 5870.6 6318.0 6349.7 6370.5 6380.4 6385.5 5679.3 5777.2 5787.4 5813.7 5860.9 5462.7 5488.3 5507.3 5518.4 5519.9 6398.9 6402.3 6410.3 6412.7 6455.9 6359.2 6363.2 6365.2 6367.7 6382.3 6231.2 6298.3 6307.0 6356.2 6358.7 6308.2 6313.3 6317.7 6332.4 6341.9 4952.5 6354.1 6366.7 6371.5 6382.1 6040.6 6066.5 6070.0 6151.0 6249.2 6029.6 6107.6 6113.6 6143.8 6145.8 5090.8 5429.0 5831.2 5934.2 5935.7 5580.4 6055.1 6102.3 6122.8 6137.7 6015.8 6019.2 6024.3 6052.0 6060.0 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:66281.69 Median:21984.32 stddev:136646.06 (621.6%) stddev-sans-first:136939.99 20:28:36 INFO - PROCESS | 1631 | Values: 448.0 449.0 450.3 490.3 502.2 31384.5 40834.4 42872.8 42943.1 43011.6 44334.9 44709.3 44741.3 44876.3 44950.6 9309.0 9383.3 9477.8 9517.1 9525.0 8447.3 8636.7 9382.0 11342.4 11606.0 11502.5 11549.8 11560.0 11577.0 11602.2 11436.0 11486.3 11504.7 11527.9 11528.1 8319.7 8534.4 11103.3 11327.7 11338.5 41763.8 41967.8 42015.8 42188.7 42249.6 4011.8 4023.8 4028.5 4029.7 4059.2 30084.8 30706.5 30956.0 31139.7 31473.4 3145.4 3206.4 3249.7 3308.7 3355.9 456712.0 458252.7 458828.0 460812.0 461811.0 62426.0 62648.0 62861.7 62950.4 62958.0 67373.0 67485.7 67495.3 67671.0 67799.3 16213.8 16427.6 16432.6 16443.9 16475.3 12590.6 12615.6 12633.2 12637.9 12639.1 15544.8 15947.3 15949.0 16305.9 16343.9 6677.2 6699.6 7653.0 7733.0 7778.5 841.9 869.3 887.3 902.2 906.9 26717.5 30200.8 30248.5 30856.8 30896.7 1049.8 1053.1 1092.9 1105.3 1180.6 15625.8 15817.2 15992.3 16011.7 16492.2 573626.0 579503.1 579710.0 580031.0 580275.0 61113.0 61351.4 61388.0 61466.0 61501.7 1234.4 1413.5 1445.3 1455.5 1463.8 26017.7 29647.3 29732.6 30502.4 30574.4 52414.5 52781.7 52878.5 52913.5 53121.0 484343.6 495957.0 498246.0 500571.0 501898.0 40288.8 40945.0 41045.6 41252.6 41273.8 44007.0 45808.3 46181.3 46852.3 46888.6 38620.4 38633.8 39056.7 39254.8 39903.2 33803.0 38456.0 38961.9 39225.0 39956.8 37224.0 38204.2 38269.0 38495.8 38527.8 27121.5 28210.7 32807.8 34283.8 34366.0 24433.5 24753.8 25227.6 25300.6 25424.0 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:37897.68 Median:22730.55 stddev:112518.07 (495.0%) stddev-sans-first:112798.36 20:28:36 INFO - PROCESS | 1631 | Values: 333.7 366.3 386.4 397.7 419.3 14800.3 15074.2 17114.9 20335.3 20748.7 20626.8 21182.4 21248.5 21422.0 21574.6 5272.0 5795.2 5888.9 6146.9 6159.3 4206.8 5947.3 6038.2 6042.5 6062.5 4372.7 6256.0 6530.7 6570.4 6653.3 5694.2 6295.7 6626.4 6668.7 6702.7 5788.7 5808.2 5808.5 5814.8 5815.5 25707.9 25803.9 26055.6 26078.7 26109.7 2786.2 2787.1 2802.3 2807.4 2813.0 11991.9 15574.5 15737.6 16064.6 16171.9 1570.9 1766.3 1805.4 1808.5 1809.5 131270.0 133519.0 134119.0 135119.0 136001.3 9152.0 11002.2 11081.4 11170.2 11360.8 14001.7 14005.4 14006.0 14023.8 14049.6 8312.6 8392.5 8468.2 8482.8 8634.8 7033.4 8410.8 8445.4 8578.5 8592.0 5666.6 6735.4 6891.1 6911.2 6934.9 1870.7 1904.1 1904.7 1907.5 1909.6 1037.2 1040.9 1046.0 1061.3 1101.5 22427.4 22727.7 22733.4 22834.7 22867.7 1065.7 1070.6 1076.0 1103.9 1107.7 11616.3 11894.5 11915.2 11925.0 11945.0 659148.0 664577.0 675937.0 687009.0 695917.0 93477.5 101191.3 133880.0 136182.8 139713.3 973.7 977.5 1039.7 1042.2 1047.0 16497.6 17287.1 18472.9 19960.1 20028.5 56918.9 57571.4 57633.1 58127.5 58640.4 80689.4 81110.0 81712.6 82075.0 82102.4 6977.9 7736.0 8254.9 8382.2 8430.7 11388.6 12645.6 12926.2 12954.4 13365.8 10615.0 10854.6 10999.1 11116.8 11336.5 9410.6 10759.3 10972.6 11180.2 11408.9 11141.3 11409.3 11457.0 11535.0 11566.4 8312.0 8354.7 8370.5 8499.0 8501.7 8393.8 10925.2 11224.2 11343.4 11376.5 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:5357.95 Median:5153.52 stddev:2924.58 (56.7%) stddev-sans-first:2916.24 20:28:36 INFO - PROCESS | 1631 | Values: 1218.7 1413.0 1420.9 1421.9 1441.7 7974.7 8312.1 8327.3 8349.5 8374.1 7248.6 7547.1 7549.2 7838.9 8093.2 1927.6 2262.7 2298.7 2299.1 2305.4 2270.4 2313.6 2314.9 2315.5 2319.5 2025.2 2106.3 2223.8 2271.4 2296.2 2282.6 2286.5 2287.0 2291.5 2291.9 2224.3 2314.5 2318.5 2321.0 2323.2 8242.8 8306.9 8307.1 8316.8 8317.1 4974.7 5122.5 5123.1 5124.2 5129.3 2788.3 3135.9 3274.8 3356.8 3434.2 1176.1 1206.6 1206.7 1252.7 1269.4 10556.2 10670.3 10707.5 10709.9 10735.6 3935.3 4340.9 4565.8 4639.8 4664.3 9318.0 9321.9 9324.9 9337.7 9338.6 5142.7 5149.7 5152.9 5154.2 5168.7 3811.0 4148.0 4397.8 4649.7 4688.9 3737.7 3775.8 3821.0 3862.4 3871.4 1141.2 1175.6 1258.0 1266.3 1270.4 780.2 852.7 898.6 902.2 929.1 5361.8 5363.9 5378.7 5576.0 5757.8 804.5 997.1 1009.7 1048.7 1051.1 3258.4 3722.0 3833.2 3852.7 3865.2 9660.0 9847.8 9958.2 9959.4 9977.9 9688.3 9871.0 9884.6 9889.4 9931.2 7335.4 7736.2 7739.6 7807.7 7813.6 5342.9 5582.7 5771.5 5796.0 5807.3 6849.7 9073.5 9093.5 9115.6 9232.9 9144.9 9312.3 9316.2 9402.2 9464.7 6594.9 6768.0 6862.0 7101.9 7251.8 7805.4 7912.6 7986.2 7989.6 8003.0 7057.6 7071.0 7136.5 7184.9 7253.3 6939.9 6947.7 7015.3 7089.8 7132.5 6248.0 6266.1 6355.5 6413.6 6420.1 4927.0 4965.2 5000.9 5040.1 5064.4 4890.5 4931.5 5032.0 5074.2 5150.8 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4378.80 Median:5004.00 stddev:1350.94 (27.0%) stddev-sans-first:1319.98 20:28:36 INFO - PROCESS | 1631 | Values: 322.9 347.8 360.1 365.6 369.5 4951.7 5122.7 5131.7 5146.6 5173.7 4930.5 5011.6 5015.9 5044.0 5104.0 3328.6 3535.7 3825.3 4044.9 4094.8 3923.0 4060.9 4073.3 4085.5 4096.2 3393.6 3518.7 3987.3 4029.2 4042.5 3839.6 3985.9 3996.9 4002.6 4028.7 2667.4 3171.0 3581.4 3591.8 3598.2 4499.4 4535.6 4660.5 4717.5 5008.6 4438.3 4439.2 4461.1 4466.8 4480.6 5407.4 5416.6 5417.6 5437.2 5440.2 3205.5 3451.6 3530.5 3739.5 3756.8 5535.8 5590.5 5615.0 5657.2 5663.8 3095.6 3741.6 3767.5 3772.6 3777.5 3249.6 3363.2 3773.5 3813.7 3833.5 4126.7 4173.0 4211.1 4242.5 4439.3 4811.0 5155.5 5188.0 5391.5 5423.6 1154.0 1166.8 1196.7 1219.7 1252.5 818.5 844.6 848.6 851.1 859.9 4697.3 4728.2 4768.8 4778.9 4856.8 4801.0 4907.9 5001.5 5100.9 5261.5 4638.2 5064.2 5084.3 5100.3 5123.8 2751.9 2754.8 2772.3 2779.2 2792.3 4423.0 4686.7 5051.0 5067.0 5083.9 5195.8 5709.8 5719.5 5732.9 5769.6 5798.9 5803.8 5805.6 5811.7 5814.7 5227.5 5457.7 5556.4 5572.6 5598.3 4679.9 5442.5 5476.3 5497.0 5536.3 5138.9 5734.4 5748.5 5755.9 5773.0 3335.9 3399.3 3777.6 3790.9 3811.5 5146.8 5589.9 5602.5 5615.6 5635.8 5418.8 5432.3 5440.8 5466.4 5470.5 5006.5 5349.3 5365.7 5431.6 5438.7 4932.6 5027.5 5178.3 5184.6 5286.6 4591.6 5254.4 5332.8 5416.6 5505.7 5213.9 5297.9 5306.8 5311.6 5345.3 20:28:36 INFO - PROCESS | 1631 | 20:28:36 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:19430.86 Median:46717.91 stddev:26873.69 (57.5%) stddev-sans-first:26912.27 20:28:36 INFO - PROCESS | 1631 | Values: 699.4 720.5 721.5 778.6 835.6 14381.9 14781.2 14794.0 14797.3 14807.0 14031.1 14297.9 14333.6 14351.4 14522.7 675.5 701.0 702.3 848.5 869.9 874.5 877.6 885.0 890.1 890.1 939.1 942.9 943.3 945.7 946.0 718.6 937.2 938.1 938.8 938.9 550.9 665.1 686.0 691.8 693.0 14724.0 14774.2 14778.5 14792.1 14811.3 13475.9 13488.9 13505.3 13548.5 13552.9 12027.1 12152.3 12159.6 12375.4 12709.4 4256.3 4448.0 4464.4 4493.5 4521.7 91571.0 94917.5 95187.0 95675.7 96804.0 10569.6 10829.9 10833.6 10974.8 11143.3 20554.2 20953.3 21096.9 21114.9 21387.9 7638.1 7803.2 7865.0 7869.3 7903.6 4209.2 4234.5 4291.6 4302.6 4399.9 3302.6 3307.5 3310.6 3372.5 3389.1 658.4 662.7 673.1 690.8 707.9 583.9 636.3 644.7 689.7 719.7 9505.5 10215.2 10340.2 10395.9 10500.7 637.3 672.3 678.0 700.9 704.2 5003.1 5011.2 5019.4 5033.2 5046.4 73301.6 91043.0 93213.5 93360.0 97350.0 77270.6 83122.2 83425.2 83801.7 86742.0 75326.9 76476.6 76878.0 77263.0 79495.6 8216.5 9350.2 10572.8 10886.7 10905.1 46414.0 47021.8 47193.3 48057.0 48373.8 62872.0 63321.0 65675.7 65899.3 67607.0 10989.6 11553.4 12845.5 13007.9 13597.9 12710.4 12784.6 13341.9 14751.0 15241.8 14053.5 14062.6 14214.5 14328.9 14346.9 13635.5 13932.9 13969.9 14205.4 14496.6 13297.7 13577.4 13652.7 13831.0 14257.0 10985.7 11101.4 11209.7 11338.6 11436.4 8373.1 8957.2 10045.4 10569.5 10868.6 20:28:36 INFO - PROCESS | 1631 | -------- Summary: end -------- 20:28:36 INFO - PROCESS | 1631 | 20:28:37 INFO - TEST-INFO | 1631: exit 0 20:28:37 INFO - TEST-OK | dromaeo_css | took 1118648ms 20:28:37 INFO - TEST-START | kraken 20:28:37 INFO - operating with platform_type : mac_ 20:28:37 INFO - Initialising browser for kraken test... 20:28:37 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpDz0HoA/profile http://localhost:49237/getInfo.html) 20:28:39 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 20:28:39 INFO - PROCESS | 1641 | colorDepth:24 20:28:39 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 20:28:39 INFO - PROCESS | 1641 | __metrics 20:28:39 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 20:28:39 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" 20:28:39 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] 20:28:40 INFO - TEST-INFO | 1641: exit 0 20:28:40 INFO - Browser initialized. 20:28:40 INFO - Running cycle 1/1 for kraken test... 20:28:40 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpDz0HoA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:52 INFO - PROCESS | 1642 | RSS: Main: 227713024 20:28:52 INFO - PROCESS | 1642 | 20:28:55 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:56 INFO - PROCESS | 1642 | RSS: Main: 288481280 20:28:56 INFO - PROCESS | 1642 | 20:28:58 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 20:28:59 INFO - PROCESS | 1642 | RSS: Main: 291905536 20:28:59 INFO - PROCESS | 1642 | 20:29:02 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 20:29:03 INFO - PROCESS | 1642 | RSS: Main: 381321216 20:29:03 INFO - PROCESS | 1642 | 20:29:05 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 20:29:06 INFO - PROCESS | 1642 | RSS: Main: 280899584 20:29:06 INFO - PROCESS | 1642 | 20:29:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:08 INFO - PROCESS | 1642 | RSS: Main: 286048256 20:29:08 INFO - PROCESS | 1642 | 20:29:11 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:12 INFO - PROCESS | 1642 | RSS: Main: 326819840 20:29:12 INFO - PROCESS | 1642 | 20:29:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:15 INFO - PROCESS | 1642 | RSS: Main: 329621504 20:29:15 INFO - PROCESS | 1642 | 20:29:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 20:29:19 INFO - PROCESS | 1642 | RSS: Main: 325627904 20:29:19 INFO - PROCESS | 1642 | 20:29:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:21 INFO - PROCESS | 1642 | RSS: Main: 304328704 20:29:21 INFO - PROCESS | 1642 | 20:29:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:24 INFO - PROCESS | 1642 | RSS: Main: 307888128 20:29:24 INFO - PROCESS | 1642 | 20:29:26 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:26 INFO - PROCESS | 1642 | RSS: Main: 310538240 20:29:26 INFO - PROCESS | 1642 | 20:29:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:30 INFO - PROCESS | 1642 | RSS: Main: 328200192 20:29:30 INFO - PROCESS | 1642 | 20:29:33 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:33 INFO - PROCESS | 1642 | RSS: Main: 322539520 20:29:33 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 20:29:35 INFO - PROCESS | 1642 | RSS: Main: 366608384 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | __start_tp_report 20:29:35 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 20:29:35 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 20:29:35 INFO - PROCESS | 1642 | |i|pagename|runs| 20:29:35 INFO - PROCESS | 1642 | |0;ai-astar;112;113;112;115;114;116;113;112;114;115 20:29:35 INFO - PROCESS | 1642 | |1;audio-beat-detection;141;109;109;147;110;111;107;105;121;129 20:29:35 INFO - PROCESS | 1642 | |2;audio-dft;185;180;185;220;182;223;231;181;181;181 20:29:35 INFO - PROCESS | 1642 | |3;audio-fft;80;58;58;85;60;60;61;73;96;81 20:29:35 INFO - PROCESS | 1642 | |4;audio-oscillator;93;70;85;69;67;70;82;68;70;83 20:29:35 INFO - PROCESS | 1642 | |5;imaging-gaussian-blur;89;85;90;87;87;86;90;88;90;88 20:29:35 INFO - PROCESS | 1642 | |6;imaging-darkroom;94;95;94;94;95;95;94;96;94;95 20:29:35 INFO - PROCESS | 1642 | |7;imaging-desaturate;88;100;113;87;84;86;84;94;129;86 20:29:35 INFO - PROCESS | 1642 | |8;json-parse-financial;57;55;54;54;55;56;55;56;55;55 20:29:35 INFO - PROCESS | 1642 | |9;json-stringify-tinderbox;72;80;66;74;74;69;71;69;73;72 20:29:35 INFO - PROCESS | 1642 | |10;stanford-crypto-aes;88;89;83;90;87;87;87;88;86;89 20:29:35 INFO - PROCESS | 1642 | |11;stanford-crypto-ccm;141;142;141;140;141;142;137;152;180;150 20:29:35 INFO - PROCESS | 1642 | |12;stanford-crypto-pbkdf2;177;171;174;172;173;173;174;173;170;173 20:29:35 INFO - PROCESS | 1642 | |13;stanford-crypto-sha256-iterative;66;65;67;68;68;68;66;68;66;65 20:29:35 INFO - PROCESS | 1642 | __end_tp_report 20:29:35 INFO - PROCESS | 1642 | __start_cc_report 20:29:35 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1991 20:29:35 INFO - PROCESS | 1642 | __end_cc_report 20:29:35 INFO - PROCESS | 1642 | __startTimestamp1485232175965__endTimestamp 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | ------- Summary: start ------- 20:29:35 INFO - PROCESS | 1642 | Number of tests: 14 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.39 20:29:35 INFO - PROCESS | 1642 | Values: 112.0 113.0 112.0 115.0 114.0 116.0 113.0 112.0 114.0 115.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:116.00 stddev:15.12 (13.0%) stddev-sans-first:13.76 20:29:35 INFO - PROCESS | 1642 | Values: 141.0 109.0 109.0 147.0 110.0 111.0 107.0 105.0 121.0 129.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#2] audio-dft Cycles:10 Average:194.90 Median:185.00 stddev:20.78 (11.2%) stddev-sans-first:21.73 20:29:35 INFO - PROCESS | 1642 | Values: 185.0 180.0 185.0 220.0 182.0 223.0 231.0 181.0 181.0 181.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#3] audio-fft Cycles:10 Average:71.20 Median:76.50 stddev:13.69 (17.9%) stddev-sans-first:14.14 20:29:35 INFO - PROCESS | 1642 | Values: 80.0 58.0 58.0 85.0 60.0 60.0 61.0 73.0 96.0 81.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:9.17 (12.1%) stddev-sans-first:7.28 20:29:35 INFO - PROCESS | 1642 | Values: 93.0 70.0 85.0 69.0 67.0 70.0 82.0 68.0 70.0 83.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.50 stddev:1.76 (2.0%) stddev-sans-first:1.83 20:29:35 INFO - PROCESS | 1642 | Values: 89.0 85.0 90.0 87.0 87.0 86.0 90.0 88.0 90.0 88.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 20:29:35 INFO - PROCESS | 1642 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 94.0 96.0 94.0 95.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:86.00 stddev:14.99 (17.4%) stddev-sans-first:15.68 20:29:35 INFO - PROCESS | 1642 | Values: 88.0 100.0 113.0 87.0 84.0 86.0 84.0 94.0 129.0 86.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.71 20:29:35 INFO - PROCESS | 1642 | Values: 57.0 55.0 54.0 54.0 55.0 56.0 55.0 56.0 55.0 55.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.50 stddev:3.77 (5.2%) stddev-sans-first:4.00 20:29:35 INFO - PROCESS | 1642 | Values: 72.0 80.0 66.0 74.0 74.0 69.0 71.0 69.0 73.0 72.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:88.00 stddev:1.96 (2.2%) stddev-sans-first:2.06 20:29:35 INFO - PROCESS | 1642 | Values: 88.0 89.0 83.0 90.0 87.0 87.0 87.0 88.0 86.0 89.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:142.00 stddev:12.60 (8.9%) stddev-sans-first:13.20 20:29:35 INFO - PROCESS | 1642 | Values: 141.0 142.0 141.0 140.0 141.0 142.0 137.0 152.0 180.0 150.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.00 stddev:1.89 (1.1%) stddev-sans-first:1.33 20:29:35 INFO - PROCESS | 1642 | Values: 177.0 171.0 174.0 172.0 173.0 173.0 174.0 173.0 170.0 173.0 20:29:35 INFO - PROCESS | 1642 | 20:29:35 INFO - PROCESS | 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 20:29:35 INFO - PROCESS | 1642 | Values: 66.0 65.0 67.0 68.0 68.0 68.0 66.0 68.0 66.0 65.0 20:29:35 INFO - PROCESS | 1642 | -------- Summary: end -------- 20:29:35 INFO - PROCESS | 1642 | 20:29:36 INFO - TEST-INFO | 1642: exit 0 20:29:36 INFO - TEST-OK | kraken | took 59479ms 20:29:36 INFO - SUITE-END | took 1178s 20:29:37 INFO - Completed test suite (00:19:38) 20:29:37 INFO - javascript benchmark 20:29:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.510550970108, 3377.98311008445, 3388.796672199667, 3395.1512121969517, 3420.43562812136, 4279.48646162461, 5704.942950570493, 5708.65748055117, 5754.280714910637, 5787.536997040237, 5718.370979192296, 5720.427957204278, 5753.367129615739, 5797.420257974211, 5835.124731290298, 5190.662606930557, 5194.142966410538, 5229.398619158807, 5262.02652509287, 5285.497877701631, 4386.583274588909, 4453.51011388747, 5348.866278343034, 5366.597505187126, 5368.221607866857, 5191.584673226171, 5210.895782084337, 5304.549113325372, 5324.680519168863, 5326.600504962104, 4640.721556706575, 5230.8692282692855, 5255.0, 5260.842174734764, 5280.287161233223, 3802.8478860845535, 5188.11801993662, 5234.555062819665, 5239.449857764918, 5247.39654939683, 5651.18057881609, 5776.075827867563, 5793.710314484259, 5804.361520232771, 5824.0390335594575, 6183.165272688175, 6256.343083976162, 6283.560150789401, 6288.654124023177, 6309.179806625109, 6300.716467758962, 6338.904916426257, 6381.585196962183, 6382.744690212386, 6392.041193820917, 5918.940810591882, 5926.7252145590455, 5927.229460170151, 5931.3178984417345, 5941.732622032019, 6221.5333849961435, 6294.874102518015, 6308.148399966038, 6328.335524769925, 6351.491880649537, 6204.224471941007, 6271.184745982993, 6279.372062793684, 6284.528660350492, 6286.214223222098, 6207.534434917399, 6360.840978975562, 6367.204099487564, 6375.808725738235, 6382.585131966407, 6120.873812997669, 6127.078295984317, 6164.537659675542, 6172.351903050205, 6249.937500625027, 6264.655443950626, 6267.811965641038, 6270.467010304175, 6282.026285925689, 6283.246010478681, 4964.982178653368, 4973.079980203674, 4973.8010479581135, 4978.975105124524, 5011.699298042129, 4329.242382583036, 4349.652027837766, 4398.8020539075815, 4477.440319960005, 4485.955140448554, 5762.0, 5771.192033115283, 5774.653520788682, 5805.535557155417, 5870.5890587659305, 6317.952995144681, 6349.746010159542, 6370.522210834206, 6380.361963803675, 6385.521085918482, 5679.318481782213, 5777.248957635565, 5787.363390027093, 5813.7383817728305, 5860.882782344414, 5462.672239665632, 5488.25908502355, 5507.284053073155, 5518.420565840609, 5519.9448005520235, 6398.9040164397575, 6402.327755585597, 6410.294867564471, 6412.711427985659, 6455.870882582228, 6359.236891573041, 6363.236411630634, 6365.204349456318, 6367.713452894538, 6382.32985536512, 6231.22109736283, 6298.307186209605, 6306.9684651576445, 6356.173697419306, 6358.682065896779, 6308.211473565804, 6313.305536390902, 6317.7157027932935, 6332.366763323631, 6341.936580634135, 4952.504749525163, 6354.142190804182, 6366.713497892699, 6371.522135839923, 6382.106505089198, 6040.607360521552, 6066.545009124245, 6070.0, 6151.046587778901, 6249.218847644044, 6029.638221706711, 6107.603005804608, 6113.5979309659515, 6143.818944274897, 6145.84635384119, 5090.803661139703, 5429.0, 5831.1544826000845, 5934.169216309634, 5935.673537955454, 5580.35825880029, 6055.061465472859, 6102.337773232528, 6122.825106970096, 6137.6931153441255, 6015.759369625166, 6019.157317975574, 6024.337322894566, 6052.03167493199, 6060.030395136757], "value": 5714.506485148801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.04566273836724, 448.9528599497052, 450.28854410032153, 490.3209055458191, 502.1588838695185, 31384.529232061508, 40834.387484187726, 42872.78563607185, 42943.14113717728, 43011.56988430115, 44334.89162770932, 44709.32936005962, 44741.32888006682, 44876.3268550972, 44950.550494495044, 9308.953455232715, 9383.343165978384, 9477.81044379112, 9517.143457088861, 9524.999875013127, 8447.324214062892, 8636.740897773077, 9381.95309023454, 11342.43287835609, 11606.0, 11502.482388292505, 11549.826752598718, 11560.0, 11576.95807377336, 11602.187846850724, 11436.0, 11486.310821350746, 11504.712382190428, 11527.942360288187, 11528.077753779677, 8319.66721331146, 8534.402591818574, 11103.278286911405, 11327.716807079807, 11338.489767960462, 41763.7911810442, 41967.790161049306, 42015.789921050506, 42188.73433796991, 42249.57750422487, 4011.83952641894, 4023.8189281482405, 4028.4561584186054, 4029.6977726670325, 4059.188162367538, 30084.79660813565, 30706.53940190899, 30955.999960261983, 31139.688603113904, 31473.37053258922, 3145.3552021835467, 3206.4388731971812, 3249.707526322619, 3308.669133086696, 3355.8825441109443, 456712.0, 458252.7087364542, 458828.0, 460812.0, 461811.0, 62426.0, 62648.0, 62861.68569157125, 62950.37049629536, 62958.0, 67373.0, 67485.6625716878, 67495.3250467489, 67671.0, 67799.32200678029, 16213.837861621232, 16427.58931026734, 16432.589185270463, 16443.917780411022, 16475.258613362428, 12590.622281331574, 12615.621531354074, 12633.2420054797, 12637.925776308934, 12639.052071094704, 15544.76682849758, 15947.252395687005, 15949.006374203225, 16305.918470407572, 16343.91828040876, 6677.165354330708, 6699.598024118569, 7652.961735191288, 7732.9613351934, 7778.49439786412, 841.9223394055618, 869.2567854484325, 887.316766090107, 902.1880307723102, 906.9047749986156, 26717.465650686878, 30200.79196832146, 30248.54627180594, 30856.845715771728, 30896.69103308983, 1049.7952899184738, 1053.131166787388, 1092.852464917226, 1105.287089827073, 1180.6340034589305, 15625.765613515807, 15817.209139542976, 15992.281312176958, 16011.679766404606, 16492.17539123039, 573626.0, 579503.1024844849, 579710.0, 580031.0, 580275.0, 61113.0, 61351.38648613546, 61388.0, 61466.0, 61501.69249153815, 1234.370471059766, 1413.5264686330195, 1445.28458413082, 1455.51240334487, 1463.8316593591874, 26017.739822601532, 29647.258818528848, 29732.554011689408, 30502.389952201276, 30574.388512230074, 52414.47585524096, 52781.73609132083, 52878.4712152889, 52913.47086529085, 53121.0, 484343.5782821063, 495957.0, 498246.0, 500571.0, 501898.0, 40288.79855600703, 40945.0, 41045.58954410537, 41252.58747412488, 41273.79363103165, 44007.0, 45808.312875306234, 46181.30728039149, 46852.29721554248, 46888.59334219979, 38620.420693690176, 38633.80683096567, 39056.71138443159, 39254.80372598119, 39903.2019359617, 33803.0, 38456.0, 38961.86546015038, 39225.019374514726, 39956.80021599874, 37224.0, 38204.23591528098, 38269.0, 38495.84512464631, 38527.8441646751, 27121.49737521084, 28210.71789282081, 32807.83596082004, 34283.828580856934, 34366.0, 24433.51132977366, 24753.752462475146, 25227.605875373018, 25300.620490692287, 25424.0], "value": 20339.111062366817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.65800054943685, 366.3095065800964, 386.43580372655936, 397.6736093850971, 419.25372836351306, 14800.333984970675, 15074.170920599376, 17114.914425427873, 20335.28826491073, 20748.688769668468, 20626.793732062673, 21182.364529064154, 21248.4687882803, 21422.0, 21574.568508629818, 5271.971965466735, 5795.217645617851, 5888.941110588904, 6146.877062458748, 6159.3224745277985, 4206.831726730927, 5947.345791962881, 6038.184845045928, 6042.486388656969, 6062.4543791058795, 4372.715773474714, 6256.0, 6530.673466326689, 6570.375814297634, 6653.301403352651, 5694.202811606378, 6295.653739044351, 6626.436752875988, 6668.699908504129, 6702.698378572976, 5788.6816225107605, 5808.186853840466, 5808.535317174658, 5814.767409303623, 5815.505682017034, 25707.871460642764, 25803.870980645166, 26055.609165862526, 26078.73921260782, 26109.738902611112, 2786.233785708926, 2787.1359878437747, 2802.299425143714, 2807.368342123006, 2812.9578056329174, 11991.880081199164, 15574.454894078654, 15737.606559835982, 16064.59838504035, 16171.91914040434, 1570.9082187879428, 1766.3464518128246, 1805.3771448850125, 1808.5388226002417, 1809.5114319133893, 131270.0, 133519.0, 134119.0, 135119.0, 136001.3199934004, 9152.039035901134, 11002.214036893976, 11081.390523521284, 11170.218084734153, 11360.772784544262, 14001.719965600834, 14005.369758360897, 14006.0, 14023.78964315536, 14049.578512644637, 8312.625931833081, 8392.4544904581, 8468.237858592756, 8482.830343393098, 8634.78413039679, 7033.402160816286, 8410.78973025667, 8445.408821382443, 8578.528180950108, 8592.0, 5666.603337766399, 6735.360140786617, 6891.104156459628, 6911.205211400653, 6934.861302773917, 1870.7474490943548, 1904.095554611576, 1904.6571617108775, 1907.5421898744478, 1909.5989842133308, 1037.1754455208127, 1040.861030582161, 1045.9581616735397, 1061.310148403544, 1101.5373543111912, 22427.43931401728, 22727.659085113737, 22733.43166420853, 22834.657480137477, 22867.656985145237, 1065.737101534684, 1070.6466865934224, 1075.978480430387, 1103.9282446641103, 1107.6732363952653, 11616.303021818718, 11894.464749086139, 11915.16593838423, 11925.0, 11945.044396448264, 659148.0, 664577.0, 675937.0, 687009.0, 695917.0, 93477.53261233651, 101191.31534612147, 133880.0, 136182.8290302585, 139713.3014334922, 973.6835528453281, 977.5454413697664, 1039.719275795531, 1042.2183362478142, 1046.9528871200814, 16497.587560311087, 17287.13564321804, 18472.891626502453, 19960.107639735434, 20028.499287517345, 56918.86162276814, 57571.42428575828, 57633.13550296665, 58127.54681133005, 58640.413595865204, 80689.3862122766, 81110.0, 81712.59143704243, 82075.0, 82102.3579528418, 6977.895331570132, 7736.0, 8254.917450825415, 8382.203690649378, 8430.662773488992, 11388.601398950997, 12645.557405490763, 12926.224426534438, 12954.417051232529, 13365.799513007507, 10615.0, 10854.620088296871, 10999.120070394189, 11116.833247501456, 11336.489857956576, 9410.623575056921, 10759.30064545802, 10972.561097556008, 11180.217384782987, 11408.885911140782, 11141.331520108819, 11409.315441073562, 11457.026152777107, 11535.019523340274, 11566.363849988331, 8312.0, 8354.665813367397, 8370.539620320696, 8498.957505212435, 8501.659933602587, 8393.83212335762, 10925.235233533895, 11224.214304998899, 11343.432828358715, 11376.488058037574], "value": 9996.06808564672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.6587755428484, 1412.964675883103, 1420.8721215090645, 1421.905133047554, 1441.6612096157405, 7974.68101275949, 8312.127226641207, 8327.250547450729, 8349.457285276452, 8374.120717324684, 7248.565086094824, 7547.05661792276, 7549.207333230014, 7838.92161078389, 8093.2311430414165, 1927.6433859735923, 2262.739784924738, 2298.6666933294746, 2299.0688771047753, 2305.43516838374, 2270.4323919020244, 2313.641385585237, 2314.90740370385, 2315.513742114158, 2319.489712263299, 2025.1595587831032, 2106.3154474795674, 2223.7998580127787, 2271.375371772759, 2296.1733775840685, 2282.646189840561, 2286.4855407533337, 2286.9542609147807, 2291.472961218912, 2291.8854057297153, 2224.2659922225625, 2314.479242170515, 2318.5362927414417, 2321.0, 2323.1520495019195, 8242.752717418487, 8306.916930830675, 8307.08622051574, 8316.792080197984, 8317.085120636724, 4974.676646017997, 5122.462141475166, 5123.129068058439, 5124.180131178993, 5129.333186685744, 2788.344738986337, 3135.937281254362, 3274.836258187105, 3356.8321583920706, 3434.158631135363, 1176.112035413266, 1206.6078524479578, 1206.7345184059493, 1252.680566455557, 1269.4033804112053, 10556.208284378625, 10670.253082284244, 10707.518161682743, 10709.892901070967, 10735.570577176904, 3935.2719746846924, 4340.8697739067875, 4565.840195593139, 4639.837605683785, 4664.277037059193, 9318.0, 9321.860172097424, 9324.8601270981, 9337.71986840396, 9338.626454941726, 5142.717150556755, 5149.716765577929, 5152.871178220575, 5154.175331946871, 5168.715720635326, 3810.961890381116, 4147.97926010368, 4397.758123303249, 4649.744264065509, 4688.859334219979, 3737.663610275088, 3775.811209439517, 3820.9617903821163, 3862.420636904487, 3871.399933010388, 1141.1612464838338, 1175.6369696909273, 1258.0438866461554, 1266.290877108822, 1270.39021269791, 780.2041917244379, 852.6504133305315, 898.6405437824923, 902.2376092202079, 929.0709290709291, 5361.812336568201, 5363.919541206885, 5378.650387724785, 5575.99632066232, 5757.769689212469, 804.5213098206558, 997.1275134257525, 1009.6567167163053, 1048.7220886465093, 1051.1170616682023, 3258.364618899292, 3721.981390093032, 3833.1758671885123, 3852.6917846572205, 3865.16898866745, 9659.951700241594, 9847.80304393908, 9958.153556947596, 9959.352642078242, 9977.850332245021, 9688.32181747271, 9871.0, 9884.555195016097, 9889.406635601887, 9931.155851752683, 7335.4131669466315, 7736.187700291501, 7739.574323412154, 7807.68769249235, 7813.648385822652, 5342.9465705342445, 5582.720863956867, 5771.451712087345, 5796.0, 5807.332156801853, 6849.657517124224, 9073.50095744714, 9093.54532273397, 9115.589798459217, 9232.907670923205, 9144.862827057466, 9312.301577381588, 9316.161545460942, 9402.247820174232, 9464.716058518256, 6594.901076483952, 6767.966160169364, 6861.965690171517, 7101.893471598033, 7251.8187045324285, 7805.414593905593, 7912.564808935564, 7986.241307075818, 7989.640466178919, 8002.9599852000365, 7057.576545407292, 7071.0, 7136.500444968802, 7184.892226616709, 7253.310935461122, 6939.861202776017, 6947.7220911162985, 7015.263397343206, 7089.822754430974, 7132.536385134949, 6247.96876015617, 6266.060090986389, 6355.459785918249, 6413.647249401328, 6420.133282006869, 4926.975365123151, 4965.1807451770055, 5000.874978125576, 5040.092783298895, 5064.41759197697, 4890.462049174517, 4931.5315045070665, 5031.974840125776, 5074.238864170256, 5150.845474635767], "value": 4357.195607455368, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8918312365357, 347.8034910275696, 360.0692210635507, 365.58323511197256, 369.51777929801614, 4951.702897826124, 5122.66702664327, 5131.743412829363, 5146.6140039497095, 5173.663711858727, 4930.457649658535, 5011.599072074235, 5015.949840501594, 5044.0, 5103.974480127604, 3328.6005679318396, 3535.7171426285963, 3825.3114439400897, 4044.898877528056, 4094.8362065517344, 3922.960770392288, 4060.8578699745517, 4073.3299347267625, 4085.5301640311445, 4096.221717873609, 3393.643667414923, 3518.6833185013343, 3987.342088555399, 4029.1538776856896, 4042.4946881639794, 3839.596842331543, 3985.9402108968243, 3996.86010989614, 4002.6197511236387, 4028.67770578353, 2667.42650330178, 3170.952435713466, 3581.391163502211, 3591.8024508652015, 3598.226381328027, 4499.422958747803, 4535.591796738277, 4660.464046634646, 4717.504662010474, 5008.574271186953, 4438.289873620205, 4439.245328294198, 4461.055703235881, 4466.82132714691, 4480.574345437179, 5407.432219616923, 5416.647917885325, 5417.566594672456, 5437.215250579504, 5440.211169380417, 3205.5031470122167, 3451.620321764604, 3530.5233793437815, 3739.4951681522916, 3756.8121593920196, 5535.778568857281, 5590.450064209256, 5615.0, 5657.2096695213895, 5663.801766938137, 3095.613048368954, 3741.644543768338, 3767.530663041416, 3772.6227377262053, 3777.527809023872, 3249.644008094113, 3363.226457914693, 3773.547174339042, 3813.675837553839, 3833.4824798652385, 4126.720716577871, 4172.979135104305, 4211.115665710174, 4242.451505200641, 4439.337546524131, 4810.975945120252, 5155.458676838878, 5188.0, 5391.514763671288, 5423.593230507728, 1154.0306142840054, 1166.8040258734695, 1196.7254873559632, 1219.6523990662618, 1252.486480542973, 818.5170749257848, 844.5650489997656, 848.6011574560071, 851.1190917400461, 859.9269062129664, 4697.271922851895, 4728.172569800271, 4768.809247630056, 4778.948631301108, 4856.8300109495995, 4800.951990480051, 4907.877303067452, 5001.524855138756, 5100.934121680725, 5261.526462618306, 4638.234691275901, 5064.240363945438, 5084.288199652052, 5100.336956195745, 5123.846284611468, 2751.917442476729, 2754.834709917411, 2772.2514920971225, 2779.2496026072845, 2792.3158826087333, 4422.977885110618, 4686.687727436323, 5051.0, 5067.037262920034, 5083.949160508421, 5195.844124676266, 5709.800156994485, 5719.456651618089, 5732.914006289909, 5769.596128271065, 5798.855028624318, 5803.82588522345, 5805.622634528742, 5811.680357580289, 5814.73833677494, 5227.529522343008, 5457.727113644222, 5556.416576259435, 5572.60991730575, 5598.300212473441, 4679.906401872012, 5442.537384322377, 5476.315460567429, 5497.0, 5536.335639723259, 5138.922916156186, 5734.3978882218435, 5748.48263656273, 5755.8561035974435, 5773.04744717117, 3335.8832440864453, 3399.3201359728646, 3777.62223777631, 3790.9241815164096, 3811.5045044144085, 5146.816232266525, 5589.860253493533, 5602.4957753802355, 5615.606907516598, 5635.774569017357, 5418.783248670009, 5432.3159820455785, 5440.809571664972, 5466.3713672928125, 5470.452954704498, 5006.4743201963265, 5349.251104845403, 5365.704886231295, 5431.619786614899, 5438.74908770977, 4932.556069953722, 5027.472115427828, 5178.32681751385, 5184.559312458483, 5286.629935904603, 4591.5638014389915, 5254.369475662945, 5332.78668853257, 5416.647917885325, 5505.724713764376, 5213.921791173059, 5297.867553311198, 5306.761195746123, 5311.6271167807945, 5345.33183352081], "value": 3957.690861693243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.4299645788682, 720.5280541245486, 721.5273995532928, 778.6301506784274, 835.5989125219894, 14381.928090359546, 14781.187034713086, 14794.0, 14797.3341199646, 14807.0, 14031.08797928134, 14297.928510357433, 14333.569992900204, 14351.35418906149, 14522.709545809077, 675.5203805298244, 700.9684564194598, 702.2766550453042, 848.4866655673321, 869.9217070463673, 874.5321253129576, 877.6138499060424, 884.9557522123868, 890.1098901098901, 890.1454603580538, 939.0515579264958, 942.9198518125934, 943.259541260111, 945.6642891773424, 946.011418068117, 718.5760401363168, 937.1565590968183, 938.1369140390823, 938.7887725261829, 938.8732521109699, 550.9366422861382, 665.0523004718257, 686.0121425147771, 691.7647999680133, 693.012457248419, 14724.0, 14774.187419691913, 14778.48275310359, 14792.11247325164, 14811.259437028213, 13475.865241347658, 13488.865111348958, 13505.324733763273, 13548.45806167752, 13552.932235338858, 12027.097967652373, 12152.331621760799, 12159.635210943687, 12375.443105060203, 12709.428075736614, 4256.340267258549, 4448.043670610802, 4464.352668863029, 4493.4832494263255, 4521.728696278234, 91571.0, 94917.52541237319, 95187.0, 95675.7133331342, 96804.0319596802, 10569.577216911237, 10829.891701082888, 10833.566657333618, 10974.835377469344, 11143.256283996023, 20554.177832886817, 20953.26663566768, 21096.89451552763, 21114.944252787605, 21387.89306053491, 7638.083429988437, 7803.219678032265, 7864.9606751965875, 7869.291763741291, 7903.56530390834, 4209.17921005401, 4234.491860976703, 4291.570842915746, 4302.591253830881, 4399.890002749893, 3302.6036875575087, 3307.5038744188564, 3310.6027276726945, 3372.460406334975, 3389.1018879996823, 658.4370363339372, 662.6620423584006, 673.0980486148584, 690.8169335126196, 707.900893874858, 583.8511179649163, 636.3382082634009, 644.7324360390479, 689.7137687859582, 719.6725489902186, 9505.524723763785, 10215.23385746072, 10340.22581757668, 10395.94802026, 10500.684979450629, 637.31689586839, 672.2638710611873, 677.9661016949133, 700.8808502554577, 704.2288693880296, 5003.1238285642885, 5011.248312753116, 5019.447860735316, 5033.194688849767, 5046.44489106198, 73301.6334918322, 91043.0, 93213.5339323299, 93360.0, 97350.0, 77270.61364693141, 83122.16877831265, 83425.16574834296, 83801.65867655749, 86742.0, 75326.87009694969, 76476.61761691156, 76878.0, 77263.0, 79495.60252198817, 8216.548089855116, 9350.158485736316, 10572.788544229226, 10886.67339979802, 10905.127589792955, 46414.0, 47021.82445438755, 47193.292100619205, 48057.03885922332, 48373.758131210525, 62872.0, 63321.0, 65675.67162164158, 65899.34100658933, 67607.0, 10989.61536346224, 11553.364564948672, 12845.486180552673, 13007.934960325138, 13597.86402135966, 12710.428030738454, 12784.61646150617, 13341.866581334063, 14751.0, 15241.771373429629, 14053.508127215498, 14062.648433789238, 14214.50249241313, 14328.85369170443, 14346.856531434969, 13635.454581817014, 13932.860671393157, 13969.860301396857, 14205.431782728576, 14496.637584060483, 13297.734045318846, 13577.389017494039, 13652.726945461234, 13830.962677799003, 14257.0, 10985.747921675877, 11101.38942358178, 11209.684271555347, 11338.60314888975, 11436.370999595103, 8373.078961314372, 8957.193852553302, 10045.447500387549, 10569.524371403151, 10868.61959831402], "value": 7422.098055254758, "unit": "score"}], "name": "dromaeo_css", "value": 7278.820976552897, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 115.0, 114.0, 116.0, 113.0, 112.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 109.0, 147.0, 110.0, 111.0, 107.0, 105.0, 121.0, 129.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 185.0, 220.0, 182.0, 223.0, 231.0, 181.0, 181.0, 181.0], "value": 194.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 85.0, 60.0, 60.0, 61.0, 73.0, 96.0, 81.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 85.0, 69.0, 67.0, 70.0, 82.0, 68.0, 70.0, 83.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 90.0, 87.0, 87.0, 86.0, 90.0, 88.0, 90.0, 88.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 100.0, 113.0, 87.0, 84.0, 86.0, 84.0, 94.0, 129.0, 86.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 54.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 66.0, 74.0, 74.0, 69.0, 71.0, 69.0, 73.0, 72.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 83.0, 90.0, 87.0, 87.0, 87.0, 88.0, 86.0, 89.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 141.0, 140.0, 141.0, 142.0, 137.0, 152.0, 180.0, 150.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 171.0, 174.0, 172.0, 173.0, 173.0, 174.0, 173.0, 170.0, 173.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 68.0, 68.0, 68.0, 66.0, 68.0, 66.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1452.9, "alertThreshold": 2.0}]} 20:29:37 INFO - Return code: 0 20:29:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:29:37 ERROR - # TBPL SUCCESS # 20:29:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:37 INFO - 2017-01-23 20:29:37.309 screenresolution[1646:9686] starting screenresolution argv=screenresolution get 20:29:37 INFO - 2017-01-23 20:29:37.313 screenresolution[1646:9686] Display 0: 1600x1200x32@60 20:29:37 INFO - 2017-01-23 20:29:37.319 screenresolution[1647:9689] starting screenresolution argv=screenresolution list 20:29:37 INFO - Available Modes on Display 0 20:29:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:37 INFO - Intel Iris: 20:29:37 INFO - Chipset Model: Intel Iris 20:29:37 INFO - Type: GPU 20:29:37 INFO - Bus: Built-In 20:29:37 INFO - VRAM (Dynamic, Max): 1536 MB 20:29:37 INFO - Vendor: Intel (0x8086) 20:29:37 INFO - Device ID: 0x0a2e 20:29:37 INFO - Revision ID: 0x0009 20:29:37 INFO - Displays: 20:29:37 INFO - Display: 20:29:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:37 INFO - Display Serial Number: 1600x1200 60 20:29:37 INFO - Main Display: Yes 20:29:37 INFO - Mirror: Off 20:29:37 INFO - Online: Yes 20:29:37 INFO - Rotation: Supported 20:29:37 INFO - Return code: 0 20:29:37 INFO - Running post-action listener: _resource_record_post_action 20:29:37 INFO - [mozharness: 2017-01-24 04:29:37.554619Z] Finished run-tests step (success) 20:29:37 INFO - Running post-run listener: _resource_record_post_run 20:29:37 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37860352; Write bytes: 552531968; Read time: 239; Write time: 1680 20:29:37 INFO - TinderboxPrint: CPU usage
53.7% 20:29:37 INFO - TinderboxPrint: I/O read bytes / time
37,860,352 / 239 20:29:37 INFO - TinderboxPrint: I/O write bytes / time
552,531,968 / 1,680 20:29:37 INFO - TinderboxPrint: CPU idle
2,224.8 (46.3%) 20:29:37 INFO - TinderboxPrint: CPU system
962.7 (20.0%) 20:29:37 INFO - TinderboxPrint: CPU user
1,618.1 (33.7%) 20:29:37 INFO - TinderboxPrint: Swap in / out
289,030,144 / 0 20:29:37 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243141120; Write bytes: 235470848; Read time: 17740; Write time: 494 20:29:37 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35898368; Write bytes: 299534336; Read time: 222; Write time: 1137 20:29:38 INFO - Running post-run listener: _upload_blobber_files 20:29:38 INFO - Blob upload gear active. 20:29:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:38 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 20:29:38 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:38 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:38 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:39 INFO - (blobuploader) - INFO - Done attempting. 20:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:40 INFO - (blobuploader) - INFO - Done attempting. 20:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:41 INFO - (blobuploader) - INFO - Done attempting. 20:29:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:43 INFO - (blobuploader) - INFO - Done attempting. 20:29:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:43 INFO - Return code: 0 20:29:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95f8b9bc15216494141e6942d623302c80a2fc7c675c786302b2c1a877ea90bf1a67087f18965da2685824b7d6330961beabbf30d5687c774e9fc116368a9271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/186937cde5b6a837fa8e7726ef370caec7a6a7c683260f735471b079e60b7406503e9fe219cd9723532d86025bbf50efee89485f373e7b3397db781e2de920f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a7df16c3d6058b29d8e27f658fc6d006c45fcb4f38e2877fbd6ead55fff0c5d04b97b110fb8310e58ea1f1bc44f9f99239f73666a180de76e8928d7dd0a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89d6d9300de69f08ff86b24ae456b3ed582042e450e8ded0dbd0c449c9bb794b8c1720acae31408cb7b11d81dc3b094f8dfee197a3566dee7c5a76efe8f80"} 20:29:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:43 INFO - Contents: 20:29:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95f8b9bc15216494141e6942d623302c80a2fc7c675c786302b2c1a877ea90bf1a67087f18965da2685824b7d6330961beabbf30d5687c774e9fc116368a9271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/186937cde5b6a837fa8e7726ef370caec7a6a7c683260f735471b079e60b7406503e9fe219cd9723532d86025bbf50efee89485f373e7b3397db781e2de920f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a7df16c3d6058b29d8e27f658fc6d006c45fcb4f38e2877fbd6ead55fff0c5d04b97b110fb8310e58ea1f1bc44f9f99239f73666a180de76e8928d7dd0a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89d6d9300de69f08ff86b24ae456b3ed582042e450e8ded0dbd0c449c9bb794b8c1720acae31408cb7b11d81dc3b094f8dfee197a3566dee7c5a76efe8f80"} 20:29:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:43 INFO - Copying logs to upload dir... 20:29:43 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.284227 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-01-23 20:29:43.841226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 20:29:43.844818) ========= 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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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/Firefox/sha512/95f8b9bc15216494141e6942d623302c80a2fc7c675c786302b2c1a877ea90bf1a67087f18965da2685824b7d6330961beabbf30d5687c774e9fc116368a9271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/186937cde5b6a837fa8e7726ef370caec7a6a7c683260f735471b079e60b7406503e9fe219cd9723532d86025bbf50efee89485f373e7b3397db781e2de920f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a7df16c3d6058b29d8e27f658fc6d006c45fcb4f38e2877fbd6ead55fff0c5d04b97b110fb8310e58ea1f1bc44f9f99239f73666a180de76e8928d7dd0a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89d6d9300de69f08ff86b24ae456b3ed582042e450e8ded0dbd0c449c9bb794b8c1720acae31408cb7b11d81dc3b094f8dfee197a3566dee7c5a76efe8f80"} build_url:https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011051 build_url: 'https://queue.taskcluster.net/v1/task/D8xlY9DnS92A2CtZjTsA5A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95f8b9bc15216494141e6942d623302c80a2fc7c675c786302b2c1a877ea90bf1a67087f18965da2685824b7d6330961beabbf30d5687c774e9fc116368a9271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/186937cde5b6a837fa8e7726ef370caec7a6a7c683260f735471b079e60b7406503e9fe219cd9723532d86025bbf50efee89485f373e7b3397db781e2de920f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a7df16c3d6058b29d8e27f658fc6d006c45fcb4f38e2877fbd6ead55fff0c5d04b97b110fb8310e58ea1f1bc44f9f99239f73666a180de76e8928d7dd0a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89d6d9300de69f08ff86b24ae456b3ed582042e450e8ded0dbd0c449c9bb794b8c1720acae31408cb7b11d81dc3b094f8dfee197a3566dee7c5a76efe8f80"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 20:29:43.879551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:29:43.879916) ========= 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.rkRHYpXxI6/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.OuiAm5SIGP/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:29:43.928055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 20:29:43.928361) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 20:29:43.928665) ========= ========= Total master_lag: 0.19 =========