builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1490028729.45 results: success (0) buildid: 20170320082524 builduid: 7a43aa8fbe8641c3b899c46844104d5b revision: 05bfa2831c0ba4a26fa72328ffe6a99aba9c356a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.453354) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.453867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.454185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.481445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.481782) ========= 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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-20 09:52:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-03-20 09:52:09 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.667683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.668050) ========= 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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.028342 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:09.718108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 09:52:09.718489) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05bfa2831c0ba4a26fa72328ffe6a99aba9c356a --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 05bfa2831c0ba4a26fa72328ffe6a99aba9c356a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AW3YtvEKAg/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.uGXfRBi0oy/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-20 09:52:09,830 truncating revision to first 12 chars 2017-03-20 09:52:09,830 Setting DEBUG logging. 2017-03-20 09:52:09,830 attempt 1/10 2017-03-20 09:52:09,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05bfa2831c0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 09:52:10,844 unpacking tar archive at: mozilla-central-05bfa2831c0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312339 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 09:52:11.052964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:11.053287) ========= script_repo_revision: 05bfa2831c0ba4a26fa72328ffe6a99aba9c356a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:11.072856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:11.073257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 09:52:11.093585) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-20 09:52:11.093997) ========= /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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:52:11 INFO - MultiFileLogger online at 20170320 09:52:11 in /builds/slave/test 09:52:11 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 09:52:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:52:11 INFO - {'append_to_log': False, 09:52:11 INFO - 'base_work_dir': '/builds/slave/test', 09:52:11 INFO - 'blob_upload_branch': 'Firefox', 09:52:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:52:11 INFO - 'branch': 'Firefox', 09:52:11 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:11 INFO - 'config_files': ('talos/mac_config.py',), 09:52:11 INFO - 'default_actions': ('clobber', 09:52:11 INFO - 'read-buildbot-config', 09:52:11 INFO - 'download-and-extract', 09:52:11 INFO - 'populate-webroot', 09:52:11 INFO - 'create-virtualenv', 09:52:11 INFO - 'install', 09:52:11 INFO - 'run-tests'), 09:52:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:11 INFO - 'download_minidump_stackwalk': True, 09:52:11 INFO - 'download_symbols': 'ondemand', 09:52:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:11 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:11 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:11 INFO - 'gecko_profile': False, 09:52:11 INFO - 'gecko_profile_interval': 0, 09:52:11 INFO - 'installer_path': 'installer.exe', 09:52:11 INFO - 'log_level': 'info', 09:52:11 INFO - 'log_name': 'talos', 09:52:11 INFO - 'log_to_console': True, 09:52:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:52:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:52:11 INFO - 'opt_config_files': (), 09:52:11 INFO - 'pip_index': False, 09:52:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:52:11 INFO - 'cmd': ('bash', 09:52:11 INFO - '-c', 09:52:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:52:11 INFO - 'enabled': True, 09:52:11 INFO - 'halt_on_failure': False, 09:52:11 INFO - 'name': 'check_screen_resolution'},), 09:52:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:52:11 INFO - 'cmd': ('bash', 09:52:11 INFO - '-c', 09:52:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:52:11 INFO - 'enabled': True, 09:52:11 INFO - 'halt_on_failure': False, 09:52:11 INFO - 'name': 'check_screen_resolution'},), 09:52:11 INFO - 'run_cmd_checks_enabled': True, 09:52:11 INFO - 'suite': 'dromaeojs', 09:52:11 INFO - 'system_bits': '32', 09:52:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:11 INFO - 'title': 't-yosemite-r7-0022', 09:52:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:11 INFO - 'use_talos_json': True, 09:52:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:52:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:11 INFO - 'work_dir': 'build'} 09:52:11 INFO - [mozharness: 2017-03-20 16:52:11.322695Z] Running clobber step. 09:52:11 INFO - Running pre-action listener: _resource_record_pre_action 09:52:11 INFO - Running main action method: clobber 09:52:11 INFO - rmtree: /builds/slave/test/build 09:52:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:52:13 INFO - Running post-action listener: _resource_record_post_action 09:52:13 INFO - [mozharness: 2017-03-20 16:52:13.872231Z] Finished clobber step (success) 09:52:13 INFO - [mozharness: 2017-03-20 16:52:13.872385Z] Running read-buildbot-config step. 09:52:13 INFO - Running pre-action listener: _resource_record_pre_action 09:52:13 INFO - Running main action method: read_buildbot_config 09:52:13 INFO - Using buildbot properties: 09:52:13 INFO - { 09:52:13 INFO - "project": "", 09:52:13 INFO - "product": "firefox", 09:52:13 INFO - "script_repo_revision": "production", 09:52:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:52:13 INFO - "repository": "", 09:52:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:52:13 INFO - "buildid": "20170320082524", 09:52:13 INFO - "pgo_build": "False", 09:52:13 INFO - "basedir": "/builds/slave/test", 09:52:13 INFO - "buildnumber": 50, 09:52:13 INFO - "slavename": "t-yosemite-r7-0022", 09:52:13 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:52:13 INFO - "platform": "yosemite_r7", 09:52:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:52:13 INFO - "branch": "mozilla-central", 09:52:13 INFO - "repo_path": "mozilla-central", 09:52:13 INFO - "revision": "05bfa2831c0ba4a26fa72328ffe6a99aba9c356a", 09:52:13 INFO - "stage_platform": "macosx64", 09:52:13 INFO - "builduid": "7a43aa8fbe8641c3b899c46844104d5b", 09:52:13 INFO - "slavebuilddir": "test" 09:52:13 INFO - } 09:52:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:52:13 INFO - Running post-action listener: _resource_record_post_action 09:52:13 INFO - [mozharness: 2017-03-20 16:52:13.875710Z] Finished read-buildbot-config step (success) 09:52:13 INFO - [mozharness: 2017-03-20 16:52:13.875840Z] Running download-and-extract step. 09:52:13 INFO - Running pre-action listener: _resource_record_pre_action 09:52:13 INFO - Running main action method: download_and_extract 09:52:13 INFO - mkdir: /builds/slave/test/build/tests 09:52:13 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')]} 09:52:13 INFO - trying https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:52:13 INFO - Downloading https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:52:15 INFO - Downloaded 1325 bytes. 09:52:15 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:52:15 INFO - Using the following test package requirements: 09:52:15 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:52:15 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:52:15 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:52:15 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:52:15 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'jsshell-mac.zip'], 09:52:15 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:52:15 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:52:15 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:52:15 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:52:15 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:52:15 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:15 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:52:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:52:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:52:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:52:15 INFO - Fetch https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:52:16 INFO - Expected file size: 52474461 09:52:16 INFO - Obtained file size: 52474461 09:52:33 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:52:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:52:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:52:33 INFO - Fetch https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:52:35 INFO - Expected file size: 52474461 09:52:35 INFO - Obtained file size: 52474461 09:52:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:52:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:52:50 INFO - Fetch https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:52:51 INFO - Expected file size: 14404171 09:52:51 INFO - Obtained file size: 14404171 09:52:52 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')]} 09:52:52 INFO - trying https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:52:52 INFO - Downloading https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:52:54 INFO - Downloaded 75191379 bytes. 09:52:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:52:54 INFO - mkdir: /builds/slave/test/properties 09:52:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:54 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:54 INFO - Contents: 09:52:54 INFO - build_url:https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:52:54 INFO - Running post-action listener: _resource_record_post_action 09:52:54 INFO - Running post-action listener: set_extra_try_arguments 09:52:54 INFO - [mozharness: 2017-03-20 16:52:54.946419Z] Finished download-and-extract step (success) 09:52:54 INFO - [mozharness: 2017-03-20 16:52:54.946556Z] Running populate-webroot step. 09:52:54 INFO - Running pre-action listener: _resource_record_pre_action 09:52:54 INFO - Running main action method: populate_webroot 09:52:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:54 INFO - '--tppagecycles', 09:52:54 INFO - '7'], 09:52:54 INFO - 'tests': ['tsvgm']}}, 09:52:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:52:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:52:54 INFO - 'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:52:54 INFO - 'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['damp', 'tps']}, 09:52:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:52:54 INFO - 'tests': ['damp', 'tps']}, 09:52:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['dromaeo_dom']}, 09:52:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['basic_compositor_video']}, 09:52:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:52:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['a11yr', 09:52:54 INFO - 'ts_paint', 09:52:54 INFO - 'tpaint', 09:52:54 INFO - 'sessionrestore', 09:52:54 INFO - 'sessionrestore_no_auto_restore', 09:52:54 INFO - 'tabpaint']}, 09:52:54 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:54 INFO - 'ts_paint', 09:52:54 INFO - 'tpaint', 09:52:54 INFO - 'sessionrestore', 09:52:54 INFO - 'sessionrestore_no_auto_restore', 09:52:54 INFO - 'tabpaint']}, 09:52:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:52:54 INFO - 'ts_paint', 09:52:54 INFO - 'tpaint', 09:52:54 INFO - 'sessionrestore', 09:52:54 INFO - 'sessionrestore_no_auto_restore', 09:52:54 INFO - 'tabpaint']}, 09:52:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:52:54 INFO - 'ts_paint', 09:52:54 INFO - 'tpaint', 09:52:54 INFO - 'sessionrestore', 09:52:54 INFO - 'sessionrestore_no_auto_restore', 09:52:54 INFO - 'tabpaint']}, 09:52:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['a11yr', 09:52:54 INFO - 'ts_paint', 09:52:54 INFO - 'tpaint', 09:52:54 INFO - 'sessionrestore', 09:52:54 INFO - 'sessionrestore_no_auto_restore', 09:52:54 INFO - 'tabpaint']}, 09:52:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['a11yr', 09:52:54 INFO - 'ts_paint', 09:52:54 INFO - 'tpaint', 09:52:54 INFO - 'sessionrestore', 09:52:54 INFO - 'sessionrestore_no_auto_restore', 09:52:54 INFO - 'tabpaint']}, 09:52:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['tsvgx', 09:52:54 INFO - 'tsvgr_opacity', 09:52:54 INFO - 'tart', 09:52:54 INFO - 'tscrollx', 09:52:54 INFO - 'cart', 09:52:54 INFO - 'tsvg_static']}, 09:52:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:54 INFO - 'tsvgr_opacity', 09:52:54 INFO - 'tart', 09:52:54 INFO - 'tscrollx', 09:52:54 INFO - 'cart', 09:52:54 INFO - 'tsvg_static']}, 09:52:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:52:54 INFO - 'talos_options': ['--disable-e10s'], 09:52:54 INFO - 'tests': ['tp5o']}, 09:52:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:52:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:52:54 INFO - 'talos_options': ['--disable-e10s', 09:52:54 INFO - '--xperf_path', 09:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:54 INFO - 'tests': ['tp5n']}, 09:52:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:52:54 INFO - 'talos_options': ['--xperf_path', 09:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:54 INFO - 'tests': ['tp5n']}}, 09:52:54 INFO - 'talos.zip': {'path': '', 09:52:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:54 INFO - Running post-action listener: _resource_record_post_action 09:52:54 INFO - [mozharness: 2017-03-20 16:52:54.965092Z] Finished populate-webroot step (success) 09:52:54 INFO - [mozharness: 2017-03-20 16:52:54.965231Z] Running create-virtualenv step. 09:52:54 INFO - Running pre-action listener: _resource_record_pre_action 09:52:54 INFO - Running main action method: create_virtualenv 09:52:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:54 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 09:52:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:52:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:55 INFO - Using real prefix '/tools/python27' 09:52:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:58 INFO - Installing pip.................done. 09:52:58 INFO - Return code: 0 09:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:52:58 INFO - Reading from file tmpfile_stdout 09:52:58 INFO - Output received: 09:52:58 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) 09:52:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:58 INFO - 'HOME': '/Users/cltbld', 09:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:58 INFO - 'LOGNAME': 'cltbld', 09:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:58 INFO - 'MOZ_NO_REMOTE': '1', 09:52:58 INFO - 'NO_EM_RESTART': '1', 09:52:58 INFO - 'PAGER': '/bin/cat', 09:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:58 INFO - 'PWD': '/builds/slave/test', 09:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:58 INFO - 'SHELL': '/bin/bash', 09:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:52:58 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:58 INFO - 'USER': 'cltbld', 09:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:58 INFO - 'XPC_FLAGS': '0x0', 09:52:58 INFO - 'XPC_SERVICE_NAME': '0', 09:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 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 09:52:59 INFO - Cleaning up... 09:52:59 INFO - Return code: 0 09:52:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:52:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:52:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:59 INFO - 'HOME': '/Users/cltbld', 09:52:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:59 INFO - 'LOGNAME': 'cltbld', 09:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:59 INFO - 'MOZ_NO_REMOTE': '1', 09:52:59 INFO - 'NO_EM_RESTART': '1', 09:52:59 INFO - 'PAGER': '/bin/cat', 09:52:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:59 INFO - 'PWD': '/builds/slave/test', 09:52:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:59 INFO - 'SHELL': '/bin/bash', 09:52:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:52:59 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:52:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:59 INFO - 'USER': 'cltbld', 09:52:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:59 INFO - 'XPC_FLAGS': '0x0', 09:52:59 INFO - 'XPC_SERVICE_NAME': '0', 09:52:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 INFO - Downloading/unpacking psutil>=3.1.1 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:03 INFO - Installing collected packages: psutil 09:53:03 INFO - Running setup.py install for psutil 09:53:03 INFO - building 'psutil._psutil_osx' extension 09:53:03 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 09:53:03 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 09:53:03 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 09:53:03 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 09:53:04 INFO - building 'psutil._psutil_posix' extension 09:53:04 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 09:53:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:53:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:53:04 INFO - ^ 09:53:04 INFO - 1 warning generated. 09:53:04 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 09:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:04 INFO - Successfully installed psutil 09:53:04 INFO - Cleaning up... 09:53:04 INFO - Return code: 0 09:53:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:04 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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53:04 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 09:53:04 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 09:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:04 INFO - 'HOME': '/Users/cltbld', 09:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:04 INFO - 'LOGNAME': 'cltbld', 09:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:04 INFO - 'MOZ_NO_REMOTE': '1', 09:53:04 INFO - 'NO_EM_RESTART': '1', 09:53:04 INFO - 'PAGER': '/bin/cat', 09:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:04 INFO - 'PWD': '/builds/slave/test', 09:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:04 INFO - 'SHELL': '/bin/bash', 09:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:04 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:04 INFO - 'USER': 'cltbld', 09:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:04 INFO - 'XPC_FLAGS': '0x0', 09:53:04 INFO - 'XPC_SERVICE_NAME': '0', 09:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:53:04 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 09:53:04 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 09:53:04 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 09:53:04 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 09:53:04 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 09:53:04 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 09:53:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:53:07 INFO - Installing collected packages: mozsystemmonitor 09:53:07 INFO - Running setup.py install for mozsystemmonitor 09:53:07 INFO - Successfully installed mozsystemmonitor 09:53:07 INFO - Cleaning up... 09:53:07 INFO - Return code: 0 09:53:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:08 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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53:08 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 09:53:08 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 09:53:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:08 INFO - 'HOME': '/Users/cltbld', 09:53:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:08 INFO - 'LOGNAME': 'cltbld', 09:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:08 INFO - 'MOZ_NO_REMOTE': '1', 09:53:08 INFO - 'NO_EM_RESTART': '1', 09:53:08 INFO - 'PAGER': '/bin/cat', 09:53:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:08 INFO - 'PWD': '/builds/slave/test', 09:53:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:08 INFO - 'SHELL': '/bin/bash', 09:53:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:08 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:08 INFO - 'USER': 'cltbld', 09:53:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:08 INFO - 'XPC_FLAGS': '0x0', 09:53:08 INFO - 'XPC_SERVICE_NAME': '0', 09:53:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:08 INFO - Downloading/unpacking jsonschema==2.5.1 09:53:08 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 09:53:08 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 09:53:08 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 09:53:08 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 09:53:08 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 09:53:08 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 09:53:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:53:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:53:12 INFO - warning: no files found matching '*.txt' 09:53:12 INFO - no previously-included directories found matching 'build' 09:53:12 INFO - no previously-included directories found matching 'dist' 09:53:12 INFO - no previously-included directories found matching '.git*' 09:53:12 INFO - Installing collected packages: jsonschema, functools32 09:53:12 INFO - Running setup.py install for functools32 09:53:12 INFO - warning: no files found matching '*.txt' 09:53:12 INFO - no previously-included directories found matching 'build' 09:53:12 INFO - no previously-included directories found matching 'dist' 09:53:12 INFO - no previously-included directories found matching '.git*' 09:53:12 INFO - Successfully installed jsonschema functools32 09:53:12 INFO - Cleaning up... 09:53:12 INFO - Return code: 0 09:53:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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', '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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:53: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 functools32==3.2.3-2 09:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:12 INFO - 'HOME': '/Users/cltbld', 09:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:12 INFO - 'LOGNAME': 'cltbld', 09:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:12 INFO - 'MOZ_NO_REMOTE': '1', 09:53:12 INFO - 'NO_EM_RESTART': '1', 09:53:12 INFO - 'PAGER': '/bin/cat', 09:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:12 INFO - 'PWD': '/builds/slave/test', 09:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:12 INFO - 'SHELL': '/bin/bash', 09:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:12 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:12 INFO - 'USER': 'cltbld', 09:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:12 INFO - 'XPC_FLAGS': '0x0', 09:53:12 INFO - 'XPC_SERVICE_NAME': '0', 09:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:53:12 INFO - Cleaning up... 09:53:12 INFO - Return code: 0 09:53:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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', '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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:53: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 blobuploader==1.2.4 09:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:12 INFO - 'HOME': '/Users/cltbld', 09:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:12 INFO - 'LOGNAME': 'cltbld', 09:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:12 INFO - 'MOZ_NO_REMOTE': '1', 09:53:12 INFO - 'NO_EM_RESTART': '1', 09:53:12 INFO - 'PAGER': '/bin/cat', 09:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:12 INFO - 'PWD': '/builds/slave/test', 09:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:12 INFO - 'SHELL': '/bin/bash', 09:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:12 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:12 INFO - 'USER': 'cltbld', 09:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:12 INFO - 'XPC_FLAGS': '0x0', 09:53:12 INFO - 'XPC_SERVICE_NAME': '0', 09:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:53:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:53:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:53:16 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 09:53:16 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 09:53:16 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 09:53:16 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 09:53:16 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 09:53:16 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 09:53:16 INFO - Downloading docopt-0.6.1.tar.gz 09:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:53:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:53:16 INFO - Running setup.py install for blobuploader 09:53:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:53:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:53:17 INFO - Running setup.py install for requests 09:53:17 INFO - Running setup.py install for docopt 09:53:17 INFO - Successfully installed blobuploader requests docopt 09:53:17 INFO - Cleaning up... 09:53:17 INFO - Return code: 0 09:53:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:17 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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53:17 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 09:53:17 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 09:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:17 INFO - 'HOME': '/Users/cltbld', 09:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:17 INFO - 'LOGNAME': 'cltbld', 09:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:17 INFO - 'MOZ_NO_REMOTE': '1', 09:53:17 INFO - 'NO_EM_RESTART': '1', 09:53:17 INFO - 'PAGER': '/bin/cat', 09:53:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:17 INFO - 'PWD': '/builds/slave/test', 09:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:17 INFO - 'SHELL': '/bin/bash', 09:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:17 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:17 INFO - 'USER': 'cltbld', 09:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:17 INFO - 'XPC_FLAGS': '0x0', 09:53:17 INFO - 'XPC_SERVICE_NAME': '0', 09:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-trtztL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-pbpUsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-NxYrXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-2xRJfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-U1S8_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ydbPgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-NOG1VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-TS2v2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-IK1uw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-MJMCxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-0Tprk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-52MpL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-yfo63i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-lAJrYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-nj7mw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-bIfCQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-hMufL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:53:19 INFO - Running setup.py install for manifestparser 09:53:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:53:20 INFO - Running setup.py install for mozcrash 09:53:20 INFO - Running setup.py install for mozdebug 09:53:20 INFO - Running setup.py install for mozdevice 09:53:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:53:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:53:20 INFO - Running setup.py install for mozfile 09:53:20 INFO - Running setup.py install for mozhttpd 09:53:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:53:20 INFO - Running setup.py install for mozinfo 09:53:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:53:20 INFO - Running setup.py install for mozInstall 09:53:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Running setup.py install for mozleak 09:53:21 INFO - Running setup.py install for mozlog 09:53:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Running setup.py install for moznetwork 09:53:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Running setup.py install for mozprocess 09:53:21 INFO - Running setup.py install for mozprofile 09:53:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:53:21 INFO - Running setup.py install for mozrunner 09:53:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:53:22 INFO - Running setup.py install for mozscreenshot 09:53:22 INFO - Running setup.py install for moztest 09:53:22 INFO - Running setup.py install for mozversion 09:53:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:53:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:53:22 INFO - Cleaning up... 09:53:22 INFO - Return code: 0 09:53:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:22 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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53:22 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 09:53:22 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 09:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:22 INFO - 'HOME': '/Users/cltbld', 09:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:22 INFO - 'LOGNAME': 'cltbld', 09:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:22 INFO - 'MOZ_NO_REMOTE': '1', 09:53:22 INFO - 'NO_EM_RESTART': '1', 09:53:22 INFO - 'PAGER': '/bin/cat', 09:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:22 INFO - 'PWD': '/builds/slave/test', 09:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:22 INFO - 'SHELL': '/bin/bash', 09:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:22 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:22 INFO - 'USER': 'cltbld', 09:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:22 INFO - 'XPC_FLAGS': '0x0', 09:53:22 INFO - 'XPC_SERVICE_NAME': '0', 09:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-QLKc3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:22 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)) 09:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-jrzURv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-IDebFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-y6BKzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-t8abdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-CfKrAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-8x6esA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-RusRl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-AMyODu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-IPQD1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:23 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)) 09:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-KtWPjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:24 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)) 09:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-17r8Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-AOxT4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:24 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)) 09:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-2G_5M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:24 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)) 09:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-rlXVJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:24 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)) 09:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-fJ0MPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:24 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)) 09:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-EUC0rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:24 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)) 09:53:24 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)) 09:53:24 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)) 09:53:24 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)) 09:53:24 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)) 09:53:24 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)) 09:53:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:27 INFO - Downloading blessings-1.6.tar.gz 09:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:27 INFO - Installing collected packages: blessings 09:53:27 INFO - Running setup.py install for blessings 09:53:27 INFO - Successfully installed blessings 09:53:27 INFO - Cleaning up... 09:53:27 INFO - Return code: 0 09:53:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:27 INFO - Reading from file tmpfile_stdout 09:53:27 INFO - Current package versions: 09:53:27 INFO - blessings == 1.6 09:53:27 INFO - blobuploader == 1.2.4 09:53:27 INFO - docopt == 0.6.1 09:53:27 INFO - functools32 == 3.2.3-2 09:53:27 INFO - jsonschema == 2.5.1 09:53:27 INFO - manifestparser == 1.1 09:53:27 INFO - mozInstall == 1.12 09:53:27 INFO - mozcrash == 1.0 09:53:27 INFO - mozdebug == 0.1 09:53:27 INFO - mozdevice == 0.49 09:53:27 INFO - mozfile == 1.2 09:53:27 INFO - mozhttpd == 0.7 09:53:27 INFO - mozinfo == 0.9 09:53:27 INFO - mozleak == 0.1 09:53:27 INFO - mozlog == 3.4 09:53:27 INFO - moznetwork == 0.27 09:53:27 INFO - mozprocess == 0.25 09:53:27 INFO - mozprofile == 0.28 09:53:27 INFO - mozrunner == 6.13 09:53:27 INFO - mozscreenshot == 0.1 09:53:27 INFO - mozsystemmonitor == 0.3 09:53:27 INFO - moztest == 0.8 09:53:27 INFO - mozversion == 1.4 09:53:27 INFO - psutil == 3.1.1 09:53:27 INFO - requests == 1.2.3 09:53:27 INFO - wsgiref == 0.1.2 09:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:27 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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53:27 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 09:53:27 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 09:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:27 INFO - 'HOME': '/Users/cltbld', 09:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:27 INFO - 'LOGNAME': 'cltbld', 09:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:27 INFO - 'MOZ_NO_REMOTE': '1', 09:53:27 INFO - 'NO_EM_RESTART': '1', 09:53:27 INFO - 'PAGER': '/bin/cat', 09:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:27 INFO - 'PWD': '/builds/slave/test', 09:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:27 INFO - 'SHELL': '/bin/bash', 09:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:27 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:27 INFO - 'USER': 'cltbld', 09:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:27 INFO - 'XPC_FLAGS': '0x0', 09:53:27 INFO - 'XPC_SERVICE_NAME': '0', 09:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 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)) 09:53:28 INFO - Cleaning up... 09:53:28 INFO - Return code: 0 09:53:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:28 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')]} 09:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:28 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')]} 09:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:28 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 0x10663ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10663d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaa8ce02f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, '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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 09:53:28 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 09:53:28 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 09:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:28 INFO - 'HOME': '/Users/cltbld', 09:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:28 INFO - 'LOGNAME': 'cltbld', 09:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:28 INFO - 'MOZ_NO_REMOTE': '1', 09:53:28 INFO - 'NO_EM_RESTART': '1', 09:53:28 INFO - 'PAGER': '/bin/cat', 09:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:28 INFO - 'PWD': '/builds/slave/test', 09:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:28 INFO - 'SHELL': '/bin/bash', 09:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:28 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:28 INFO - 'USER': 'cltbld', 09:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:28 INFO - 'XPC_FLAGS': '0x0', 09:53:28 INFO - 'XPC_SERVICE_NAME': '0', 09:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:53:28 INFO - Cleaning up... 09:53:28 INFO - Return code: 0 09:53:28 INFO - Running post-action listener: _resource_record_post_action 09:53:28 INFO - Running post-action listener: _start_resource_monitoring 09:53:28 INFO - Starting resource monitoring. 09:53:28 INFO - [mozharness: 2017-03-20 16:53:28.555523Z] Finished create-virtualenv step (success) 09:53:28 INFO - [mozharness: 2017-03-20 16:53:28.556459Z] Running install step. 09:53:28 INFO - Running pre-action listener: _resource_record_pre_action 09:53:28 INFO - Running main action method: install 09:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:28 INFO - Reading from file tmpfile_stdout 09:53:28 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:28 INFO - Reading from file tmpfile_stdout 09:53:28 INFO - Output received: 09:53:28 INFO - Usage: mozinstall [options] installer 09:53:28 INFO - Options: 09:53:28 INFO - -h, --help show this help message and exit 09:53:28 INFO - -d DEST, --destination=DEST 09:53:28 INFO - Directory to install application into. [default: 09:53:28 INFO - "/builds/slave/test"] 09:53:28 INFO - --app=APP Application being installed. [default: firefox] 09:53:28 INFO - mkdir: /builds/slave/test/build/application 09:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:53:49 INFO - Reading from file tmpfile_stdout 09:53:49 INFO - Output received: 09:53:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:53:49 INFO - Running post-action listener: _resource_record_post_action 09:53:49 INFO - [mozharness: 2017-03-20 16:53:49.156383Z] Finished install step (success) 09:53:49 INFO - [mozharness: 2017-03-20 16:53:49.156547Z] Running run-tests step. 09:53:49 INFO - Running pre-action listener: _resource_record_pre_action 09:53:49 INFO - Running main action method: run_tests 09:53:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:53:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:53:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:53:49 INFO - 2017-03-20 09:53:49.171 screenresolution[1622:7460] starting screenresolution argv=screenresolution get 09:53:49 INFO - 2017-03-20 09:53:49.173 screenresolution[1622:7460] Display 0: 1600x1200x32@60 09:53:49 INFO - 2017-03-20 09:53:49.179 screenresolution[1623:7462] starting screenresolution argv=screenresolution list 09:53:49 INFO - Available Modes on Display 0 09:53:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:53:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:53:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:53:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:53:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:53:49 INFO - Intel Iris: 09:53:49 INFO - Chipset Model: Intel Iris 09:53:49 INFO - Type: GPU 09:53:49 INFO - Bus: Built-In 09:53:49 INFO - VRAM (Dynamic, Max): 1536 MB 09:53:49 INFO - Vendor: Intel (0x8086) 09:53:49 INFO - Device ID: 0x0a2e 09:53:49 INFO - Revision ID: 0x0009 09:53:49 INFO - Displays: 09:53:49 INFO - Display: 09:53:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:53:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:53:49 INFO - Display Serial Number: 1600x1200 60 09:53:49 INFO - Main Display: Yes 09:53:49 INFO - Mirror: Off 09:53:49 INFO - Online: Yes 09:53:49 INFO - Rotation: Supported 09:53:49 INFO - Return code: 0 09:53:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:53:49 INFO - Python 2.7.3 09:53:49 INFO - Return code: 0 09:53:49 INFO - grabbing minidump binary from tooltool 09:53:49 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')]} 09:53:49 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 0x106418d30>, '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 0x10633fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:53:49 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 09:53:49 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 09:53:49 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 09:53:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:49 INFO - Return code: 0 09:53:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:53:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:53:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:53:49 INFO - ENV: RUST_BACKTRACE is now 1 09:53:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:53:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:53:49 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/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 09:53:49 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/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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 09:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AW3YtvEKAg/Render', 09:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:49 INFO - 'HOME': '/Users/cltbld', 09:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:49 INFO - 'LOGNAME': 'cltbld', 09:53:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:49 INFO - 'MOZ_NO_REMOTE': '1', 09:53:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:49 INFO - 'NO_EM_RESTART': '1', 09:53:49 INFO - 'PAGER': '/bin/cat', 09:53:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:49 INFO - 'PWD': '/builds/slave/test', 09:53:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:49 INFO - 'RUST_BACKTRACE': '1', 09:53:49 INFO - 'SHELL': '/bin/bash', 09:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uGXfRBi0oy/Listeners', 09:53:49 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 09:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:49 INFO - 'USER': 'cltbld', 09:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:49 INFO - 'XPC_FLAGS': '0x0', 09:53:49 INFO - 'XPC_SERVICE_NAME': '0', 09:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:49 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/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 09:53:49 INFO - mozversion application_buildid: 20170320082524 09:53:49 INFO - mozversion application_changeset: 05bfa2831c0ba4a26fa72328ffe6a99aba9c356a 09:53:49 INFO - mozversion application_display_name: Nightly 09:53:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:49 INFO - mozversion application_name: Firefox 09:53:49 INFO - mozversion application_remotingname: firefox 09:53:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:53:49 INFO - mozversion application_vendor: Mozilla 09:53:49 INFO - mozversion application_version: 55.0a1 09:53:49 INFO - mozversion platform_buildid: 20170320082524 09:53:49 INFO - mozversion platform_changeset: 05bfa2831c0ba4a26fa72328ffe6a99aba9c356a 09:53:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:53:49 INFO - mozversion platform_version: 55.0a1 09:53:49 INFO - using testdate: 1490028829 09:53:49 INFO - actual date: 1490028829 09:53:49 INFO - starting webserver on 'localhost:49241' 09:53:49 INFO - SUITE-START | Running 2 tests 09:53:49 INFO - TEST-START | dromaeo_css 09:53:49 INFO - operating with platform_type : mac_ 09:53:49 INFO - Initialising browser for dromaeo_css test... 09:53:49 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpK5fYQc/profile http://localhost:49241/getInfo.html) 09:53:52 INFO - PID 1633 | __metrics Screen width/height:1600/1200 09:53:52 INFO - PID 1633 | colorDepth:24 09:53:52 INFO - PID 1633 | Browser inner width/height: 1024/689 09:53:52 INFO - PID 1633 | __metrics 09:53:52 INFO - PID 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:53:52 INFO - PID 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:53 INFO - TEST-INFO | 1633: exit 0 09:53:53 INFO - Browser initialized. 09:53:53 INFO - Running cycle 1/1 for dromaeo_css test... 09:53:53 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpK5fYQc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:05 INFO - PID 1635 | RSS: Main: 233553920 09:54:05 INFO - PID 1635 | 09:57:10 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:57:11 INFO - PID 1635 | RSS: Main: 363991040 09:57:11 INFO - PID 1635 | 09:58:56 INFO - PID 1635 | ************************* 09:58:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 09:58:56 INFO - PID 1635 | 09:58:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:58:56 INFO - PID 1635 | Full stack: 09:58:56 INFO - PID 1635 | ************************* 10:00:15 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:00:15 INFO - PID 1635 | RSS: Main: 369471488 10:00:15 INFO - PID 1635 | 10:03:18 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:03:19 INFO - PID 1635 | RSS: Main: 352038912 10:03:19 INFO - PID 1635 | 10:06:21 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:06:22 INFO - PID 1635 | RSS: Main: 359514112 10:06:22 INFO - PID 1635 | 10:09:26 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:09:26 INFO - PID 1635 | RSS: Main: 335790080 10:09:26 INFO - PID 1635 | 10:12:29 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:12:30 INFO - PID 1635 | RSS: Main: 576487424 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | __start_tp_report 10:12:30 INFO - PID 1635 | _x_x_mozilla_page_load 10:12:30 INFO - PID 1635 | _x_x_mozilla_page_load_details 10:12:30 INFO - PID 1635 | |i|pagename|runs| 10:12:30 INFO - PID 1635 | |0;dojo.html;3420.914477138071;3423.212661087948;3431.2794313194227;3469.98265008675;3482.077249528874;5139.792148845018;5770;6022.7590896364145;6051.122587224855;6086.056661217507;5937.079752638338;6034.155218269435;6057.242844644419;6086.573939824214;6093.207882975207;4499.48255950565;5297.205419187114;5350;5370.275012873251;5374.193870919355;5474.863128421782;5496.450354964491;5501.504864562188;5519.668819870801;5545.667259964415;5318.734063296858;5377.596680248997;5383.623146379755;5392.137258038734;5470.17947307905;5466.590005749545;5480.671159730389;5483.561315094783;5484.972575137139;5492.423295553949;5320.574354051705;5367.355917289911;5369.301990741218;5372.0330340538685;5374.54316383104;6012.458878700938;6018.729157187937;6020.247469066367;6024.126501657279;6043.546733994968;6227.595206311576;6238.2825975013;6280;6296.496280297565;6298.2442106947;6351;6374.617522948592;6383.010633351838;6386.2336519617475;6392.520560957947;5967.43309385612;6101.877962440771;6116;6125.78559750411;6130.448259656652;5493.6496525281345;6306.873862522724;6382;6546.8363290918105;6550.377714117151;5984.251968503937;6229.190205273376;6284.748610055638;6288.968555157195;6289.496840252768;6346.809595712136;6354.078658594478;6354.618722876642;6359.300476947532;6374.235091789015;6220;6294.0558916162945;6303.338149494329;6307.842303942346;6323.336049714806;6229.127922090911;6241;6250.249970003629;6255.499560035186;6287.1512345832725;5154.7164905929785;5157.303763991888;5159.148740457783;5187.19598462239;5190.740462976836;4579.496255411902;4586.656000799953;4591.977040114778;4607.14767767964;4622.214223581999;5923.17075609415;6015.2781666200335;6037.094435834572;6098.54260930432;6104.542159338067;6249.406306400884;6255.249370075529;6257.624542527463;6271.749130034838;6286.874262514724;6006.0090085136335;6028.819135425944;6032.065029920369;6046.909296360558;6051.425114614105;5572.554195664337;5572.665640061609;5574.916376254359;5575.581831362583;5577.9959607271085;6554.246261679872;6561.1470508833545;6561.835954100995;6563.015547667888;6578.342165783383;5325.786968521215;5327.9200811987075;6323.841903952438;6336.619802811846;6430.839229019312;6624.271330153776;6627.966860165669;6637.070810086495;6639.502037347122;6660.766873159416;6294.1188233648245;6308.306086330408;6313.6843157841;6317.115603815561;6321.11504389395;6214.161088253209;6217.160683307696;6252.468540174136;6329.556931014785;6345.555811093179;6173.536984726074;6219.346968568416;6264.185655864709;6266.874662506633;6269.529785266032;6080.847978800389;6228.314885362516;6231.906521402092;6257.843553911189;6262.185915831095;6065.120557519223;6103.943827031667;6212.968935155476;6223.222097237845;6227.314995350417;5121.359830021247;6193.287771906288;6247.656378899204;6274.874502509833;6283.874322513616;6211.844703882259;6216.160818289473;6222.066689996536;6226.439620434002;6231.096491008688 10:12:30 INFO - PID 1635 | |1;ext.html;768.2816566510312;790.766723816474;853.0062477214042;864.9178328058836;867.3104881619112;36787.81606091969;37577.6847810327;37624.623753762455;37645;37677.43483847744;38812.41781373282;39171.60828391715;39217.21565568687;39244.607553924456;39370.40944385836;7348.706051757923;9108.590113444894;9314.534273286343;9327.720168394924;9349.85975210369;7434.442416818733;10798.082163016154;10983.505742241618;11021.338719676805;11025.44872756363;11070.28043177195;11162.05122564579;11181.32912025281;11187.664370068871;11197.328160310408;7312.963435182844;11048.502817373197;11127.276727012719;11158.107351411867;11197.888021119767;7365.116186057708;7440.590767507785;7461.067366579177;7485.737999170057;10581.470926453647;38134;38528;38554.807225963974;38586;38711.61288387136;3774.886753397375;3781.7920014399197;3790.1851102013197;3803.486529318562;3860;28212.858935705397;28304.920235932364;28530.714692853013;29143.70856291431;29795;3124.5811303894466;3126.2028182813237;3139.8116113033293;3151.1806930198086;3226.290216152466;326615.36692316626;328141;328340;328507;329093.9999999976;38949.610503895165;39633;51900.809919008556;52007.69980750436;52139.56813670805;41655.958601035214;49840.003199935796;50232.246516302286;50631.74684126556;50689;14679.412823487155;14793.408263669548;14805.03767255125;14806.925965370105;14813.629659258604;11993.940030299967;12018.33899135556;12034.277943323428;12036.277823330629;12043.698907527381;12955.676108097374;12970.286634235019;12992.545260915822;13016.166925496891;13099.279539625222;5322.175062865262;5381.3811411687375;5390.54180394663;5393.83818485446;5400.162974738922;1057.3655806516028;1061.7239517725448;1078.2021304234809;1080.1250986700798;1146.3866831245243;26787.46425071488;27207;27626.585601215997;27635.309117271827;27706.72293277082;1008.7944905837601;1131.3551275772895;1134.733337665648;1158.3744777819884;1184.603157942099;13473.730525389437;13562.982776291818;13797;13990.778917840951;14283.143011419348;452082.73958630656;453892;454720;455024;455400;56715.58211044757;56722.71638641781;56740.148897766565;56794.716026419606;56991;1399.0975820595659;1453.9345729442412;1454.0693955868253;1457.5773025822605;1465.2673663168416;26245.4750904977;26646.7335326652;26823.865880670473;27022.864885675444;27054.594181087694;47842.760786195846;47932;47982.28026579534;48018.27972580484;48039.03921921472;426179;426577;427675;427832;428011;26119;26647.60028599611;31061.068167954996;31968.68031319657;34387.82806085954;41240.37053145178;41443;42047.36928946007;42070.78964605158;42080;33901;35366.82316588401;36475.90572282836;36658.90023299305;36943.445848311756;29237;34704.479432809036;34846.78036268718;36194.27611447809;37068.25863482769;29378.265543361587;35000.82499587486;35833.82083089568;35909.28181436409;35990.46014309735;24863.62704559397;27960.58059129074;31440;31462.685373145974;31469.213269668442;21595;23719.644205337278;24010;24014.639780403657;24123.63814542748 10:12:30 INFO - PID 1635 | |2;jquery.html;391.4793324877913;394.2804382002842;407.234399329261;407.74719673802235;423.14313515131875;18757.812421875777;20269.391918242458;20880.686789698168;21129.366119016417;21136.57726845462;20976.37070887876;21517.67723484149;21835.344939651837;22517.774822251773;22734.090636374567;6477.805665830033;6829.624370659637;6848.863022739567;6861.348171923659;6891.448684105285;6584.670766461658;6631.577896071985;6731.259561448237;6736.427403670694;6753.93246067538;6711.6979735911755;6717.1939367276;6718.764843230488;6733.989901514763;6741.730330786762;7033.402160816337;7710;7745.535267883889;7784.338331241851;7822.335101516321;7112.608806515639;7412.666430010662;7488.475806693534;7505.061867266591;7537.321641052276;26663.333416664544;27279.318017049533;27321.31696707598;28001.85999070012;28265.57601635977;2837.601717338118;2857.7713782897317;2876.5685147227873;2888.725571070745;3016.0650198438334;13893.652658683613;14526.927365363212;16269.430569929995;16790.076545789976;17076.316947322215;2114.672225804987;2141.7108690326763;2151.9246826361004;2177.6951226828255;2181.2910803988766;137738;143965.99999999895;148986;156862;159094.2045289766;17196.914015429844;18131;21938.122475101136;22568.66147007796;23552.411189720395;42410.57589424066;42528.787356063025;42704.78647606742;42721.35917961233;42776.369662701705;9982.358203435293;10996.340219586851;11036.834447483294;11222.607208747819;11392.202545821712;8340.541270230075;8807.955960220286;8818.86771698425;9006.504642244608;9016.909830901739;10839.983808986088;11128.299667376737;11154;11306.434678266218;11320.433978301053;4443.888902777457;4485.282354823213;4506.864794056183;4532.184206842734;4538.977305113453;926.1988380051207;936.3211671538216;976.9658061967797;1030.8247597908223;1031.7103620474406;20671.59320753581;22457.877106144955;22878.42803929915;23164.65253021206;23165.88417057904;1055.984160237597;1059.862217911682;1094.1301665176204;1096.8702236696215;1097.3744965369822;10524.842127368096;11226.887731122584;12016.962312608233;12144.574939877239;12186.390680465942;674257;689357;708183;714155;735362;106046;112966;128776;135994;149509;1207.2756346192214;1231.846019247594;1242.3663931395233;1269.2955409747678;1271.6884363330857;20948.266810661553;21825.56348872982;21833.344999650035;21838.89080554587;21896.45258868541;59301.406985929585;62074;62692;63469.682651586445;63502.36497635149;83708.74436883573;86470.56764716136;87214;88636;88638;7712.383009359126;11407.372594507382;11783.821617838148;11888.372185357963;12014.399280035788;10632.89367106319;13390.93304533471;13732.519361822287;13886.166829990232;14079.648008799863;11338.489767960296;11537.48081336325;11845.348505832262;11899.405029748652;11940.46267917963;11378.260413073123;11468.82796758066;11486.770264594494;11574.958253757202;11847.526098955945;11646.94176529112;11686.298822070703;11979.101567382308;12059.21615095016;12072.698182545155;12015.699607509881;12087.697807554881;12113.286727195022;12395.566155184526;12459.875401245872;11589.420528973349;11731.648050558497;11924.463399147233;11963.222390544586;11983.243853913475 10:12:30 INFO - PID 1635 | |3;mootools.html;1544.3822471011601;1565.412970136199;1597.1215831292793;1605.6307049378638;1658.5190294814504;10226.642067527639;10659.573617055328;10675.092617127544;10688.893111068886;10711.732206694816;10294.845577316346;10786.460676966159;10803;10829.350238985666;10906.727331816708;2316.756740542244;2359.3393849722106;2366.479374537599;2369.087901158058;2370;2192.1450634252656;2279.575265459088;2320.373499155227;2358.127492827656;2359.0327965534134;2322.883855807211;2326.7905888470036;2343.250159948817;2344.6951896253463;2346.6245400735884;2285.3943704918042;2305.5504176685554;2311.0986715181093;2313.7339205991357;2314.4329639238326;2250.5723912456583;2322.7328857181474;2323.2101085630966;2323.8838058097026;2329.615613423783;11119.221654484189;11213.943930280378;11217.607383741612;11244.718882028015;11247.83128253077;5655.745491452894;5884;5900.085486749561;5912.4974377178;5917.733701983421;3348.162959260185;3393.4400823864034;3606.314800187982;3638.326909521747;3642.7085833133287;1124.3647339253296;1156.6587856582328;1201.5374080978886;1223.1132428989001;1230.5569994801865;13366.665833354147;14125.081869678437;14694.853051469456;15496.147711875843;15525.068495890282;3824.2160357126722;4486.7083639563325;4614.353990441341;4617.515160908057;4625.745583992845;11439.313641181556;11450.427478626201;11451.026662733595;11455.083593312514;11462.598809041643;4797.112534181188;5641.182028605829;5645.068563686946;5645.350784659735;5654.434556544313;4409.2724700424715;5152.639315247971;5181.715005674724;5199.766010529535;5203.16749320107;3636;3773.415120656303;3825.6748176405317;3870.670992965573;3875.748076375027;1026.856240126383;1027.6403258859489;1028.275066078413;1039.9168066554657;1045.6758404894506;764.8087978005499;797.3740613618281;804.2480280937342;815.152241668658;825.1294883897546;5642.4075472075665;6366.713497892606;6375.354227995423;6655.101561289261;6783.219929708147;847.8088285958239;909.2271569166288;939.9718008459621;950.843110886696;986.5215370545279;3894.2406230784727;3903.921921561553;4001.1197536541913;4123.948393159725;4156.896077598024;12897.48410063587;13929.651758706113;14075.366608502642;14102.435902563782;14115.435382584581;13659;13692.65768355799;13917.721645567031;13980.930095349458;13991.510297139552;9997.550110245056;10098.394096354243;10124.645637402655;10255.897441025792;10263.794724105475;6251.812445626639;6351.96824015877;6396.808095757135;6426.614403135827;6494.188226471691;11516.596919107791;11997.580084696994;12248.142630015813;12299.200551964093;12327.321997290235;9323.114304141096;9867.753306167404;12434.316112613893;12482.438290277141;12513.687157821127;8896.955515222382;8909.599068042084;8940.552972351486;9118.908810911806;9197.264218862609;9969.551370188505;10167.237457190593;10214.591416343561;10230.48847557634;10232.386056836614;7648.808779780327;8638.308935285037;8899.644014239617;8899.955500222457;8951.35457276928;8657.047724750399;8732.56337183151;8823.161799629024;8922.330825188266;8963.820723585623;7687.423443241891;7820.335271501758;7823.3350165234315;7833.451658383859;7834.216578342121;5611.663300202001;5694.829155125353;5825.94174058254;5907.49786268172;5911.379305172895;5721.971390143022;5722.599418040697;5932.525397968238;5966.76132954677;6118.082287656887 10:12:30 INFO - PID 1635 | |4;prototype.html;367.61951380321375;368.4804425759679;379.5407556856204;382.08490664857686;386.1947838756193;5493.697846618435;5571.164325351189;5607.635503692257;5692.003899317623;6027.789027384037;5159.690418574888;5389.973050134744;5586.352026152284;5692.686902220386;5743.655380677163;4664.906701865961;4827.7586120694;4829.420469543642;4859.885949611912;5002.974985125087;4982.800687972477;4996.675216110959;5004.774785134659;5010.949890501085;5028.195488721805;4525.47956984946;4657.836975705851;5010.198368261079;5017.523335283142;5019.222020586815;4912.9642116830355;4954.20732682769;5054.772535235923;5068.315777370045;5082.517160869711;4467.664925130595;4720.268358404453;4743.478217396084;4758.287775967699;4772.308015337791;4394.956050439519;4647.488776234612;4888.951110488885;4936.925946110811;5661.743773130673;5559.997601295296;5665.263515742927;5822.155787410802;5861.267341582302;5912.906112369183;4655.557722016403;6241.906371404432;6259.467945224661;6267.4986001119805;6267.62394256346;5056.62075344347;5095.566876815476;5333.200019997032;5380.7309634518115;5388.515033646991;5542.891421715673;5640.277416904864;6074.908876366858;6523.434375749834;6626.469882409396;4099.795010249476;5342.198670199501;5522.475364840334;5530.419305972815;5550.639208451518;5631.7747290108755;5650.5479561634975;5660.915086273709;5668.943310566924;5693.743781529841;4804.735739534359;5623.297087864017;5771.874484475487;5886.764529418861;5898.292204935349;5580.972095139498;6012.308584512837;6283.3402492737605;6287.591306565058;6290.634510536841;1659;1758.821589534989;1821.122626250521;1841.2174825699024;1894.8294653480978;1285.9485620575072;1306.9281189534477;1308.1954597922208;1308.2542950518114;1312.4840808865774;4787.640926930494;4852.951470485321;5068.898622027539;5598.2442370280305;5842.298924129047;5803.564732645069;6018.879622407528;6306.716197771111;6416.412265230383;6452.354764523604;5612.410696876851;5783.306003279633;5803.448672376117;5833.7374818133285;5845.707714614337;2813.5779633055204;3335.9666403335655;3346.665333466634;3368.292658541685;3384.627690953993;5032.7735251913755;6072.483838873657;6328.810135695937;6367.758287133965;6609.20689517261;6298.968505157445;6480;6521.6413097279155;6555.066959824067;6601.3068627794355;5091.338126043591;5223.817166399158;5428.5928555358505;6619.172603424572;6620.503462240351;5172.7413629319135;5401.513863752281;5868.2077919482035;6337.65142917144;6356.586821856565;5581.190727344593;5696.629719068247;5936.376680448663;5995.9700201500455;6173.351798061319;6126.877462450815;6203.65879876593;6257.78097766576;6510.18622672166;6572.342765723581;4792.137415265286;4965.726885021359;4976.626752993612;4998.275250088789;5026.396832380138;6313.210848643919;6374.394432528902;6388.840278993062;6435.678216089271;6489.967550162219;5210.843674689765;6113.628755439881;6191.9690401547705;6220.813375598739;6270.529710271839;5800.7099645018425;6064.909026364697;6115.816525504064;6123.571350005457;6171.413715697002;5041.319421878;5252.579793616578;6047.304559975483;6089.299730530868;6091.9086213707715;5161.509656582619;5812.94187058124;6149.692515374124;6287.528435367274;6290.402411770874;5267.947320526746;6043.8186854394435;6060.000299851602;6076.817695469143;6136.417040381157 10:12:30 INFO - PID 1635 | |5;yui.html;758.9468737188396;766.7584710816093;811.5374236685088;812.317653171336;823.3865770001343;15513.379464821408;15866.12736299503;15912.52262432129;15955.202239888004;16003.959742616737;14760.6309842254;14937.253137343143;14974.25128743564;14974.32615532301;14980.925095374536;793.488200110931;900.459724165502;931.3480563605469;932.6828878181417;938.2212763406357;859.3426029087752;943.0710749911332;943.79708362702;958.8945216026232;960.346964064436;842.5366048673236;1005.1958433253404;1005.8742657167854;1007.9949600252025;1008.2740426892625;1002.9869831470195;1003.8494225866142;1004.0862814838534;1005.3415013166388;1007.425767312632;743.9032925719675;746.4177941205813;746.4588173574169;749.3106342165221;750.3996802557987;13904;16022.679546409006;16600.83399166005;16928.322867085426;17025.404110856183;14555.854441455662;14621.853781462156;14684.17636191144;14744;14761.77857332141;11483.712907177387;11572.53709851605;11686.41567921609;11866.762664746657;12111.576094836639;3582.874599389009;3722.7766334020043;3750.887473375803;3759.2293579816073;3883.8834834954996;110736;112001;112284.37372905728;113620.29569556464;114331.85668143378;10040.046195611405;10474.947625261824;11345.716357091138;11489.368084755251;11899.702507437383;22765.544689106126;23545.7645423547;25075.62386564203;25095.62356564653;25162;7908.406869484812;7928.207179282141;8013.2387423194705;8051.83896322082;8140.063892652421;4244.236037513278;4272.636825869836;4327.7186982846015;4461.085477477174;4475.753833539186;3392.6776956189124;3474.6699063588917;3477.7739446935866;3479.634638362986;3500.824958752052;568.3322096536635;620.227816368615;624.1573875268351;634.429013887505;649.2014821769251;646.7251418147268;648.4747354642755;690.8756423843756;714.4391652552721;721.7870728135213;9145;9444.8583271251;9491.620335186653;9984.400935943866;10354.378737275787;628.4658040665398;684.910961574992;699.5872435263118;709.5848928376854;711.8149281186825;4154.563770804082;4369.519352871182;4826.831060912921;4830.7101573905675;4832.323474713543;73783.63108184424;92128.53935730278;96339;97381;98368.53547138965;57878;87046.56476717576;87839;87840.12159878448;89306;80388.59805700934;80755.59622201852;80788.59605701934;80920.59539702382;81664.84878532474;9361.251099912128;9442.716718498456;9478.85781713261;9548.809023819345;9552.808943820946;39944.00139996524;50263.74868125636;50958;51837.48162518477;52159.478405215465;52422;66497.33502665105;66655.33344666491;66680.6665966667;68081.65959170173;11146.665600032013;11387.886121138683;11578;12142.514299427923;12191.695207619881;12130.514779408724;12418.937905310777;12602.054845886412;12777.616671499869;12989;10512.535900409808;10526.263161578616;10653.530052480504;10691.465426728788;10877.456127193767;11732.882671173178;11753.412329383325;11779.411029448665;11804.350760708243;11863.228890122115;11921;12061.698457538632;12815.935920320338;13125;13231.206127632373;10777.838332424863;10800.729981750519;10822.242443028912;10954.780904381709;11415.885841141482;8854.424462409923;9082.62771978549;10552.947235263775;10800.837987430037;10872.021518063413 10:12:30 INFO - PID 1635 | __end_tp_report 10:12:30 INFO - PID 1635 | __start_cc_report 10:12:30 INFO - PID 1635 | _x_x_mozilla_cycle_collect,1894 10:12:30 INFO - PID 1635 | __end_cc_report 10:12:30 INFO - PID 1635 | __startTimestamp1490029950218__endTimestamp 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | ------- Summary: start ------- 10:12:30 INFO - PID 1635 | Number of tests: 6 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5897.53 Median:6130.45 stddev:646.02 (10.5%) stddev-sans-first:618.09 10:12:30 INFO - PID 1635 | Values: 3420.9 3423.2 3431.3 3470.0 3482.1 5139.8 5770.0 6022.8 6051.1 6086.1 5937.1 6034.2 6057.2 6086.6 6093.2 4499.5 5297.2 5350.0 5370.3 5374.2 5474.9 5496.5 5501.5 5519.7 5545.7 5318.7 5377.6 5383.6 5392.1 5470.2 5466.6 5480.7 5483.6 5485.0 5492.4 5320.6 5367.4 5369.3 5372.0 5374.5 6012.5 6018.7 6020.2 6024.1 6043.5 6227.6 6238.3 6280.0 6296.5 6298.2 6351.0 6374.6 6383.0 6386.2 6392.5 5967.4 6101.9 6116.0 6125.8 6130.4 5493.6 6306.9 6382.0 6546.8 6550.4 5984.3 6229.2 6284.7 6289.0 6289.5 6346.8 6354.1 6354.6 6359.3 6374.2 6220.0 6294.1 6303.3 6307.8 6323.3 6229.1 6241.0 6250.2 6255.5 6287.2 5154.7 5157.3 5159.1 5187.2 5190.7 4579.5 4586.7 4592.0 4607.1 4622.2 5923.2 6015.3 6037.1 6098.5 6104.5 6249.4 6255.2 6257.6 6271.7 6286.9 6006.0 6028.8 6032.1 6046.9 6051.4 5572.6 5572.7 5574.9 5575.6 5578.0 6554.2 6561.1 6561.8 6563.0 6578.3 5325.8 5327.9 6323.8 6336.6 6430.8 6624.3 6628.0 6637.1 6639.5 6660.8 6294.1 6308.3 6313.7 6317.1 6321.1 6214.2 6217.2 6252.5 6329.6 6345.6 6173.5 6219.3 6264.2 6266.9 6269.5 6080.8 6228.3 6231.9 6257.8 6262.2 6065.1 6103.9 6213.0 6223.2 6227.3 5121.4 6193.3 6247.7 6274.9 6283.9 6211.8 6216.2 6222.1 6226.4 6231.1 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:54350.60 Median:34144.41 stddev:107807.40 (315.7%) stddev-sans-first:108034.77 10:12:30 INFO - PID 1635 | Values: 768.3 790.8 853.0 864.9 867.3 36787.8 37577.7 37624.6 37645.0 37677.4 38812.4 39171.6 39217.2 39244.6 39370.4 7348.7 9108.6 9314.5 9327.7 9349.9 7434.4 10798.1 10983.5 11021.3 11025.4 11070.3 11162.1 11181.3 11187.7 11197.3 7313.0 11048.5 11127.3 11158.1 11197.9 7365.1 7440.6 7461.1 7485.7 10581.5 38134.0 38528.0 38554.8 38586.0 38711.6 3774.9 3781.8 3790.2 3803.5 3860.0 28212.9 28304.9 28530.7 29143.7 29795.0 3124.6 3126.2 3139.8 3151.2 3226.3 326615.4 328141.0 328340.0 328507.0 329094.0 38949.6 39633.0 51900.8 52007.7 52139.6 41656.0 49840.0 50232.2 50631.7 50689.0 14679.4 14793.4 14805.0 14806.9 14813.6 11993.9 12018.3 12034.3 12036.3 12043.7 12955.7 12970.3 12992.5 13016.2 13099.3 5322.2 5381.4 5390.5 5393.8 5400.2 1057.4 1061.7 1078.2 1080.1 1146.4 26787.5 27207.0 27626.6 27635.3 27706.7 1008.8 1131.4 1134.7 1158.4 1184.6 13473.7 13563.0 13797.0 13990.8 14283.1 452082.7 453892.0 454720.0 455024.0 455400.0 56715.6 56722.7 56740.1 56794.7 56991.0 1399.1 1453.9 1454.1 1457.6 1465.3 26245.5 26646.7 26823.9 27022.9 27054.6 47842.8 47932.0 47982.3 48018.3 48039.0 426179.0 426577.0 427675.0 427832.0 428011.0 26119.0 26647.6 31061.1 31968.7 34387.8 41240.4 41443.0 42047.4 42070.8 42080.0 33901.0 35366.8 36475.9 36658.9 36943.4 29237.0 34704.5 34846.8 36194.3 37068.3 29378.3 35000.8 35833.8 35909.3 35990.5 24863.6 27960.6 31440.0 31462.7 31469.2 21595.0 23719.6 24010.0 24014.6 24123.6 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:41574.78 Median:12003.43 stddev:117130.20 (975.8%) stddev-sans-first:117417.96 10:12:30 INFO - PID 1635 | Values: 391.5 394.3 407.2 407.7 423.1 18757.8 20269.4 20880.7 21129.4 21136.6 20976.4 21517.7 21835.3 22517.8 22734.1 6477.8 6829.6 6848.9 6861.3 6891.4 6584.7 6631.6 6731.3 6736.4 6753.9 6711.7 6717.2 6718.8 6734.0 6741.7 7033.4 7710.0 7745.5 7784.3 7822.3 7112.6 7412.7 7488.5 7505.1 7537.3 26663.3 27279.3 27321.3 28001.9 28265.6 2837.6 2857.8 2876.6 2888.7 3016.1 13893.7 14526.9 16269.4 16790.1 17076.3 2114.7 2141.7 2151.9 2177.7 2181.3 137738.0 143966.0 148986.0 156862.0 159094.2 17196.9 18131.0 21938.1 22568.7 23552.4 42410.6 42528.8 42704.8 42721.4 42776.4 9982.4 10996.3 11036.8 11222.6 11392.2 8340.5 8808.0 8818.9 9006.5 9016.9 10840.0 11128.3 11154.0 11306.4 11320.4 4443.9 4485.3 4506.9 4532.2 4539.0 926.2 936.3 977.0 1030.8 1031.7 20671.6 22457.9 22878.4 23164.7 23165.9 1056.0 1059.9 1094.1 1096.9 1097.4 10524.8 11226.9 12017.0 12144.6 12186.4 674257.0 689357.0 708183.0 714155.0 735362.0 106046.0 112966.0 128776.0 135994.0 149509.0 1207.3 1231.8 1242.4 1269.3 1271.7 20948.3 21825.6 21833.3 21838.9 21896.5 59301.4 62074.0 62692.0 63469.7 63502.4 83708.7 86470.6 87214.0 88636.0 88638.0 7712.4 11407.4 11783.8 11888.4 12014.4 10632.9 13390.9 13732.5 13886.2 14079.6 11338.5 11537.5 11845.3 11899.4 11940.5 11378.3 11468.8 11486.8 11575.0 11847.5 11646.9 11686.3 11979.1 12059.2 12072.7 12015.7 12087.7 12113.3 12395.6 12459.9 11589.4 11731.6 11924.5 11963.2 11983.2 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:6610.04 Median:2859.08 stddev:4167.55 (145.8%) stddev-sans-first:4161.86 10:12:30 INFO - PID 1635 | Values: 1544.4 1565.4 1597.1 1605.6 1658.5 10226.6 10659.6 10675.1 10688.9 10711.7 10294.8 10786.5 10803.0 10829.4 10906.7 2316.8 2359.3 2366.5 2369.1 2370.0 2192.1 2279.6 2320.4 2358.1 2359.0 2322.9 2326.8 2343.3 2344.7 2346.6 2285.4 2305.6 2311.1 2313.7 2314.4 2250.6 2322.7 2323.2 2323.9 2329.6 11119.2 11213.9 11217.6 11244.7 11247.8 5655.7 5884.0 5900.1 5912.5 5917.7 3348.2 3393.4 3606.3 3638.3 3642.7 1124.4 1156.7 1201.5 1223.1 1230.6 13366.7 14125.1 14694.9 15496.1 15525.1 3824.2 4486.7 4614.4 4617.5 4625.7 11439.3 11450.4 11451.0 11455.1 11462.6 4797.1 5641.2 5645.1 5645.4 5654.4 4409.3 5152.6 5181.7 5199.8 5203.2 3636.0 3773.4 3825.7 3870.7 3875.7 1026.9 1027.6 1028.3 1039.9 1045.7 764.8 797.4 804.2 815.2 825.1 5642.4 6366.7 6375.4 6655.1 6783.2 847.8 909.2 940.0 950.8 986.5 3894.2 3903.9 4001.1 4123.9 4156.9 12897.5 13929.7 14075.4 14102.4 14115.4 13659.0 13692.7 13917.7 13980.9 13991.5 9997.6 10098.4 10124.6 10255.9 10263.8 6251.8 6352.0 6396.8 6426.6 6494.2 11516.6 11997.6 12248.1 12299.2 12327.3 9323.1 9867.8 12434.3 12482.4 12513.7 8897.0 8909.6 8940.6 9118.9 9197.3 9969.6 10167.2 10214.6 10230.5 10232.4 7648.8 8638.3 8899.6 8900.0 8951.4 8657.0 8732.6 8823.2 8922.3 8963.8 7687.4 7820.3 7823.3 7833.5 7834.2 5611.7 5694.8 5825.9 5907.5 5911.4 5722.0 5722.6 5932.5 5966.8 6118.1 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5205.50 Median:5610.02 stddev:1415.37 (25.2%) stddev-sans-first:1371.97 10:12:30 INFO - PID 1635 | Values: 367.6 368.5 379.5 382.1 386.2 5493.7 5571.2 5607.6 5692.0 6027.8 5159.7 5390.0 5586.4 5692.7 5743.7 4664.9 4827.8 4829.4 4859.9 5003.0 4982.8 4996.7 5004.8 5010.9 5028.2 4525.5 4657.8 5010.2 5017.5 5019.2 4913.0 4954.2 5054.8 5068.3 5082.5 4467.7 4720.3 4743.5 4758.3 4772.3 4395.0 4647.5 4889.0 4936.9 5661.7 5560.0 5665.3 5822.2 5861.3 5912.9 4655.6 6241.9 6259.5 6267.5 6267.6 5056.6 5095.6 5333.2 5380.7 5388.5 5542.9 5640.3 6074.9 6523.4 6626.5 4099.8 5342.2 5522.5 5530.4 5550.6 5631.8 5650.5 5660.9 5668.9 5693.7 4804.7 5623.3 5771.9 5886.8 5898.3 5581.0 6012.3 6283.3 6287.6 6290.6 1659.0 1758.8 1821.1 1841.2 1894.8 1285.9 1306.9 1308.2 1308.3 1312.5 4787.6 4853.0 5068.9 5598.2 5842.3 5803.6 6018.9 6306.7 6416.4 6452.4 5612.4 5783.3 5803.4 5833.7 5845.7 2813.6 3336.0 3346.7 3368.3 3384.6 5032.8 6072.5 6328.8 6367.8 6609.2 6299.0 6480.0 6521.6 6555.1 6601.3 5091.3 5223.8 5428.6 6619.2 6620.5 5172.7 5401.5 5868.2 6337.7 6356.6 5581.2 5696.6 5936.4 5996.0 6173.4 6126.9 6203.7 6257.8 6510.2 6572.3 4792.1 4965.7 4976.6 4998.3 5026.4 6313.2 6374.4 6388.8 6435.7 6490.0 5210.8 6113.6 6192.0 6220.8 6270.5 5800.7 6064.9 6115.8 6123.6 6171.4 5041.3 5252.6 6047.3 6089.3 6091.9 5161.5 5812.9 6149.7 6287.5 6290.4 5267.9 6043.8 6060.0 6076.8 6136.4 10:12:30 INFO - PID 1635 | 10:12:30 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:19995.99 Median:3755.06 stddev:28845.79 (768.2%) stddev-sans-first:28890.55 10:12:30 INFO - PID 1635 | Values: 758.9 766.8 811.5 812.3 823.4 15513.4 15866.1 15912.5 15955.2 16004.0 14760.6 14937.3 14974.3 14974.3 14980.9 793.5 900.5 931.3 932.7 938.2 859.3 943.1 943.8 958.9 960.3 842.5 1005.2 1005.9 1008.0 1008.3 1003.0 1003.8 1004.1 1005.3 1007.4 743.9 746.4 746.5 749.3 750.4 13904.0 16022.7 16600.8 16928.3 17025.4 14555.9 14621.9 14684.2 14744.0 14761.8 11483.7 11572.5 11686.4 11866.8 12111.6 3582.9 3722.8 3750.9 3759.2 3883.9 110736.0 112001.0 112284.4 113620.3 114331.9 10040.0 10474.9 11345.7 11489.4 11899.7 22765.5 23545.8 25075.6 25095.6 25162.0 7908.4 7928.2 8013.2 8051.8 8140.1 4244.2 4272.6 4327.7 4461.1 4475.8 3392.7 3474.7 3477.8 3479.6 3500.8 568.3 620.2 624.2 634.4 649.2 646.7 648.5 690.9 714.4 721.8 9145.0 9444.9 9491.6 9984.4 10354.4 628.5 684.9 699.6 709.6 711.8 4154.6 4369.5 4826.8 4830.7 4832.3 73783.6 92128.5 96339.0 97381.0 98368.5 57878.0 87046.6 87839.0 87840.1 89306.0 80388.6 80755.6 80788.6 80920.6 81664.8 9361.3 9442.7 9478.9 9548.8 9552.8 39944.0 50263.7 50958.0 51837.5 52159.5 52422.0 66497.3 66655.3 66680.7 68081.7 11146.7 11387.9 11578.0 12142.5 12191.7 12130.5 12418.9 12602.1 12777.6 12989.0 10512.5 10526.3 10653.5 10691.5 10877.5 11732.9 11753.4 11779.4 11804.4 11863.2 11921.0 12061.7 12815.9 13125.0 13231.2 10777.8 10800.7 10822.2 10954.8 11415.9 8854.4 9082.6 10552.9 10800.8 10872.0 10:12:30 INFO - PID 1635 | -------- Summary: end -------- 10:12:30 INFO - PID 1635 | 10:12:30 INFO - TEST-INFO | 1635: exit 0 10:12:30 INFO - TEST-OK | dromaeo_css | took 1121140ms 10:12:30 INFO - TEST-START | kraken 10:12:30 INFO - operating with platform_type : mac_ 10:12:30 INFO - Initialising browser for kraken test... 10:12:30 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpXI0EQS/profile http://localhost:49241/getInfo.html) 10:12:33 INFO - PID 1644 | __metrics Screen width/height:1600/1200 10:12:33 INFO - PID 1644 | colorDepth:24 10:12:33 INFO - PID 1644 | Browser inner width/height: 1024/689 10:12:33 INFO - PID 1644 | __metrics 10:12:33 INFO - PID 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:12:33 INFO - PID 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:12:34 INFO - TEST-INFO | 1644: exit 0 10:12:34 INFO - Browser initialized. 10:12:34 INFO - Running cycle 1/1 for kraken test... 10:12:34 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpXI0EQS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:46 INFO - PID 1645 | RSS: Main: 233529344 10:12:46 INFO - PID 1645 | 10:12:49 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:50 INFO - PID 1645 | RSS: Main: 286208000 10:12:50 INFO - PID 1645 | 10:12:53 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:12:53 INFO - PID 1645 | RSS: Main: 287731712 10:12:53 INFO - PID 1645 | 10:12:57 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:12:57 INFO - PID 1645 | RSS: Main: 378023936 10:12:57 INFO - PID 1645 | 10:12:59 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:13:00 INFO - PID 1645 | RSS: Main: 281341952 10:13:00 INFO - PID 1645 | 10:13:02 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:13:02 INFO - PID 1645 | RSS: Main: 284733440 10:13:02 INFO - PID 1645 | 10:13:05 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:13:06 INFO - PID 1645 | RSS: Main: 325455872 10:13:06 INFO - PID 1645 | 10:13:09 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:13:10 INFO - PID 1645 | RSS: Main: 335429632 10:13:10 INFO - PID 1645 | 10:13:13 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:13:13 INFO - PID 1645 | RSS: Main: 343015424 10:13:13 INFO - PID 1645 | 10:13:15 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:13:16 INFO - PID 1645 | RSS: Main: 301481984 10:13:16 INFO - PID 1645 | 10:13:17 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:13:18 INFO - PID 1645 | RSS: Main: 304140288 10:13:18 INFO - PID 1645 | 10:13:20 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:13:21 INFO - PID 1645 | RSS: Main: 307015680 10:13:21 INFO - PID 1645 | 10:13:24 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:13:25 INFO - PID 1645 | RSS: Main: 327020544 10:13:25 INFO - PID 1645 | 10:13:28 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:13:28 INFO - PID 1645 | RSS: Main: 321159168 10:13:28 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:13:30 INFO - PID 1645 | RSS: Main: 383913984 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | __start_tp_report 10:13:30 INFO - PID 1645 | _x_x_mozilla_page_load 10:13:30 INFO - PID 1645 | _x_x_mozilla_page_load_details 10:13:30 INFO - PID 1645 | |i|pagename|runs| 10:13:30 INFO - PID 1645 | |0;ai-astar;123;171;148;115;116;117;115;115;115;116 10:13:30 INFO - PID 1645 | |1;audio-beat-detection;147;112;112;153;114;112;112;112;154;146 10:13:30 INFO - PID 1645 | |2;audio-dft;184;184;187;186;183;182;183;184;184;184 10:13:30 INFO - PID 1645 | |3;audio-fft;81;59;60;89;61;61;58;62;74;61 10:13:30 INFO - PID 1645 | |4;audio-oscillator;85;70;88;68;69;68;84;70;69;86 10:13:30 INFO - PID 1645 | |5;imaging-gaussian-blur;94;86;87;88;88;87;88;88;88;88 10:13:30 INFO - PID 1645 | |6;imaging-darkroom;95;94;96;95;95;94;96;94;95;94 10:13:30 INFO - PID 1645 | |7;imaging-desaturate;83;84;84;83;84;83;83;83;84;100 10:13:30 INFO - PID 1645 | |8;json-parse-financial;62;62;62;62;62;61;60;63;61;61 10:13:30 INFO - PID 1645 | |9;json-stringify-tinderbox;55;60;64;63;59;58;58;59;59;60 10:13:30 INFO - PID 1645 | |10;stanford-crypto-aes;81;82;82;84;84;83;83;82;82;83 10:13:30 INFO - PID 1645 | |11;stanford-crypto-ccm;144;159;139;143;142;152;148;139;185;156 10:13:30 INFO - PID 1645 | |12;stanford-crypto-pbkdf2;188;186;188;185;185;186;186;187;185;187 10:13:30 INFO - PID 1645 | |13;stanford-crypto-sha256-iterative;68;67;67;64;67;65;69;68;68;68 10:13:30 INFO - PID 1645 | __end_tp_report 10:13:30 INFO - PID 1645 | __start_cc_report 10:13:30 INFO - PID 1645 | _x_x_mozilla_cycle_collect,2178 10:13:30 INFO - PID 1645 | __end_cc_report 10:13:30 INFO - PID 1645 | __startTimestamp1490030010874__endTimestamp 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | ------- Summary: start ------- 10:13:30 INFO - PID 1645 | Number of tests: 14 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#0] ai-astar Cycles:10 Average:125.10 Median:116.50 stddev:19.08 (16.4%) stddev-sans-first:20.22 10:13:30 INFO - PID 1645 | Values: 123.0 171.0 148.0 115.0 116.0 117.0 115.0 115.0 115.0 116.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:130.00 stddev:19.60 (15.1%) stddev-sans-first:19.47 10:13:30 INFO - PID 1645 | Values: 147.0 112.0 112.0 153.0 114.0 112.0 112.0 112.0 154.0 146.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.00 stddev:1.45 (0.8%) stddev-sans-first:1.54 10:13:30 INFO - PID 1645 | Values: 184.0 184.0 187.0 186.0 183.0 182.0 183.0 184.0 184.0 184.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#3] audio-fft Cycles:10 Average:66.60 Median:61.50 stddev:10.82 (17.6%) stddev-sans-first:10.15 10:13:30 INFO - PID 1645 | Values: 81.0 59.0 60.0 89.0 61.0 61.0 58.0 62.0 74.0 61.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:77.00 stddev:8.73 (11.3%) stddev-sans-first:8.59 10:13:30 INFO - PID 1645 | Values: 85.0 70.0 88.0 68.0 69.0 68.0 84.0 70.0 69.0 86.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:2.15 (2.4%) stddev-sans-first:0.73 10:13:30 INFO - PID 1645 | Values: 94.0 86.0 87.0 88.0 88.0 87.0 88.0 88.0 88.0 88.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 10:13:30 INFO - PID 1645 | Values: 95.0 94.0 96.0 95.0 95.0 94.0 96.0 94.0 95.0 94.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:83.50 stddev:5.26 (6.3%) stddev-sans-first:5.52 10:13:30 INFO - PID 1645 | Values: 83.0 84.0 84.0 83.0 84.0 83.0 83.0 83.0 84.0 100.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:0.84 (1.4%) stddev-sans-first:0.88 10:13:30 INFO - PID 1645 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 60.0 63.0 61.0 61.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:2.55 (4.3%) stddev-sans-first:2.12 10:13:30 INFO - PID 1645 | Values: 55.0 60.0 64.0 63.0 59.0 58.0 58.0 59.0 59.0 60.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:0.83 10:13:30 INFO - PID 1645 | Values: 81.0 82.0 82.0 84.0 84.0 83.0 83.0 82.0 82.0 83.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:150.00 stddev:13.89 (9.3%) stddev-sans-first:14.52 10:13:30 INFO - PID 1645 | Values: 144.0 159.0 139.0 143.0 142.0 152.0 148.0 139.0 185.0 156.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:186.50 stddev:1.16 (0.6%) stddev-sans-first:1.05 10:13:30 INFO - PID 1645 | Values: 188.0 186.0 188.0 185.0 185.0 186.0 186.0 187.0 185.0 187.0 10:13:30 INFO - PID 1645 | 10:13:30 INFO - PID 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.58 10:13:30 INFO - PID 1645 | Values: 68.0 67.0 67.0 64.0 67.0 65.0 69.0 68.0 68.0 68.0 10:13:30 INFO - PID 1645 | -------- Summary: end -------- 10:13:30 INFO - PID 1645 | 10:13:31 INFO - TEST-INFO | 1645: exit 0 10:13:31 INFO - TEST-OK | kraken | took 60904ms 10:13:31 INFO - SUITE-END | took 1182s 10:13:32 INFO - Completed test suite (00:19:42) 10:13:32 INFO - javascript benchmark 10:13:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7841.711206869581, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.914477138071, 3423.212661087948, 3431.2794313194227, 3469.98265008675, 3482.077249528874, 5139.792148845018, 5770.0, 6022.7590896364145, 6051.122587224855, 6086.056661217507, 5937.079752638338, 6034.155218269435, 6057.242844644419, 6086.573939824214, 6093.207882975207, 4499.48255950565, 5297.205419187114, 5350.0, 5370.275012873251, 5374.193870919355, 5474.863128421782, 5496.450354964491, 5501.504864562188, 5519.668819870801, 5545.667259964415, 5318.734063296858, 5377.596680248997, 5383.623146379755, 5392.137258038734, 5470.17947307905, 5466.590005749545, 5480.671159730389, 5483.561315094783, 5484.972575137139, 5492.423295553949, 5320.574354051705, 5367.355917289911, 5369.301990741218, 5372.0330340538685, 5374.54316383104, 6012.458878700938, 6018.729157187937, 6020.247469066367, 6024.126501657279, 6043.546733994968, 6227.595206311576, 6238.2825975013, 6280.0, 6296.496280297565, 6298.2442106947, 6351.0, 6374.617522948592, 6383.010633351838, 6386.2336519617475, 6392.520560957947, 5967.43309385612, 6101.877962440771, 6116.0, 6125.78559750411, 6130.448259656652, 5493.6496525281345, 6306.873862522724, 6382.0, 6546.8363290918105, 6550.377714117151, 5984.251968503937, 6229.190205273376, 6284.748610055638, 6288.968555157195, 6289.496840252768, 6346.809595712136, 6354.078658594478, 6354.618722876642, 6359.300476947532, 6374.235091789015, 6220.0, 6294.0558916162945, 6303.338149494329, 6307.842303942346, 6323.336049714806, 6229.127922090911, 6241.0, 6250.249970003629, 6255.499560035186, 6287.1512345832725, 5154.7164905929785, 5157.303763991888, 5159.148740457783, 5187.19598462239, 5190.740462976836, 4579.496255411902, 4586.656000799953, 4591.977040114778, 4607.14767767964, 4622.214223581999, 5923.17075609415, 6015.2781666200335, 6037.094435834572, 6098.54260930432, 6104.542159338067, 6249.406306400884, 6255.249370075529, 6257.624542527463, 6271.749130034838, 6286.874262514724, 6006.0090085136335, 6028.819135425944, 6032.065029920369, 6046.909296360558, 6051.425114614105, 5572.554195664337, 5572.665640061609, 5574.916376254359, 5575.581831362583, 5577.9959607271085, 6554.246261679872, 6561.1470508833545, 6561.835954100995, 6563.015547667888, 6578.342165783383, 5325.786968521215, 5327.9200811987075, 6323.841903952438, 6336.619802811846, 6430.839229019312, 6624.271330153776, 6627.966860165669, 6637.070810086495, 6639.502037347122, 6660.766873159416, 6294.1188233648245, 6308.306086330408, 6313.6843157841, 6317.115603815561, 6321.11504389395, 6214.161088253209, 6217.160683307696, 6252.468540174136, 6329.556931014785, 6345.555811093179, 6173.536984726074, 6219.346968568416, 6264.185655864709, 6266.874662506633, 6269.529785266032, 6080.847978800389, 6228.314885362516, 6231.906521402092, 6257.843553911189, 6262.185915831095, 6065.120557519223, 6103.943827031667, 6212.968935155476, 6223.222097237845, 6227.314995350417, 5121.359830021247, 6193.287771906288, 6247.656378899204, 6274.874502509833, 6283.874322513616, 6211.844703882259, 6216.160818289473, 6222.066689996536, 6226.439620434002, 6231.096491008688], "value": 5857.781073426046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.2816566510312, 790.766723816474, 853.0062477214042, 864.9178328058836, 867.3104881619112, 36787.81606091969, 37577.6847810327, 37624.623753762455, 37645.0, 37677.43483847744, 38812.41781373282, 39171.60828391715, 39217.21565568687, 39244.607553924456, 39370.40944385836, 7348.706051757923, 9108.590113444894, 9314.534273286343, 9327.720168394924, 9349.85975210369, 7434.442416818733, 10798.082163016154, 10983.505742241618, 11021.338719676805, 11025.44872756363, 11070.28043177195, 11162.05122564579, 11181.32912025281, 11187.664370068871, 11197.328160310408, 7312.963435182844, 11048.502817373197, 11127.276727012719, 11158.107351411867, 11197.888021119767, 7365.116186057708, 7440.590767507785, 7461.067366579177, 7485.737999170057, 10581.470926453647, 38134.0, 38528.0, 38554.807225963974, 38586.0, 38711.61288387136, 3774.886753397375, 3781.7920014399197, 3790.1851102013197, 3803.486529318562, 3860.0, 28212.858935705397, 28304.920235932364, 28530.714692853013, 29143.70856291431, 29795.0, 3124.5811303894466, 3126.2028182813237, 3139.8116113033293, 3151.1806930198086, 3226.290216152466, 326615.36692316626, 328141.0, 328340.0, 328507.0, 329093.9999999976, 38949.610503895165, 39633.0, 51900.809919008556, 52007.69980750436, 52139.56813670805, 41655.958601035214, 49840.003199935796, 50232.246516302286, 50631.74684126556, 50689.0, 14679.412823487155, 14793.408263669548, 14805.03767255125, 14806.925965370105, 14813.629659258604, 11993.940030299967, 12018.33899135556, 12034.277943323428, 12036.277823330629, 12043.698907527381, 12955.676108097374, 12970.286634235019, 12992.545260915822, 13016.166925496891, 13099.279539625222, 5322.175062865262, 5381.3811411687375, 5390.54180394663, 5393.83818485446, 5400.162974738922, 1057.3655806516028, 1061.7239517725448, 1078.2021304234809, 1080.1250986700798, 1146.3866831245243, 26787.46425071488, 27207.0, 27626.585601215997, 27635.309117271827, 27706.72293277082, 1008.7944905837601, 1131.3551275772895, 1134.733337665648, 1158.3744777819884, 1184.603157942099, 13473.730525389437, 13562.982776291818, 13797.0, 13990.778917840951, 14283.143011419348, 452082.73958630656, 453892.0, 454720.0, 455024.0, 455400.0, 56715.58211044757, 56722.71638641781, 56740.148897766565, 56794.716026419606, 56991.0, 1399.0975820595659, 1453.9345729442412, 1454.0693955868253, 1457.5773025822605, 1465.2673663168416, 26245.4750904977, 26646.7335326652, 26823.865880670473, 27022.864885675444, 27054.594181087694, 47842.760786195846, 47932.0, 47982.28026579534, 48018.27972580484, 48039.03921921472, 426179.0, 426577.0, 427675.0, 427832.0, 428011.0, 26119.0, 26647.60028599611, 31061.068167954996, 31968.68031319657, 34387.82806085954, 41240.37053145178, 41443.0, 42047.36928946007, 42070.78964605158, 42080.0, 33901.0, 35366.82316588401, 36475.90572282836, 36658.90023299305, 36943.445848311756, 29237.0, 34704.479432809036, 34846.78036268718, 36194.27611447809, 37068.25863482769, 29378.265543361587, 35000.82499587486, 35833.82083089568, 35909.28181436409, 35990.46014309735, 24863.62704559397, 27960.58059129074, 31440.0, 31462.685373145974, 31469.213269668442, 21595.0, 23719.644205337278, 24010.0, 24014.639780403657, 24123.63814542748], "value": 18538.209984721318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.4793324877913, 394.2804382002842, 407.234399329261, 407.74719673802235, 423.14313515131875, 18757.812421875777, 20269.391918242458, 20880.686789698168, 21129.366119016417, 21136.57726845462, 20976.37070887876, 21517.67723484149, 21835.344939651837, 22517.774822251773, 22734.090636374567, 6477.805665830033, 6829.624370659637, 6848.863022739567, 6861.348171923659, 6891.448684105285, 6584.670766461658, 6631.577896071985, 6731.259561448237, 6736.427403670694, 6753.93246067538, 6711.6979735911755, 6717.1939367276, 6718.764843230488, 6733.989901514763, 6741.730330786762, 7033.402160816337, 7710.0, 7745.535267883889, 7784.338331241851, 7822.335101516321, 7112.608806515639, 7412.666430010662, 7488.475806693534, 7505.061867266591, 7537.321641052276, 26663.333416664544, 27279.318017049533, 27321.31696707598, 28001.85999070012, 28265.57601635977, 2837.601717338118, 2857.7713782897317, 2876.5685147227873, 2888.725571070745, 3016.0650198438334, 13893.652658683613, 14526.927365363212, 16269.430569929995, 16790.076545789976, 17076.316947322215, 2114.672225804987, 2141.7108690326763, 2151.9246826361004, 2177.6951226828255, 2181.2910803988766, 137738.0, 143965.99999999895, 148986.0, 156862.0, 159094.2045289766, 17196.914015429844, 18131.0, 21938.122475101136, 22568.66147007796, 23552.411189720395, 42410.57589424066, 42528.787356063025, 42704.78647606742, 42721.35917961233, 42776.369662701705, 9982.358203435293, 10996.340219586851, 11036.834447483294, 11222.607208747819, 11392.202545821712, 8340.541270230075, 8807.955960220286, 8818.86771698425, 9006.504642244608, 9016.909830901739, 10839.983808986088, 11128.299667376737, 11154.0, 11306.434678266218, 11320.433978301053, 4443.888902777457, 4485.282354823213, 4506.864794056183, 4532.184206842734, 4538.977305113453, 926.1988380051207, 936.3211671538216, 976.9658061967797, 1030.8247597908223, 1031.7103620474406, 20671.59320753581, 22457.877106144955, 22878.42803929915, 23164.65253021206, 23165.88417057904, 1055.984160237597, 1059.862217911682, 1094.1301665176204, 1096.8702236696215, 1097.3744965369822, 10524.842127368096, 11226.887731122584, 12016.962312608233, 12144.574939877239, 12186.390680465942, 674257.0, 689357.0, 708183.0, 714155.0, 735362.0, 106046.0, 112966.0, 128776.0, 135994.0, 149509.0, 1207.2756346192214, 1231.846019247594, 1242.3663931395233, 1269.2955409747678, 1271.6884363330857, 20948.266810661553, 21825.56348872982, 21833.344999650035, 21838.89080554587, 21896.45258868541, 59301.406985929585, 62074.0, 62692.0, 63469.682651586445, 63502.36497635149, 83708.74436883573, 86470.56764716136, 87214.0, 88636.0, 88638.0, 7712.383009359126, 11407.372594507382, 11783.821617838148, 11888.372185357963, 12014.399280035788, 10632.89367106319, 13390.93304533471, 13732.519361822287, 13886.166829990232, 14079.648008799863, 11338.489767960296, 11537.48081336325, 11845.348505832262, 11899.405029748652, 11940.46267917963, 11378.260413073123, 11468.82796758066, 11486.770264594494, 11574.958253757202, 11847.526098955945, 11646.94176529112, 11686.298822070703, 11979.101567382308, 12059.21615095016, 12072.698182545155, 12015.699607509881, 12087.697807554881, 12113.286727195022, 12395.566155184526, 12459.875401245872, 11589.420528973349, 11731.648050558497, 11924.463399147233, 11963.222390544586, 11983.243853913475], "value": 11969.985759247882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.3822471011601, 1565.412970136199, 1597.1215831292793, 1605.6307049378638, 1658.5190294814504, 10226.642067527639, 10659.573617055328, 10675.092617127544, 10688.893111068886, 10711.732206694816, 10294.845577316346, 10786.460676966159, 10803.0, 10829.350238985666, 10906.727331816708, 2316.756740542244, 2359.3393849722106, 2366.479374537599, 2369.087901158058, 2370.0, 2192.1450634252656, 2279.575265459088, 2320.373499155227, 2358.127492827656, 2359.0327965534134, 2322.883855807211, 2326.7905888470036, 2343.250159948817, 2344.6951896253463, 2346.6245400735884, 2285.3943704918042, 2305.5504176685554, 2311.0986715181093, 2313.7339205991357, 2314.4329639238326, 2250.5723912456583, 2322.7328857181474, 2323.2101085630966, 2323.8838058097026, 2329.615613423783, 11119.221654484189, 11213.943930280378, 11217.607383741612, 11244.718882028015, 11247.83128253077, 5655.745491452894, 5884.0, 5900.085486749561, 5912.4974377178, 5917.733701983421, 3348.162959260185, 3393.4400823864034, 3606.314800187982, 3638.326909521747, 3642.7085833133287, 1124.3647339253296, 1156.6587856582328, 1201.5374080978886, 1223.1132428989001, 1230.5569994801865, 13366.665833354147, 14125.081869678437, 14694.853051469456, 15496.147711875843, 15525.068495890282, 3824.2160357126722, 4486.7083639563325, 4614.353990441341, 4617.515160908057, 4625.745583992845, 11439.313641181556, 11450.427478626201, 11451.026662733595, 11455.083593312514, 11462.598809041643, 4797.112534181188, 5641.182028605829, 5645.068563686946, 5645.350784659735, 5654.434556544313, 4409.2724700424715, 5152.639315247971, 5181.715005674724, 5199.766010529535, 5203.16749320107, 3636.0, 3773.415120656303, 3825.6748176405317, 3870.670992965573, 3875.748076375027, 1026.856240126383, 1027.6403258859489, 1028.275066078413, 1039.9168066554657, 1045.6758404894506, 764.8087978005499, 797.3740613618281, 804.2480280937342, 815.152241668658, 825.1294883897546, 5642.4075472075665, 6366.713497892606, 6375.354227995423, 6655.101561289261, 6783.219929708147, 847.8088285958239, 909.2271569166288, 939.9718008459621, 950.843110886696, 986.5215370545279, 3894.2406230784727, 3903.921921561553, 4001.1197536541913, 4123.948393159725, 4156.896077598024, 12897.48410063587, 13929.651758706113, 14075.366608502642, 14102.435902563782, 14115.435382584581, 13659.0, 13692.65768355799, 13917.721645567031, 13980.930095349458, 13991.510297139552, 9997.550110245056, 10098.394096354243, 10124.645637402655, 10255.897441025792, 10263.794724105475, 6251.812445626639, 6351.96824015877, 6396.808095757135, 6426.614403135827, 6494.188226471691, 11516.596919107791, 11997.580084696994, 12248.142630015813, 12299.200551964093, 12327.321997290235, 9323.114304141096, 9867.753306167404, 12434.316112613893, 12482.438290277141, 12513.687157821127, 8896.955515222382, 8909.599068042084, 8940.552972351486, 9118.908810911806, 9197.264218862609, 9969.551370188505, 10167.237457190593, 10214.591416343561, 10230.48847557634, 10232.386056836614, 7648.808779780327, 8638.308935285037, 8899.644014239617, 8899.955500222457, 8951.35457276928, 8657.047724750399, 8732.56337183151, 8823.161799629024, 8922.330825188266, 8963.820723585623, 7687.423443241891, 7820.335271501758, 7823.3350165234315, 7833.451658383859, 7834.216578342121, 5611.663300202001, 5694.829155125353, 5825.94174058254, 5907.49786268172, 5911.379305172895, 5721.971390143022, 5722.599418040697, 5932.525397968238, 5966.76132954677, 6118.082287656887], "value": 5014.372027630424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.61951380321375, 368.4804425759679, 379.5407556856204, 382.08490664857686, 386.1947838756193, 5493.697846618435, 5571.164325351189, 5607.635503692257, 5692.003899317623, 6027.789027384037, 5159.690418574888, 5389.973050134744, 5586.352026152284, 5692.686902220386, 5743.655380677163, 4664.906701865961, 4827.7586120694, 4829.420469543642, 4859.885949611912, 5002.974985125087, 4982.800687972477, 4996.675216110959, 5004.774785134659, 5010.949890501085, 5028.195488721805, 4525.47956984946, 4657.836975705851, 5010.198368261079, 5017.523335283142, 5019.222020586815, 4912.9642116830355, 4954.20732682769, 5054.772535235923, 5068.315777370045, 5082.517160869711, 4467.664925130595, 4720.268358404453, 4743.478217396084, 4758.287775967699, 4772.308015337791, 4394.956050439519, 4647.488776234612, 4888.951110488885, 4936.925946110811, 5661.743773130673, 5559.997601295296, 5665.263515742927, 5822.155787410802, 5861.267341582302, 5912.906112369183, 4655.557722016403, 6241.906371404432, 6259.467945224661, 6267.4986001119805, 6267.62394256346, 5056.62075344347, 5095.566876815476, 5333.200019997032, 5380.7309634518115, 5388.515033646991, 5542.891421715673, 5640.277416904864, 6074.908876366858, 6523.434375749834, 6626.469882409396, 4099.795010249476, 5342.198670199501, 5522.475364840334, 5530.419305972815, 5550.639208451518, 5631.7747290108755, 5650.5479561634975, 5660.915086273709, 5668.943310566924, 5693.743781529841, 4804.735739534359, 5623.297087864017, 5771.874484475487, 5886.764529418861, 5898.292204935349, 5580.972095139498, 6012.308584512837, 6283.3402492737605, 6287.591306565058, 6290.634510536841, 1659.0, 1758.821589534989, 1821.122626250521, 1841.2174825699024, 1894.8294653480978, 1285.9485620575072, 1306.9281189534477, 1308.1954597922208, 1308.2542950518114, 1312.4840808865774, 4787.640926930494, 4852.951470485321, 5068.898622027539, 5598.2442370280305, 5842.298924129047, 5803.564732645069, 6018.879622407528, 6306.716197771111, 6416.412265230383, 6452.354764523604, 5612.410696876851, 5783.306003279633, 5803.448672376117, 5833.7374818133285, 5845.707714614337, 2813.5779633055204, 3335.9666403335655, 3346.665333466634, 3368.292658541685, 3384.627690953993, 5032.7735251913755, 6072.483838873657, 6328.810135695937, 6367.758287133965, 6609.20689517261, 6298.968505157445, 6480.0, 6521.6413097279155, 6555.066959824067, 6601.3068627794355, 5091.338126043591, 5223.817166399158, 5428.5928555358505, 6619.172603424572, 6620.503462240351, 5172.7413629319135, 5401.513863752281, 5868.2077919482035, 6337.65142917144, 6356.586821856565, 5581.190727344593, 5696.629719068247, 5936.376680448663, 5995.9700201500455, 6173.351798061319, 6126.877462450815, 6203.65879876593, 6257.78097766576, 6510.18622672166, 6572.342765723581, 4792.137415265286, 4965.726885021359, 4976.626752993612, 4998.275250088789, 5026.396832380138, 6313.210848643919, 6374.394432528902, 6388.840278993062, 6435.678216089271, 6489.967550162219, 5210.843674689765, 6113.628755439881, 6191.9690401547705, 6220.813375598739, 6270.529710271839, 5800.7099645018425, 6064.909026364697, 6115.816525504064, 6123.571350005457, 6171.413715697002, 5041.319421878, 5252.579793616578, 6047.304559975483, 6089.299730530868, 6091.9086213707715, 5161.509656582619, 5812.94187058124, 6149.692515374124, 6287.528435367274, 6290.402411770874, 5267.947320526746, 6043.8186854394435, 6060.000299851602, 6076.817695469143, 6136.417040381157], "value": 4779.799911533684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.9468737188396, 766.7584710816093, 811.5374236685088, 812.317653171336, 823.3865770001343, 15513.379464821408, 15866.12736299503, 15912.52262432129, 15955.202239888004, 16003.959742616737, 14760.6309842254, 14937.253137343143, 14974.25128743564, 14974.32615532301, 14980.925095374536, 793.488200110931, 900.459724165502, 931.3480563605469, 932.6828878181417, 938.2212763406357, 859.3426029087752, 943.0710749911332, 943.79708362702, 958.8945216026232, 960.346964064436, 842.5366048673236, 1005.1958433253404, 1005.8742657167854, 1007.9949600252025, 1008.2740426892625, 1002.9869831470195, 1003.8494225866142, 1004.0862814838534, 1005.3415013166388, 1007.425767312632, 743.9032925719675, 746.4177941205813, 746.4588173574169, 749.3106342165221, 750.3996802557987, 13904.0, 16022.679546409006, 16600.83399166005, 16928.322867085426, 17025.404110856183, 14555.854441455662, 14621.853781462156, 14684.17636191144, 14744.0, 14761.77857332141, 11483.712907177387, 11572.53709851605, 11686.41567921609, 11866.762664746657, 12111.576094836639, 3582.874599389009, 3722.7766334020043, 3750.887473375803, 3759.2293579816073, 3883.8834834954996, 110736.0, 112001.0, 112284.37372905728, 113620.29569556464, 114331.85668143378, 10040.046195611405, 10474.947625261824, 11345.716357091138, 11489.368084755251, 11899.702507437383, 22765.544689106126, 23545.7645423547, 25075.62386564203, 25095.62356564653, 25162.0, 7908.406869484812, 7928.207179282141, 8013.2387423194705, 8051.83896322082, 8140.063892652421, 4244.236037513278, 4272.636825869836, 4327.7186982846015, 4461.085477477174, 4475.753833539186, 3392.6776956189124, 3474.6699063588917, 3477.7739446935866, 3479.634638362986, 3500.824958752052, 568.3322096536635, 620.227816368615, 624.1573875268351, 634.429013887505, 649.2014821769251, 646.7251418147268, 648.4747354642755, 690.8756423843756, 714.4391652552721, 721.7870728135213, 9145.0, 9444.8583271251, 9491.620335186653, 9984.400935943866, 10354.378737275787, 628.4658040665398, 684.910961574992, 699.5872435263118, 709.5848928376854, 711.8149281186825, 4154.563770804082, 4369.519352871182, 4826.831060912921, 4830.7101573905675, 4832.323474713543, 73783.63108184424, 92128.53935730278, 96339.0, 97381.0, 98368.53547138965, 57878.0, 87046.56476717576, 87839.0, 87840.12159878448, 89306.0, 80388.59805700934, 80755.59622201852, 80788.59605701934, 80920.59539702382, 81664.84878532474, 9361.251099912128, 9442.716718498456, 9478.85781713261, 9548.809023819345, 9552.808943820946, 39944.00139996524, 50263.74868125636, 50958.0, 51837.48162518477, 52159.478405215465, 52422.0, 66497.33502665105, 66655.33344666491, 66680.6665966667, 68081.65959170173, 11146.665600032013, 11387.886121138683, 11578.0, 12142.514299427923, 12191.695207619881, 12130.514779408724, 12418.937905310777, 12602.054845886412, 12777.616671499869, 12989.0, 10512.535900409808, 10526.263161578616, 10653.530052480504, 10691.465426728788, 10877.456127193767, 11732.882671173178, 11753.412329383325, 11779.411029448665, 11804.350760708243, 11863.228890122115, 11921.0, 12061.698457538632, 12815.935920320338, 13125.0, 13231.206127632373, 10777.838332424863, 10800.729981750519, 10822.242443028912, 10954.780904381709, 11415.885841141482, 8854.424462409923, 9082.62771978549, 10552.947235263775, 10800.837987430037, 10872.021518063413], "value": 7462.889660542644, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 171.0, 148.0, 115.0, 116.0, 117.0, 115.0, 115.0, 115.0, 116.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 112.0, 153.0, 114.0, 112.0, 112.0, 112.0, 154.0, 146.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 187.0, 186.0, 183.0, 182.0, 183.0, 184.0, 184.0, 184.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 89.0, 61.0, 61.0, 58.0, 62.0, 74.0, 61.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 88.0, 68.0, 69.0, 68.0, 84.0, 70.0, 69.0, 86.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 87.0, 88.0, 88.0, 87.0, 88.0, 88.0, 88.0, 88.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 83.0, 84.0, 83.0, 83.0, 83.0, 84.0, 100.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 60.0, 63.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 64.0, 63.0, 59.0, 58.0, 58.0, 59.0, 59.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 84.0, 84.0, 83.0, 83.0, 82.0, 82.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 159.0, 139.0, 143.0, 142.0, 152.0, 148.0, 139.0, 185.0, 156.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 186.0, 188.0, 185.0, 185.0, 186.0, 186.0, 187.0, 185.0, 187.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 64.0, 67.0, 65.0, 69.0, 68.0, 68.0, 68.0], "value": 67.1, "unit": "score"}]}]} 10:13:32 INFO - Return code: 0 10:13:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:13:32 ERROR - # TBPL SUCCESS # 10:13:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:13:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:13:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:13:32 INFO - 2017-03-20 10:13:32.206 screenresolution[1649:9876] starting screenresolution argv=screenresolution get 10:13:32 INFO - 2017-03-20 10:13:32.209 screenresolution[1649:9876] Display 0: 1600x1200x32@60 10:13:32 INFO - 2017-03-20 10:13:32.215 screenresolution[1650:9879] starting screenresolution argv=screenresolution list 10:13:32 INFO - Available Modes on Display 0 10:13:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:13:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:13:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:13:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:13:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:13:32 INFO - Intel Iris: 10:13:32 INFO - Chipset Model: Intel Iris 10:13:32 INFO - Type: GPU 10:13:32 INFO - Bus: Built-In 10:13:32 INFO - VRAM (Dynamic, Max): 1536 MB 10:13:32 INFO - Vendor: Intel (0x8086) 10:13:32 INFO - Device ID: 0x0a2e 10:13:32 INFO - Revision ID: 0x0009 10:13:32 INFO - Displays: 10:13:32 INFO - Display: 10:13:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:13:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:13:32 INFO - Display Serial Number: 1600x1200 60 10:13:32 INFO - Main Display: Yes 10:13:32 INFO - Mirror: Off 10:13:32 INFO - Online: Yes 10:13:32 INFO - Rotation: Supported 10:13:32 INFO - Return code: 0 10:13:32 INFO - Running post-action listener: _resource_record_post_action 10:13:32 INFO - [mozharness: 2017-03-20 17:13:32.452161Z] Finished run-tests step (success) 10:13:32 INFO - Running post-run listener: _resource_record_post_run 10:13:32 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37880832; Write bytes: 511862272; Read time: 382; Write time: 1577 10:13:32 INFO - TinderboxPrint: CPU usage
53.5% 10:13:32 INFO - TinderboxPrint: I/O read bytes / time
37,880,832 / 382 10:13:32 INFO - TinderboxPrint: I/O write bytes / time
511,862,272 / 1,577 10:13:32 INFO - TinderboxPrint: CPU idle
2,240.6 (46.5%) 10:13:32 INFO - TinderboxPrint: CPU system
960.4 (20.0%) 10:13:32 INFO - TinderboxPrint: CPU user
1,612.7 (33.5%) 10:13:32 INFO - TinderboxPrint: Swap in / out
247,787,520 / 0 10:13:32 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203813376; Write bytes: 203806720; Read time: 15710; Write time: 410 10:13:32 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 36045824; Write bytes: 297242112; Read time: 363; Write time: 1132 10:13:32 INFO - Running post-run listener: _upload_blobber_files 10:13:32 INFO - Blob upload gear active. 10:13:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:13:32 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 10:13:32 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'] 10:13:32 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 10:13:33 INFO - (blobuploader) - INFO - Open directory for files ... 10:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:34 INFO - (blobuploader) - INFO - Done attempting. 10:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:35 INFO - (blobuploader) - INFO - Done attempting. 10:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:37 INFO - (blobuploader) - INFO - Done attempting. 10:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:39 INFO - (blobuploader) - INFO - Done attempting. 10:13:39 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:39 INFO - Return code: 0 10:13:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b842380496511eedb9c7a097f836efac0f6156cfbb0f4a6065fe5962ebb85a3305758a88f5ef47ea994a61a6655ae2906120c79255b9fe3b44f0159074f4fcc8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/615db00e7d8e6567d5ddb20076c3ed5838aaec2a6f3b9cc7f29600bbcc02cce3ea0bf7b7814fce0a78e51e4ea0d3d1b4e9aa7e8b1642349322587cb7622d3246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/766afbc2475753bf1de989ddd173768d32c2202df6f280217b29f3b348dba74c7342f6f6a7ecb51434aa2f9a8d556c5b2ad11cf3b1986c36e6d905c3e783a20a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f538670d9acb4f6dbfe3e8c9bb2a3568e1fb3cc4e6439c068a34a804ec117f5f48912738a287fe5d48c6537c050a6b04525473de657d9bd33614476a6e7715"} 10:13:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:39 INFO - Contents: 10:13:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b842380496511eedb9c7a097f836efac0f6156cfbb0f4a6065fe5962ebb85a3305758a88f5ef47ea994a61a6655ae2906120c79255b9fe3b44f0159074f4fcc8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/615db00e7d8e6567d5ddb20076c3ed5838aaec2a6f3b9cc7f29600bbcc02cce3ea0bf7b7814fce0a78e51e4ea0d3d1b4e9aa7e8b1642349322587cb7622d3246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/766afbc2475753bf1de989ddd173768d32c2202df6f280217b29f3b348dba74c7342f6f6a7ecb51434aa2f9a8d556c5b2ad11cf3b1986c36e6d905c3e783a20a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f538670d9acb4f6dbfe3e8c9bb2a3568e1fb3cc4e6439c068a34a804ec117f5f48912738a287fe5d48c6537c050a6b04525473de657d9bd33614476a6e7715"} 10:13:39 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:39 INFO - Copying logs to upload dir... 10:13:39 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.622274 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-20 10:13:39.757702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-20 10:13:39.761190) ========= 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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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/b842380496511eedb9c7a097f836efac0f6156cfbb0f4a6065fe5962ebb85a3305758a88f5ef47ea994a61a6655ae2906120c79255b9fe3b44f0159074f4fcc8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/615db00e7d8e6567d5ddb20076c3ed5838aaec2a6f3b9cc7f29600bbcc02cce3ea0bf7b7814fce0a78e51e4ea0d3d1b4e9aa7e8b1642349322587cb7622d3246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/766afbc2475753bf1de989ddd173768d32c2202df6f280217b29f3b348dba74c7342f6f6a7ecb51434aa2f9a8d556c5b2ad11cf3b1986c36e6d905c3e783a20a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f538670d9acb4f6dbfe3e8c9bb2a3568e1fb3cc4e6439c068a34a804ec117f5f48912738a287fe5d48c6537c050a6b04525473de657d9bd33614476a6e7715"} build_url:https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010874 build_url: 'https://queue.taskcluster.net/v1/task/SwOpDkWKRhCdSdS5ftH5Uw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b842380496511eedb9c7a097f836efac0f6156cfbb0f4a6065fe5962ebb85a3305758a88f5ef47ea994a61a6655ae2906120c79255b9fe3b44f0159074f4fcc8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/615db00e7d8e6567d5ddb20076c3ed5838aaec2a6f3b9cc7f29600bbcc02cce3ea0bf7b7814fce0a78e51e4ea0d3d1b4e9aa7e8b1642349322587cb7622d3246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/766afbc2475753bf1de989ddd173768d32c2202df6f280217b29f3b348dba74c7342f6f6a7ecb51434aa2f9a8d556c5b2ad11cf3b1986c36e6d905c3e783a20a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f538670d9acb4f6dbfe3e8c9bb2a3568e1fb3cc4e6439c068a34a804ec117f5f48912738a287fe5d48c6537c050a6b04525473de657d9bd33614476a6e7715"}' ========= master_lag: 1.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-20 10:13:41.095588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 10:13:41.096029) ========= 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.AW3YtvEKAg/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.uGXfRBi0oy/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.005103 ========= master_lag: 1.72 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 10:13:42.820873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 10:13:42.821210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 10:13:42.823309) ========= ========= Total master_lag: 3.15 =========