builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0083 starttime: 1490405426.0 results: success (0) buildid: 20170324170416 builduid: d6b27b42eae74ef4a61ce685b2a505b9 revision: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.003360) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.003815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.004087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.030892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.031182) ========= 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.1fwIg7jkox/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.pGUPcZdaNL/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-24 18:30:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 69.1M=0s 2017-03-24 18:30:26 (69.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.187706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.188012) ========= 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.1fwIg7jkox/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.pGUPcZdaNL/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.037905 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:26.247145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 18:30:26.247461) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 --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 f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1fwIg7jkox/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.pGUPcZdaNL/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-24 18:30:26,335 truncating revision to first 12 chars 2017-03-24 18:30:26,336 Setting DEBUG logging. 2017-03-24 18:30:26,336 attempt 1/10 2017-03-24 18:30:26,336 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9acfdca68a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 18:30:27,459 unpacking tar archive at: mozilla-central-f9acfdca68a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.400811 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 18:30:27.669417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:27.669733) ========= script_repo_revision: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:27.670177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:27.670440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:27.693341) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-24 18:30:27.693644) ========= /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.1fwIg7jkox/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.pGUPcZdaNL/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:30:27 INFO - MultiFileLogger online at 20170324 18:30:27 in /builds/slave/test 18:30:27 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 18:30:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:27 INFO - {'append_to_log': False, 18:30:27 INFO - 'base_work_dir': '/builds/slave/test', 18:30:27 INFO - 'blob_upload_branch': 'Firefox', 18:30:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:27 INFO - 'branch': 'Firefox', 18:30:27 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:27 INFO - 'config_files': ('talos/mac_config.py',), 18:30:27 INFO - 'default_actions': ('clobber', 18:30:27 INFO - 'read-buildbot-config', 18:30:27 INFO - 'download-and-extract', 18:30:27 INFO - 'populate-webroot', 18:30:27 INFO - 'create-virtualenv', 18:30:27 INFO - 'install', 18:30:27 INFO - 'run-tests'), 18:30:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:27 INFO - 'download_minidump_stackwalk': True, 18:30:27 INFO - 'download_symbols': 'ondemand', 18:30:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:27 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:27 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:27 INFO - 'gecko_profile': False, 18:30:27 INFO - 'gecko_profile_interval': 0, 18:30:27 INFO - 'installer_path': 'installer.exe', 18:30:27 INFO - 'log_level': 'info', 18:30:27 INFO - 'log_name': 'talos', 18:30:27 INFO - 'log_to_console': True, 18:30:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:30:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:30:27 INFO - 'opt_config_files': (), 18:30:27 INFO - 'pip_index': False, 18:30:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:27 INFO - 'cmd': ('bash', 18:30:27 INFO - '-c', 18:30:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:27 INFO - 'enabled': True, 18:30:27 INFO - 'halt_on_failure': False, 18:30:27 INFO - 'name': 'check_screen_resolution'},), 18:30:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:27 INFO - 'cmd': ('bash', 18:30:27 INFO - '-c', 18:30:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:27 INFO - 'enabled': True, 18:30:27 INFO - 'halt_on_failure': False, 18:30:27 INFO - 'name': 'check_screen_resolution'},), 18:30:27 INFO - 'run_cmd_checks_enabled': True, 18:30:27 INFO - 'suite': 'dromaeojs', 18:30:27 INFO - 'system_bits': '32', 18:30:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:27 INFO - 'title': 't-yosemite-r7-0083', 18:30:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:27 INFO - 'use_talos_json': True, 18:30:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:27 INFO - 'work_dir': 'build'} 18:30:27 INFO - [mozharness: 2017-03-25 01:30:27.893550Z] Running clobber step. 18:30:27 INFO - Running pre-action listener: _resource_record_pre_action 18:30:27 INFO - Running main action method: clobber 18:30:27 INFO - rmtree: /builds/slave/test/build 18:30:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:30 INFO - Running post-action listener: _resource_record_post_action 18:30:30 INFO - [mozharness: 2017-03-25 01:30:30.509973Z] Finished clobber step (success) 18:30:30 INFO - [mozharness: 2017-03-25 01:30:30.510125Z] Running read-buildbot-config step. 18:30:30 INFO - Running pre-action listener: _resource_record_pre_action 18:30:30 INFO - Running main action method: read_buildbot_config 18:30:30 INFO - Using buildbot properties: 18:30:30 INFO - { 18:30:30 INFO - "project": "", 18:30:30 INFO - "product": "firefox", 18:30:30 INFO - "script_repo_revision": "production", 18:30:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:30:30 INFO - "repository": "", 18:30:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:30:30 INFO - "buildid": "20170324170416", 18:30:30 INFO - "pgo_build": "False", 18:30:30 INFO - "basedir": "/builds/slave/test", 18:30:30 INFO - "buildnumber": 12, 18:30:30 INFO - "slavename": "t-yosemite-r7-0083", 18:30:30 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:30:30 INFO - "platform": "yosemite_r7", 18:30:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:30:30 INFO - "branch": "mozilla-central", 18:30:30 INFO - "repo_path": "mozilla-central", 18:30:30 INFO - "revision": "f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3", 18:30:30 INFO - "stage_platform": "macosx64", 18:30:30 INFO - "builduid": "d6b27b42eae74ef4a61ce685b2a505b9", 18:30:30 INFO - "slavebuilddir": "test" 18:30:30 INFO - } 18:30:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:30:30 INFO - Running post-action listener: _resource_record_post_action 18:30:30 INFO - [mozharness: 2017-03-25 01:30:30.513368Z] Finished read-buildbot-config step (success) 18:30:30 INFO - [mozharness: 2017-03-25 01:30:30.513471Z] Running download-and-extract step. 18:30:30 INFO - Running pre-action listener: _resource_record_pre_action 18:30:30 INFO - Running main action method: download_and_extract 18:30:30 INFO - mkdir: /builds/slave/test/build/tests 18:30:30 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')]} 18:30:30 INFO - trying https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:30:30 INFO - Downloading https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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 18:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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 18:30:31 INFO - Downloaded 1325 bytes. 18:30:31 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:30:31 INFO - Using the following test package requirements: 18:30:31 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 18:30:31 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:30:31 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:30:31 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:30:31 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'jsshell-mac.zip'], 18:30:31 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:30:31 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:30:31 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:30:31 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:30:31 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:30:31 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:31 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:30:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:30:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:30:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:30:31 INFO - Fetch https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:30:33 INFO - Expected file size: 52409077 18:30:33 INFO - Obtained file size: 52409077 18:30:49 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 18:30:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:30:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:30:49 INFO - Fetch https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:30:51 INFO - Expected file size: 52409077 18:30:51 INFO - Obtained file size: 52409077 18:31:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:31:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:31:07 INFO - Fetch https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:31:08 INFO - Expected file size: 14404171 18:31:08 INFO - Obtained file size: 14404171 18:31: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')]} 18:31:08 INFO - trying https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:08 INFO - Downloading https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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 18:31:10 INFO - Downloaded 75577133 bytes. 18:31:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:10 INFO - mkdir: /builds/slave/test/properties 18:31:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:10 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:10 INFO - Contents: 18:31:10 INFO - build_url:https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:11 INFO - Running post-action listener: _resource_record_post_action 18:31:11 INFO - Running post-action listener: set_extra_try_arguments 18:31:11 INFO - [mozharness: 2017-03-25 01:31:11.276785Z] Finished download-and-extract step (success) 18:31:11 INFO - [mozharness: 2017-03-25 01:31:11.276916Z] Running populate-webroot step. 18:31:11 INFO - Running pre-action listener: _resource_record_pre_action 18:31:11 INFO - Running main action method: populate_webroot 18:31:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:11 INFO - '--tppagecycles', 18:31:11 INFO - '7'], 18:31:11 INFO - 'tests': ['tsvgm']}}, 18:31:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:31:11 INFO - 'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:31:11 INFO - 'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['damp', 'tps']}, 18:31:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:31:11 INFO - 'tests': ['damp', 'tps']}, 18:31:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['dromaeo_dom']}, 18:31:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['basic_compositor_video']}, 18:31:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:31:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['a11yr', 18:31:11 INFO - 'ts_paint', 18:31:11 INFO - 'tpaint', 18:31:11 INFO - 'sessionrestore', 18:31:11 INFO - 'sessionrestore_no_auto_restore', 18:31:11 INFO - 'tabpaint']}, 18:31:11 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:11 INFO - 'ts_paint', 18:31:11 INFO - 'tpaint', 18:31:11 INFO - 'sessionrestore', 18:31:11 INFO - 'sessionrestore_no_auto_restore', 18:31:11 INFO - 'tabpaint']}, 18:31:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:11 INFO - 'ts_paint', 18:31:11 INFO - 'tpaint', 18:31:11 INFO - 'sessionrestore', 18:31:11 INFO - 'sessionrestore_no_auto_restore', 18:31:11 INFO - 'tabpaint']}, 18:31:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:11 INFO - 'ts_paint', 18:31:11 INFO - 'tpaint', 18:31:11 INFO - 'sessionrestore', 18:31:11 INFO - 'sessionrestore_no_auto_restore', 18:31:11 INFO - 'tabpaint']}, 18:31:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['a11yr', 18:31:11 INFO - 'ts_paint', 18:31:11 INFO - 'tpaint', 18:31:11 INFO - 'sessionrestore', 18:31:11 INFO - 'sessionrestore_no_auto_restore', 18:31:11 INFO - 'tabpaint']}, 18:31:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['a11yr', 18:31:11 INFO - 'ts_paint', 18:31:11 INFO - 'tpaint', 18:31:11 INFO - 'sessionrestore', 18:31:11 INFO - 'sessionrestore_no_auto_restore', 18:31:11 INFO - 'tabpaint']}, 18:31:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['tsvgx', 18:31:11 INFO - 'tsvgr_opacity', 18:31:11 INFO - 'tart', 18:31:11 INFO - 'tscrollx', 18:31:11 INFO - 'cart', 18:31:11 INFO - 'tsvg_static']}, 18:31:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:11 INFO - 'tsvgr_opacity', 18:31:11 INFO - 'tart', 18:31:11 INFO - 'tscrollx', 18:31:11 INFO - 'cart', 18:31:11 INFO - 'tsvg_static']}, 18:31:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:31:11 INFO - 'talos_options': ['--disable-e10s'], 18:31:11 INFO - 'tests': ['tp5o']}, 18:31:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:31:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:31:11 INFO - 'talos_options': ['--disable-e10s', 18:31:11 INFO - '--xperf_path', 18:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:11 INFO - 'tests': ['tp5n']}, 18:31:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:31:11 INFO - 'talos_options': ['--xperf_path', 18:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:11 INFO - 'tests': ['tp5n']}}, 18:31:11 INFO - 'talos.zip': {'path': '', 18:31:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:11 INFO - Running post-action listener: _resource_record_post_action 18:31:11 INFO - [mozharness: 2017-03-25 01:31:11.295243Z] Finished populate-webroot step (success) 18:31:11 INFO - [mozharness: 2017-03-25 01:31:11.295353Z] Running create-virtualenv step. 18:31:11 INFO - Running pre-action listener: _resource_record_pre_action 18:31:11 INFO - Running main action method: create_virtualenv 18:31:11 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:11 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 18:31:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:11 INFO - Using real prefix '/tools/python27' 18:31:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:12 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:14 INFO - Installing pip.................done. 18:31:14 INFO - Return code: 0 18:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:15 INFO - Reading from file tmpfile_stdout 18:31:15 INFO - Output received: 18:31:15 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) 18:31:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:15 INFO - 'HOME': '/Users/cltbld', 18:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:15 INFO - 'LOGNAME': 'cltbld', 18:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:15 INFO - 'MOZ_NO_REMOTE': '1', 18:31:15 INFO - 'NO_EM_RESTART': '1', 18:31:15 INFO - 'PAGER': '/bin/cat', 18:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:15 INFO - 'PWD': '/builds/slave/test', 18:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:15 INFO - 'SHELL': '/bin/bash', 18:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:15 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:15 INFO - 'USER': 'cltbld', 18:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:15 INFO - 'XPC_FLAGS': '0x0', 18:31:15 INFO - 'XPC_SERVICE_NAME': '0', 18:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:15 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 18:31:15 INFO - Cleaning up... 18:31:15 INFO - Return code: 0 18:31:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:15 INFO - 'HOME': '/Users/cltbld', 18:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:15 INFO - 'LOGNAME': 'cltbld', 18:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:15 INFO - 'MOZ_NO_REMOTE': '1', 18:31:15 INFO - 'NO_EM_RESTART': '1', 18:31:15 INFO - 'PAGER': '/bin/cat', 18:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:15 INFO - 'PWD': '/builds/slave/test', 18:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:15 INFO - 'SHELL': '/bin/bash', 18:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:15 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:15 INFO - 'USER': 'cltbld', 18:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:15 INFO - 'XPC_FLAGS': '0x0', 18:31:15 INFO - 'XPC_SERVICE_NAME': '0', 18:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:15 INFO - Downloading/unpacking psutil>=3.1.1 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:19 INFO - Installing collected packages: psutil 18:31:19 INFO - Running setup.py install for psutil 18:31:19 INFO - building 'psutil._psutil_osx' extension 18:31:19 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 18:31:20 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 18:31:20 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 18:31:20 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 18:31:20 INFO - building 'psutil._psutil_posix' extension 18:31:20 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 18:31:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:31:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:31:20 INFO - ^ 18:31:20 INFO - 1 warning generated. 18:31:20 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 18:31:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:20 INFO - Successfully installed psutil 18:31:20 INFO - Cleaning up... 18:31:20 INFO - Return code: 0 18:31:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:20 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')]} 18:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:20 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')]} 18:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:20 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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:20 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 18:31:20 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 18:31:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:20 INFO - 'HOME': '/Users/cltbld', 18:31:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:20 INFO - 'LOGNAME': 'cltbld', 18:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:20 INFO - 'MOZ_NO_REMOTE': '1', 18:31:20 INFO - 'NO_EM_RESTART': '1', 18:31:20 INFO - 'PAGER': '/bin/cat', 18:31:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:20 INFO - 'PWD': '/builds/slave/test', 18:31:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:20 INFO - 'SHELL': '/bin/bash', 18:31:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:20 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:20 INFO - 'USER': 'cltbld', 18:31:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:20 INFO - 'XPC_FLAGS': '0x0', 18:31:20 INFO - 'XPC_SERVICE_NAME': '0', 18:31:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:24 INFO - Installing collected packages: mozsystemmonitor 18:31:24 INFO - Running setup.py install for mozsystemmonitor 18:31:24 INFO - Successfully installed mozsystemmonitor 18:31:24 INFO - Cleaning up... 18:31:24 INFO - Return code: 0 18:31:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:24 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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:24 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 18:31:24 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 18:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:24 INFO - 'HOME': '/Users/cltbld', 18:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:24 INFO - 'LOGNAME': 'cltbld', 18:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:24 INFO - 'MOZ_NO_REMOTE': '1', 18:31:24 INFO - 'NO_EM_RESTART': '1', 18:31:24 INFO - 'PAGER': '/bin/cat', 18:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:24 INFO - 'PWD': '/builds/slave/test', 18:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:24 INFO - 'SHELL': '/bin/bash', 18:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:24 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:24 INFO - 'USER': 'cltbld', 18:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:24 INFO - 'XPC_FLAGS': '0x0', 18:31:24 INFO - 'XPC_SERVICE_NAME': '0', 18:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:24 INFO - Downloading/unpacking jsonschema==2.5.1 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:27 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 18:31:27 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 18:31:27 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 18:31:27 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 18:31:27 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 18:31:27 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 18:31:27 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:28 INFO - warning: no files found matching '*.txt' 18:31:28 INFO - no previously-included directories found matching 'build' 18:31:28 INFO - no previously-included directories found matching 'dist' 18:31:28 INFO - no previously-included directories found matching '.git*' 18:31:28 INFO - Installing collected packages: jsonschema, functools32 18:31:28 INFO - Running setup.py install for functools32 18:31:28 INFO - warning: no files found matching '*.txt' 18:31:28 INFO - no previously-included directories found matching 'build' 18:31:28 INFO - no previously-included directories found matching 'dist' 18:31:28 INFO - no previously-included directories found matching '.git*' 18:31:28 INFO - Successfully installed jsonschema functools32 18:31:28 INFO - Cleaning up... 18:31:28 INFO - Return code: 0 18:31:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', '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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:31: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 functools32==3.2.3-2 18:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:28 INFO - 'HOME': '/Users/cltbld', 18:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:28 INFO - 'LOGNAME': 'cltbld', 18:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:28 INFO - 'MOZ_NO_REMOTE': '1', 18:31:28 INFO - 'NO_EM_RESTART': '1', 18:31:28 INFO - 'PAGER': '/bin/cat', 18:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:28 INFO - 'PWD': '/builds/slave/test', 18:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:28 INFO - 'SHELL': '/bin/bash', 18:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:28 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:28 INFO - 'USER': 'cltbld', 18:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:28 INFO - 'XPC_FLAGS': '0x0', 18:31:28 INFO - 'XPC_SERVICE_NAME': '0', 18:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:28 INFO - Cleaning up... 18:31:28 INFO - Return code: 0 18:31:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', '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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:31: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 blobuploader==1.2.4 18:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:28 INFO - 'HOME': '/Users/cltbld', 18:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:28 INFO - 'LOGNAME': 'cltbld', 18:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:28 INFO - 'MOZ_NO_REMOTE': '1', 18:31:28 INFO - 'NO_EM_RESTART': '1', 18:31:28 INFO - 'PAGER': '/bin/cat', 18:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:28 INFO - 'PWD': '/builds/slave/test', 18:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:28 INFO - 'SHELL': '/bin/bash', 18:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:28 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:28 INFO - 'USER': 'cltbld', 18:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:28 INFO - 'XPC_FLAGS': '0x0', 18:31:28 INFO - 'XPC_SERVICE_NAME': '0', 18:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:28 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:28 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 18:31:28 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 18:31:28 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 18:31:28 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 18:31:28 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 18:31:28 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 18:31:31 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:32 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 18:31:32 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 18:31:32 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 18:31:32 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 18:31:32 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 18:31:32 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 18:31:32 INFO - Downloading docopt-0.6.1.tar.gz 18:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:32 INFO - Running setup.py install for blobuploader 18:31:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:33 INFO - Running setup.py install for requests 18:31:33 INFO - Running setup.py install for docopt 18:31:33 INFO - Successfully installed blobuploader requests docopt 18:31:33 INFO - Cleaning up... 18:31:33 INFO - Return code: 0 18:31:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:33 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')]} 18:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:33 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')]} 18:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:33 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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:33 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 18:31:33 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 18:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:33 INFO - 'HOME': '/Users/cltbld', 18:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:33 INFO - 'LOGNAME': 'cltbld', 18:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:33 INFO - 'MOZ_NO_REMOTE': '1', 18:31:33 INFO - 'NO_EM_RESTART': '1', 18:31:33 INFO - 'PAGER': '/bin/cat', 18:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:33 INFO - 'PWD': '/builds/slave/test', 18:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:33 INFO - 'SHELL': '/bin/bash', 18:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:33 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:33 INFO - 'USER': 'cltbld', 18:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:33 INFO - 'XPC_FLAGS': '0x0', 18:31:33 INFO - 'XPC_SERVICE_NAME': '0', 18:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dT_ki0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-qBhXw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-mTAyvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-MDi4lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-y_OY7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wfU8GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-SMvRaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-aE26vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LXnm26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-zJ9zXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Z6BVib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-mymAcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-7I8Jxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-cfbX4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-gZZcwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Fp4WTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-nAsZDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:35 INFO - Running setup.py install for manifestparser 18:31:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:35 INFO - Running setup.py install for mozcrash 18:31:36 INFO - Running setup.py install for mozdebug 18:31:36 INFO - Running setup.py install for mozdevice 18:31:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:36 INFO - Running setup.py install for mozfile 18:31:36 INFO - Running setup.py install for mozhttpd 18:31:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:36 INFO - Running setup.py install for mozinfo 18:31:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:36 INFO - Running setup.py install for mozInstall 18:31:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:36 INFO - Running setup.py install for mozleak 18:31:37 INFO - Running setup.py install for mozlog 18:31:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:37 INFO - Running setup.py install for moznetwork 18:31:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:37 INFO - Running setup.py install for mozprocess 18:31:37 INFO - Running setup.py install for mozprofile 18:31:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:37 INFO - Running setup.py install for mozrunner 18:31:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:37 INFO - Running setup.py install for mozscreenshot 18:31:38 INFO - Running setup.py install for moztest 18:31:38 INFO - Running setup.py install for mozversion 18:31:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:38 INFO - Cleaning up... 18:31:38 INFO - Return code: 0 18:31:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:38 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')]} 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:38 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')]} 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:38 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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:38 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 18:31:38 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 18:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:38 INFO - 'HOME': '/Users/cltbld', 18:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:38 INFO - 'LOGNAME': 'cltbld', 18:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:38 INFO - 'MOZ_NO_REMOTE': '1', 18:31:38 INFO - 'NO_EM_RESTART': '1', 18:31:38 INFO - 'PAGER': '/bin/cat', 18:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:38 INFO - 'PWD': '/builds/slave/test', 18:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:38 INFO - 'SHELL': '/bin/bash', 18:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:38 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:38 INFO - 'USER': 'cltbld', 18:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:38 INFO - 'XPC_FLAGS': '0x0', 18:31:38 INFO - 'XPC_SERVICE_NAME': '0', 18:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:38 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-K7AAIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:38 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)) 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:38 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-TQgIau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:38 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)) 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:38 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-oMzfKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:38 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)) 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:38 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-8UfpBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-hIhP1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-G4ELnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-3_O6B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-rinA8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-9y7rUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-NGtuzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-tuEGnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-P8U3G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:39 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)) 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-oL1vil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:40 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)) 18:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-IjPTgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:40 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)) 18:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-UsoFQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:40 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)) 18:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-VbuHBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:40 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)) 18:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-aL0h5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 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)) 18:31:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:40 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 18:31:40 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 18:31:40 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 18:31:40 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 18:31:40 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 18:31:40 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 18:31:43 INFO - Downloading blessings-1.6.tar.gz 18:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:43 INFO - Installing collected packages: blessings 18:31:43 INFO - Running setup.py install for blessings 18:31:43 INFO - Successfully installed blessings 18:31:43 INFO - Cleaning up... 18:31:43 INFO - Return code: 0 18:31:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:43 INFO - Reading from file tmpfile_stdout 18:31:43 INFO - Current package versions: 18:31:43 INFO - blessings == 1.6 18:31:43 INFO - blobuploader == 1.2.4 18:31:43 INFO - docopt == 0.6.1 18:31:43 INFO - functools32 == 3.2.3-2 18:31:43 INFO - jsonschema == 2.5.1 18:31:43 INFO - manifestparser == 1.1 18:31:43 INFO - mozInstall == 1.12 18:31:43 INFO - mozcrash == 1.0 18:31:43 INFO - mozdebug == 0.1 18:31:43 INFO - mozdevice == 0.49 18:31:43 INFO - mozfile == 1.2 18:31:43 INFO - mozhttpd == 0.7 18:31:43 INFO - mozinfo == 0.9 18:31:43 INFO - mozleak == 0.1 18:31:43 INFO - mozlog == 3.4 18:31:43 INFO - moznetwork == 0.27 18:31:43 INFO - mozprocess == 0.25 18:31:43 INFO - mozprofile == 0.28 18:31:43 INFO - mozrunner == 6.13 18:31:43 INFO - mozscreenshot == 0.1 18:31:43 INFO - mozsystemmonitor == 0.3 18:31:43 INFO - moztest == 0.8 18:31:43 INFO - mozversion == 1.4 18:31:43 INFO - psutil == 3.1.1 18:31:43 INFO - requests == 1.2.3 18:31:43 INFO - wsgiref == 0.1.2 18:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:43 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 18:31:43 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 18:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:43 INFO - 'HOME': '/Users/cltbld', 18:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:43 INFO - 'LOGNAME': 'cltbld', 18:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:43 INFO - 'MOZ_NO_REMOTE': '1', 18:31:43 INFO - 'NO_EM_RESTART': '1', 18:31:43 INFO - 'PAGER': '/bin/cat', 18:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:43 INFO - 'PWD': '/builds/slave/test', 18:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:43 INFO - 'SHELL': '/bin/bash', 18:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:43 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:43 INFO - 'USER': 'cltbld', 18:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:43 INFO - 'XPC_FLAGS': '0x0', 18:31:43 INFO - 'XPC_SERVICE_NAME': '0', 18:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 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)) 18:31:43 INFO - Cleaning up... 18:31:43 INFO - Return code: 0 18:31:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 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 0x108da8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa8ace2d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, '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.1fwIg7jkox/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.pGUPcZdaNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:31:43 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 18:31:43 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 18:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:43 INFO - 'HOME': '/Users/cltbld', 18:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:43 INFO - 'LOGNAME': 'cltbld', 18:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:43 INFO - 'MOZ_NO_REMOTE': '1', 18:31:43 INFO - 'NO_EM_RESTART': '1', 18:31:43 INFO - 'PAGER': '/bin/cat', 18:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:43 INFO - 'PWD': '/builds/slave/test', 18:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:43 INFO - 'SHELL': '/bin/bash', 18:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:31:43 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:43 INFO - 'USER': 'cltbld', 18:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:43 INFO - 'XPC_FLAGS': '0x0', 18:31:43 INFO - 'XPC_SERVICE_NAME': '0', 18:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:44 INFO - Cleaning up... 18:31:44 INFO - Return code: 0 18:31:44 INFO - Running post-action listener: _resource_record_post_action 18:31:44 INFO - Running post-action listener: _start_resource_monitoring 18:31:44 INFO - Starting resource monitoring. 18:31:44 INFO - [mozharness: 2017-03-25 01:31:44.246047Z] Finished create-virtualenv step (success) 18:31:44 INFO - [mozharness: 2017-03-25 01:31:44.247021Z] Running install step. 18:31:44 INFO - Running pre-action listener: _resource_record_pre_action 18:31:44 INFO - Running main action method: install 18:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:44 INFO - Reading from file tmpfile_stdout 18:31:44 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:44 INFO - Reading from file tmpfile_stdout 18:31:44 INFO - Output received: 18:31:44 INFO - Usage: mozinstall [options] installer 18:31:44 INFO - Options: 18:31:44 INFO - -h, --help show this help message and exit 18:31:44 INFO - -d DEST, --destination=DEST 18:31:44 INFO - Directory to install application into. [default: 18:31:44 INFO - "/builds/slave/test"] 18:31:44 INFO - --app=APP Application being installed. [default: firefox] 18:31:44 INFO - mkdir: /builds/slave/test/build/application 18:31:44 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'] 18:31:44 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 18:32:04 INFO - Reading from file tmpfile_stdout 18:32:04 INFO - Output received: 18:32:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:32:04 INFO - Running post-action listener: _resource_record_post_action 18:32:04 INFO - [mozharness: 2017-03-25 01:32:04.851577Z] Finished install step (success) 18:32:04 INFO - [mozharness: 2017-03-25 01:32:04.851735Z] Running run-tests step. 18:32:04 INFO - Running pre-action listener: _resource_record_pre_action 18:32:04 INFO - Running main action method: run_tests 18:32:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:04 INFO - 2017-03-24 18:32:04.866 screenresolution[1618:7400] starting screenresolution argv=screenresolution get 18:32:04 INFO - 2017-03-24 18:32:04.869 screenresolution[1618:7400] Display 0: 1600x1200x32@60 18:32:04 INFO - 2017-03-24 18:32:04.875 screenresolution[1619:7403] starting screenresolution argv=screenresolution list 18:32:04 INFO - Available Modes on Display 0 18:32:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:05 INFO - Intel Iris: 18:32:05 INFO - Chipset Model: Intel Iris 18:32:05 INFO - Type: GPU 18:32:05 INFO - Bus: Built-In 18:32:05 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:05 INFO - Vendor: Intel (0x8086) 18:32:05 INFO - Device ID: 0x0a2e 18:32:05 INFO - Revision ID: 0x0009 18:32:05 INFO - Displays: 18:32:05 INFO - Display: 18:32:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:05 INFO - Display Serial Number: 1600x1200 60 18:32:05 INFO - Main Display: Yes 18:32:05 INFO - Mirror: Off 18:32:05 INFO - Online: Yes 18:32:05 INFO - Rotation: Supported 18:32:05 INFO - Return code: 0 18:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:05 INFO - Python 2.7.3 18:32:05 INFO - Return code: 0 18:32:05 INFO - grabbing minidump binary from tooltool 18:32:05 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')]} 18:32:05 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 0x108b86d30>, '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 0x108aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:05 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 18:32:05 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 18:32:05 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 18:32:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:05 INFO - Return code: 0 18:32:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:05 INFO - ENV: RUST_BACKTRACE is now 1 18:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:05 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/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 18:32:05 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/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --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 18:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1fwIg7jkox/Render', 18:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:05 INFO - 'HOME': '/Users/cltbld', 18:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:05 INFO - 'LOGNAME': 'cltbld', 18:32:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:05 INFO - 'MOZ_NO_REMOTE': '1', 18:32:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:05 INFO - 'NO_EM_RESTART': '1', 18:32:05 INFO - 'PAGER': '/bin/cat', 18:32:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:05 INFO - 'PWD': '/builds/slave/test', 18:32:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:05 INFO - 'RUST_BACKTRACE': '1', 18:32:05 INFO - 'SHELL': '/bin/bash', 18:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pGUPcZdaNL/Listeners', 18:32:05 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:05 INFO - 'USER': 'cltbld', 18:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:05 INFO - 'XPC_FLAGS': '0x0', 18:32:05 INFO - 'XPC_SERVICE_NAME': '0', 18:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:05 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/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 18:32:05 INFO - mozversion application_buildid: 20170324170416 18:32:05 INFO - mozversion application_changeset: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 18:32:05 INFO - mozversion application_display_name: Nightly 18:32:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:05 INFO - mozversion application_name: Firefox 18:32:05 INFO - mozversion application_remotingname: firefox 18:32:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:32:05 INFO - mozversion application_vendor: Mozilla 18:32:05 INFO - mozversion application_version: 55.0a1 18:32:05 INFO - mozversion platform_buildid: 20170324170416 18:32:05 INFO - mozversion platform_changeset: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 18:32:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:32:05 INFO - mozversion platform_version: 55.0a1 18:32:05 INFO - using testdate: 1490405525 18:32:05 INFO - actual date: 1490405525 18:32:05 INFO - starting webserver on 'localhost:49249' 18:32:05 INFO - SUITE-START | Running 2 tests 18:32:05 INFO - TEST-START | dromaeo_css 18:32:05 INFO - operating with platform_type : mac_ 18:32:05 INFO - Initialising browser for dromaeo_css test... 18:32:05 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpidnLsN/profile http://localhost:49249/getInfo.html) 18:32:08 INFO - PID 1629 | __metrics Screen width/height:1600/1200 18:32:08 INFO - PID 1629 | colorDepth:24 18:32:08 INFO - PID 1629 | Browser inner width/height: 1024/689 18:32:08 INFO - PID 1629 | __metrics 18:32:08 INFO - PID 1629 | 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" 18:32:08 INFO - PID 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:32:09 INFO - TEST-INFO | 1629: exit 0 18:32:09 INFO - Browser initialized. 18:32:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:09 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpidnLsN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:21 INFO - PID 1631 | RSS: Main: 233742336 18:32:21 INFO - PID 1631 | 18:35:25 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 18:35:27 INFO - PID 1631 | RSS: Main: 416731136 18:35:27 INFO - PID 1631 | 18:37:11 INFO - PID 1631 | ************************* 18:37:11 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 18:37:11 INFO - PID 1631 | 18:37:11 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:37:11 INFO - PID 1631 | Full stack: 18:37:11 INFO - PID 1631 | ************************* 18:38:30 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 18:38:31 INFO - PID 1631 | RSS: Main: 365101056 18:38:31 INFO - PID 1631 | 18:41:33 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 18:41:34 INFO - PID 1631 | RSS: Main: 341118976 18:41:34 INFO - PID 1631 | 18:44:36 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 18:44:37 INFO - PID 1631 | RSS: Main: 327200768 18:44:37 INFO - PID 1631 | 18:47:41 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 18:47:41 INFO - PID 1631 | RSS: Main: 333025280 18:47:41 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 18:50:45 INFO - PID 1631 | RSS: Main: 518344704 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | __start_tp_report 18:50:45 INFO - PID 1631 | _x_x_mozilla_page_load 18:50:45 INFO - PID 1631 | _x_x_mozilla_page_load_details 18:50:45 INFO - PID 1631 | |i|pagename|runs| 18:50:45 INFO - PID 1631 | |0;dojo.html;3331.883384081558;3456.1014136324548;3483.703885169762;3517.7361697872648;3543.805090720011;6123.4046368898735;6203.193584833976;6223.782167624134;6224.066390041496;6244.718987645556;6100.603460775058;6135.324535308564;6164.59930104544;6183.567150299481;6199.44205021548;5060.569851562622;5391.892162156764;5500.889982200353;5506.752196151183;5641.097424412095;5564.443555644443;5599.468050535193;5605.355384130837;5617;5634.352049514297;5407.215953686713;5447.346318441772;5455.563554915597;5463.972680136574;5524.364698059734;5480.287562616874;5497.670139791625;5499.615026948115;5558.777648894039;5576.693281869496;5471.972640136773;5483.561315094823;5485.4788795064405;5503.834884953418;5506.807261745819;5995.550333724988;6076.210092687967;6079.20970273866;6193.535484838655;6197.566170368076;5381.919271210935;6282.654454005028;6319.936800631981;6328.493720502349;6383.138276332728;6510.739570417178;6543.541952063358;6547.3125321841;6549.279579246279;6560.639164845931;6150.938490615082;6209.751609935597;6237.095621135;6250.468710159642;6254.21822272216;6386.584871983307;6719.865602687919;6725.6973436195485;6729.226138994079;6740.595564266062;6304.527160462983;6326.177596912464;6344.619322840645;6375.2668443128705;6377.362263773678;6439.8068057958335;6460.515461340418;6484.870302593922;6501.934980650133;6505.674716264168;5385.3268341457315;6403.807885763435;6410.455111315498;6413.967930160319;6417.935820641827;5085.771140298695;6302.212223472066;6307.810765677037;6309.7160627770945;6318.557700960889;5068.746562671851;5147.897042059138;5191.662541934762;5213.296205012351;5215.113430716788;4632.953670463319;4693.272542755878;4697.6711630185555;4720.33915251865;4731.668783185144;6224;6237.064440333896;6269.279032911274;6296.685165741695;6306.463950564162;6448.065030570541;6510.609363438209;6528.08606795049;6533.216014078341;6545.312742162005;6122.1542093545395;6167.506599472032;6182;6262.874742505124;6275.497960163176;5774.451427114417;5812.505936995318;5814.941850581525;5823.7379317929945;5843.035899076604;6671.966640166768;6709.228438729511;6712.966435167793;6715.966420167868;6727.966360168168;6298.968505157445;6366.363363663597;6429.132067170872;6539.346065393423;6550.934490655032;6672.432843208382;6700.731970721116;6721.227058888095;6727.293634168537;6727.461803055841;6388.616682999035;6426.807195784134;6430.099786029866;6431.517636177212;6432.2281326241155;6269.404406581368;6322.36776322364;6337.334579869047;6440.6135631862235;6529.216494020748;5711.514521265739;6314.242290924934;6318.905216421849;6323.20959880015;6330.52521060913;6143.754249830135;6300.369963003663;6304.779332723333;6311.779087731908;6312.5581209314905;6279.215098112736;6291.811245662638;6306.9684651576445;6316.084167795736;6316.463100636497;5204.765785539584;6258.7809426671665;6282.780102696383;6318.968405157945;6324.683765811783;6267.655278959701;6268.498520118288;6295.401936815995;6298.149749783721;6306.779262725782 18:50:45 INFO - PID 1631 | |1;ext.html;716.7348081209951;812.0945146162029;1139.1001109123793;1165.7668466306736;1166.3410173252107;37003.25993480129;37592.812035939816;37733.81133094331;37805.43291850617;37865.62134378655;41677.37483937744;42040.369394459034;42058;42070;42138;6123.540734444912;8607.569621518931;8745.693900713477;8759.78100547485;8764.123587641217;6163.537734669895;8499.065102838682;8690.695825646104;8694.347923905701;8723.25852302555;8844.5577721114;8875.822483550324;8907.975582807963;8916.777080573005;8921.286297096216;6098.2682078150465;8826.73519794404;8857.778555536132;8893.644254229823;8910.688125915627;6136.294326152505;8335.583220838933;8487.02399224091;8493.745187644381;8495.235428811437;38694.61305386967;39233.215335693414;39288.214235715124;39331.016724582114;39443.40834887479;3017.89437369691;3020.864061117233;3025.1227144128175;3052.206426329148;3078.507438809802;27346.863265683543;27583.724162758517;27624.447511049668;28035.29911752202;28626.856865715537;2818.3517790908;2837.294405244176;2848.2879280179955;2868.3976364963382;2905.1575043237435;318673;320991;321571;321583;321676.9999999977;38631;39251.82244532669;50541.98916021659;50793.74603127035;51044.744776276624;40796;47890;49066.50933490619;49149.330813572655;49182.50817491851;14010.509632162826;14126.85873141276;14152.71694566103;14154.36305366261;14154.929225353808;11545.653630391102;11547.942260288644;11561.479733412016;11577.363245021605;11593.188476806543;12128.272303661808;12164.209326393757;12176.695582610506;12269.509219631293;12404.875951240552;5263.921041184385;5305.761240744176;5306.708131052829;5306.761195746123;5321.175217841241;889.8476472967393;895.5611750242334;972.7859870828406;972.9318947673736;1003.8293490106553;22558.887205563868;23119.88440057789;24283.757162428148;24295.878520607283;24368.563143685846;1081.1512962324537;1083.4311986207147;1108.3903852880883;1116.1071143085499;1124.9493772780245;10189.796204075878;12115.878841211475;12235.265884046985;12304.446299916524;12323.876761232452;425448;425875;426185;427832;428144;55440.722796386566;55700.72149639226;55711.164332535045;55737.86883442818;55800;1458.329168582464;1474.8156480439945;1476.7932489451484;1522.824875139329;1522.9923850380678;23562.52874942457;23661.05355785818;23707.40731481727;23780.524389511767;24133;38177.80911095538;48695.26957095717;49580.25629615631;49611;49662;336685;397910;399015;401416;401451;25402.364940875887;25791.710414479578;25941.6108758365;31513.21216969594;32209.51685724763;35137.47293790647;41634;41704;43064.2774289025;43128.78435607802;28067.71932280651;28232.717672823008;29248.707512924597;29659;30001.54997674993;29132.27169320784;29393.19954743085;29902.25244368908;30014.84992575023;30248.108744685207;34985.82507087448;35895.64104358923;35898.10254743652;35945.64054359423;36109.63890361168;29532.409351813272;29799.55300670535;30111;30476.238094046937;30483.237919051313;22600.208992685177;23299.88350058239;23409.88295058582;23770.762292376854;23994.76005239925 18:50:45 INFO - PID 1631 | |2;jquery.html;427.12226374799775;429.167494536062;437.590852552863;440.2581649919885;446.43080072907037;20355.982200889972;20482.18071277149;21183.04676289567;21208.36374908751;21418.89290553549;21156.57686846262;21883.67174492384;22612.8869355653;22657;22965.77034229657;5167.844964651066;6069;6323.810285691414;6333.683315834213;6342.936570634304;6158.983767678328;6252.3435039320675;6314.400131987477;6314.526410519206;6322.652254126021;5326.786928522854;6113.358097399776;6286.685665716719;6288.182536270278;6296.055591661242;6048.969755151218;6201.16284301618;6202.317745048041;6202.9689851550675;6224.128621992924;5416.620836541444;5434.75543600535;5462.781488740446;5488;5497.587680923947;26933.17201693833;26935.461290774074;27060.1881943542;27224;27273;2006.7190593316948;2020.7676117246558;2026.3313106674761;2029.076770069615;2051.312810208582;15060.096394216382;15749.212539372986;16004.279807408695;16035.759463608056;16109.919450402791;1545.1887758926541;1621.2137113499944;1633.6732653469235;1641.9014859108493;1656.9171541422882;147696.2615186928;163554;164824;165686.17156914138;166860.16569917073;12056.63830085099;12371.381430928417;12406.441710123067;12414.131010829155;12608.74782504363;16695.83304166967;16707.916460417862;16724.331026759035;16735.6652866942;16800.579985500215;8414.158584141536;8509.531975741394;8686.261667758312;8757.255633271243;9032.774180645536;6634.900476492857;8128.431009829374;8264.876026859602;8282.461639993382;8386.706465273808;7441.739539116105;7499.638337249359;7590.7722768317035;7616.543007419462;7629.046369203849;1834.3763120538813;2090.571432856261;2122.630903067513;2123.309924274617;2129.98935005324;910.7540963939699;924.6717415317465;925.9027802080684;965.4496936746128;966.6809952715587;19418.902905485666;20617.79382206189;20654.178976889325;20675.483112921997;21041.368758937257;860.7159637319795;896.462122726359;958.3818437108026;989.4113002763344;999;9869.950650246703;10579.471026448648;10653.78692426147;10655.147588192925;10708.678739637824;670041;673316;689129;692801;699219;158410;160180.98190180887;161596;163203.80729565068;167177;1117.6088369070924;1148.735790768128;1169.8830116988404;1170.6136974798296;1174.2015429508017;14535.709285814013;14841.480548180762;15561.533154004945;17503.212355443782;17801.308875656792;60313;60479.69760151347;61087.69456152691;62272.75454490794;62629.060564090665;55398;70886.16455341729;84303;85008.57495712482;86522.56738716266;8018.4787988780545;8114.715984940499;8242.505449673039;8419.915800841913;8575.914240857512;12721.236725796482;12842.67893302675;12931.870681293443;13199.802002969771;13287.80068298957;9468.715938521855;10968.396738179157;11121;11226.719332016764;11258.887411125785;10113.64602238918;10159.288849780445;10209.38743675352;10369.948150259503;10385.896141038493;11193.66419007431;11236.494357753758;11439.771204576029;11442.885571144181;11563.95924366811;8093.35253179756;8209.507429554245;8396.706115285935;8408.873866892123;8417.915820841714;10962.068224201032;11269.267497612629;11440.542378304775;11449.026832719312;11460.312381257152 18:50:45 INFO - PID 1631 | |3;mootools.html;1169.8303745956832;1360.2314692198906;1432.3339647064113;1452.2012892908904;1462.7074585082983;9049.728508144757;9449.007854175316;10235.437050962195;10605.363678179314;10660.573577056928;10380.11768999636;10540.209484288689;10555.208359373059;10571.207159463032;10575.101116405114;2396.7363590005084;2450.338408629678;2458.6926634170727;2460.987695061522;2472.7279999200073;2067.1214733738175;2140.368591265573;2374.5725769361507;2462.802975761944;2465.285067330481;2425;2427.8421902576274;2430.16159424999;2437.5856104462196;2439.0609615298063;2401.423658321999;2429.477662302596;2432.2095319021214;2433.2700189943125;2437.6465412515263;2330.3940975346363;2393.401649587603;2438.2807071913826;2444.046821739523;2454.9263522094366;10703.1437485001;10821.621243256526;10823.404712740796;10825.971532704381;10833.67498975032;6141.078838174265;6376.48988080957;6376.521760867953;6377.23473183221;6380.266269379034;3775.2260786538695;3826.1773718650625;4008.2584721826556;4078.4086307485545;4082.632563069308;1198.4726720243066;1221.822835688829;1488.1220080152655;1549.4886687393134;1575.4092215419219;14468.49360272396;14624.853751462562;14706.4852730155;14734.557963261119;14760.483383081648;5352.759125839347;5666.688332141689;5757.337906140848;5762.761006383647;5782.074868021181;12706.809397859039;12718.809217861739;12724.300163490912;12733.426995785212;12753.68115797094;6440.677966101676;6449.935500644933;6453.677316134174;6454.32229615893;6477.838054048687;4884.853454396374;5512.228288039678;5838.649681019152;5854.560907931922;5870.295564532198;3975.522937247491;4066.1664358806374;4076.6331030207425;4087.652549533323;4119.361498967664;1275.4196840437578;1293.9223646581236;1307.5946456598485;1342.3489607540334;1378.7656098463285;760.6044856674608;764.2395816162842;765.0398749569366;775.3293401208027;814.771863878115;6304.810855674337;6544.70548825304;6594.9670251649395;6674.933250667528;6705.966470167618;859.6991053131354;894.5884892949316;918.93108016899;928.6888892221182;936.4989730494153;3989.0625702959783;4126.236646220459;4148.751074935513;4225.535191128974;4263.59495847894;13067.673308167372;13232.933835330954;13575.864241357658;13597.592072237849;13780.10429322111;13046.804297935538;13442.865571344162;13508.932455337661;13509.59471215865;13515;8795.164459376349;9831.508424578742;9993.350432221881;10096.69709908704;10127.24045696561;5868.589198756217;5920.437558431942;6543.607383557001;6800.6599670017295;6823.93176068233;10106.444145572064;11824.290542567473;12172.14794964344;12182.634520964386;12260.877391225973;10002.799944001225;12293.692657683272;12306.81539776922;12499.375031248583;12697.238165710087;8620.52587107715;9004.59479323419;9090.863637045582;9121.270298376247;9127.817443651222;8570;9834.360766550151;9934.652287169914;9976.50117494137;9989.950050249703;8434.957825210835;8435.915640843514;8550.1449855014;8552.786180345542;8659.740207793777;8198.139195384638;8326.750197494084;8397;8397.118302578385;8557.828843423222;7657.808554785952;7670.539767613961;7817.687292508236;7828.099768526692;7870.645820937957;4703.929441058319;5888.764449422147;5940.198073260054;6020.819375418744;6081.939180608314;5970.223870896929;6004.699765011819;6028.939710602838;6057.18228039209;6073.817785466443 18:50:45 INFO - PID 1631 | |4;prototype.html;388.755084296893;398.2705373687462;398.9381645844893;403.8768175706408;407.3157096078589;5153.4846515348445;5571.13647384655;5955.88088238235;6044.395560443953;6114.5108391328695;4842.927356089653;5121.385433747946;5779.508741756945;5780.739866705998;5939.910901336483;4505.8422955196575;4645.883852903679;4649.907001859978;4667.413079552951;4672.369230153937;3869.8452061917487;4683.672142949995;4687.507811679776;4706.176419126639;4717.433907931053;4038.1721747041934;4370.475542934836;4612.907741845161;4645.628349732014;4671.672982891199;4227.795078402641;4597.7241365518175;4597.804570811596;4625.283081122415;4629.490756016836;3545.85816567337;3962.2669806085964;4094.2016306820183;4117.155983023473;4129.669626429878;5533.6403133796575;5782.9421705782825;5861.036552754832;5895.204147440127;5937.67342796146;5384.892302153974;5388.299521062276;5405.783768649249;5409.864753381157;5415.756290966916;5002.799888004475;5249.947500525022;5546.667199968015;6358.268799088118;6363.713632886531;4017.7388469749667;4439.889002774924;4504.684672072956;4534.070515544306;4548.7725613719185;5555.722213889329;5857.970710146422;6224.470919971763;6347;6544.312847151028;3806.5051543299196;4039.939400908989;4648.349231107648;4704.1767690654;4710.599599034052;4553.269757492198;4807.423109226916;4813.855584332476;4824.734639594786;4824.831130910471;5034.496550344937;5188.896222075613;5325.786968521294;5342.91985620216;5355.30381050461;5550.639208451437;6352.428281454599;6359.887019771614;6392.808215753535;6395.20059992501;1291.560869304441;1386.9930650346685;1528.678977414733;1617.9595510112106;1642.5647203491085;1099.571167244775;1122.2424863217295;1125.9549618015187;1134.7390100276818;1140.492480846032;5923.526117910556;5934.703264836828;5939.22790037301;5944.316403613553;5961.731722072517;6467.547271691031;6469.256035555877;6503.536704241508;6515.7719479818925;6521.380468855546;5357.276767636397;5430.348358197041;6005.369436209223;6041;6069.211002569726;3018.9396212075635;3385.25524384635;3435.003848883796;3449.3618680543677;3451.240727040047;5864.501517370986;6349.428551430301;6575.671216439255;6620.503462240351;6633.668316584151;6401.487880969511;6585.934140658532;6655.401013908771;6712.42944349726;6931.202911665223;6430.453411459985;6636.203655561363;6655.733770649314;6661.634364955173;6722.428593569503;6422.3577642235405;6486.318936511599;6487.902681459687;6490.3185165558825;6496.512761542808;5126.769295381791;6084.574079814371;6406.679666016774;6419.903701444388;6500.804975850732;5958.642481450954;6579.2104947406615;6663;6697.531172817856;6728.226253980659;3413.2490852012515;3752.9624703753707;4266.360045993126;4306.332518459643;4309.784510774512;6245.437910588069;6524.608523488606;6525.314841941527;6561.770338038145;6574.901376479261;6310.7791227306825;6365.936340636535;6370.90443643355;6382.5532212744665;6405.790002449147;6054.636721796706;6337.904931426125;6342.746290148342;6369.8849104859855;6382.840428989312;5178.61160412963;5433.429489903503;6173.259208894961;6191.133241346305;6192.752289908353;6328.683565821782;6349.777757778455;6361.968190159205;6364.968175159094;6374.3306952771145;5596.90860282241;5936.5844390892225;6146.262448506029;6226.346233645402;6256.624602523863 18:50:45 INFO - PID 1631 | |5;yui.html;716.6022857314189;718.5257729898268;736.6611358774963;738.4941315199087;767.3439209475898;14934.77597836032;15662.21688915554;15803.130827804465;16790.412335568257;17651.76437649365;16252.43116490923;16300.510984670449;16643.25105370258;16646.417375391833;16743.497695069138;939.2016785732108;971.946542940138;972.2416515118219;975.1516180922572;975.5707488704948;942.1379437814426;975.3367709957226;979.4368238262991;983.2969426859794;986.6990567876795;1034.2139973620065;1035.1977217656301;1035.3011717090933;1035.4719093262452;1038.7247379444452;1027.434910799065;1027.696829435311;1031.4791030529573;1033.8139134955704;1033.819081660714;761.7219714804056;762.7826069570201;766.5898744171897;767.7658314214162;773.9574323412266;15943.760843587355;16125.516234512983;16290.755638665429;16419.917900410543;16693;13862.861371386358;14392.784108238386;14672.810322941788;14693.853061469463;14828.925855370762;11723.062155027577;11732.53069877204;11885.881141188564;11927.88072119285;12255.69360765979;3000.819950802959;3121.3601211751766;3153.4323821712082;3153.7003984621424;3155;98650;102323.99999999926;103204.48397758038;104106;106443.46778266136;10903.727406814734;11284.830727539094;11333.206675532798;11442.37066961325;11603.76792464146;20672.069756860976;24199.39501512441;24691.753082469306;25007.749922500905;25039.12363067284;7746.264104910025;7780.533168009937;7812.765617031499;7893.447458677952;8022.879656805153;4129.855455059059;4183.832646694098;4213.768242746617;4217.283061879488;4232.470941132358;4064.532578753422;4158.9376159357635;4166;4170.249355116048;4174.019105510202;771.733751855609;779.174075479993;786.2137862137862;789.960501974899;808.6967387229789;536.7262696025056;553.5875772549476;576.9019266724667;583.4049269744921;589.7139887154726;9281.071892810665;9683.080107389927;9708.437806878073;9710.465924374228;9848.35985660944;531.8803269264384;537.5941164420838;562.4038519169693;573.8020382967869;579.3829571506333;4422.911541769146;4521.84173553924;4550.317452382103;4612.43810223183;4645.958550761933;94296.52851735697;95478;96361;96685.51657241669;99820.50089749505;83698.16301837025;84269.15730842736;85051;86170.07577633574;86575.56712216524;73318.63340683369;74588.62705686546;74681;75526;76148.61925690447;9195.954020229856;9197.678081267124;9202.907970920205;9209.355345125778;9316.673916412892;35597.82201088978;36124.638753612126;36158.457623135146;36428;36707;43001.78499107484;57179.42820571741;57606;59421.405785941584;60256.39743602508;10890.727731806768;13697.246651434267;13715.1085179463;13793.517226897011;14131;11706.414679266172;14281.285935702965;14376.928115359775;14483.710325793214;14629.981024668103;13309.66725831862;13352.666183345105;13393.129446585941;13670.52153174634;13818.792718109034;10802.243842930919;12584.307863067253;12963.740725185633;12965.611031669065;13378.264195469343;13019.739605208033;13092.869071309166;13219.801702974655;13539;13863.029587928748;9345.766355841159;9447.811043779224;9615.2307815376;9754.658586949423;9964.800703986024;8978.281737461119;10787.730306742395;11049.723756906142;11143.665690029313;11199.88800112021 18:50:45 INFO - PID 1631 | __end_tp_report 18:50:45 INFO - PID 1631 | __start_cc_report 18:50:45 INFO - PID 1631 | _x_x_mozilla_cycle_collect,2106 18:50:45 INFO - PID 1631 | __end_cc_report 18:50:45 INFO - PID 1631 | __startTimestamp1490406645320__endTimestamp 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | ------- Summary: start ------- 18:50:45 INFO - PID 1631 | Number of tests: 6 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | [#0] dojo.html Cycles:165 Average:6016.55 Median:6275.50 stddev:664.60 (10.6%) stddev-sans-first:632.39 18:50:45 INFO - PID 1631 | Values: 3331.9 3456.1 3483.7 3517.7 3543.8 6123.4 6203.2 6223.8 6224.1 6244.7 6100.6 6135.3 6164.6 6183.6 6199.4 5060.6 5391.9 5500.9 5506.8 5641.1 5564.4 5599.5 5605.4 5617.0 5634.4 5407.2 5447.3 5455.6 5464.0 5524.4 5480.3 5497.7 5499.6 5558.8 5576.7 5472.0 5483.6 5485.5 5503.8 5506.8 5995.6 6076.2 6079.2 6193.5 6197.6 5381.9 6282.7 6319.9 6328.5 6383.1 6510.7 6543.5 6547.3 6549.3 6560.6 6150.9 6209.8 6237.1 6250.5 6254.2 6386.6 6719.9 6725.7 6729.2 6740.6 6304.5 6326.2 6344.6 6375.3 6377.4 6439.8 6460.5 6484.9 6501.9 6505.7 5385.3 6403.8 6410.5 6414.0 6417.9 5085.8 6302.2 6307.8 6309.7 6318.6 5068.7 5147.9 5191.7 5213.3 5215.1 4633.0 4693.3 4697.7 4720.3 4731.7 6224.0 6237.1 6269.3 6296.7 6306.5 6448.1 6510.6 6528.1 6533.2 6545.3 6122.2 6167.5 6182.0 6262.9 6275.5 5774.5 5812.5 5814.9 5823.7 5843.0 6672.0 6709.2 6713.0 6716.0 6728.0 6299.0 6366.4 6429.1 6539.3 6550.9 6672.4 6700.7 6721.2 6727.3 6727.5 6388.6 6426.8 6430.1 6431.5 6432.2 6269.4 6322.4 6337.3 6440.6 6529.2 5711.5 6314.2 6318.9 6323.2 6330.5 6143.8 6300.4 6304.8 6311.8 6312.6 6279.2 6291.8 6307.0 6316.1 6316.5 5204.8 6258.8 6282.8 6319.0 6324.7 6267.7 6268.5 6295.4 6298.1 6306.8 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | [#1] ext.html Cycles:180 Average:51369.54 Median:35061.65 stddev:100975.62 (288.0%) stddev-sans-first:101187.26 18:50:45 INFO - PID 1631 | Values: 716.7 812.1 1139.1 1165.8 1166.3 37003.3 37592.8 37733.8 37805.4 37865.6 41677.4 42040.4 42058.0 42070.0 42138.0 6123.5 8607.6 8745.7 8759.8 8764.1 6163.5 8499.1 8690.7 8694.3 8723.3 8844.6 8875.8 8908.0 8916.8 8921.3 6098.3 8826.7 8857.8 8893.6 8910.7 6136.3 8335.6 8487.0 8493.7 8495.2 38694.6 39233.2 39288.2 39331.0 39443.4 3017.9 3020.9 3025.1 3052.2 3078.5 27346.9 27583.7 27624.4 28035.3 28626.9 2818.4 2837.3 2848.3 2868.4 2905.2 318673.0 320991.0 321571.0 321583.0 321677.0 38631.0 39251.8 50542.0 50793.7 51044.7 40796.0 47890.0 49066.5 49149.3 49182.5 14010.5 14126.9 14152.7 14154.4 14154.9 11545.7 11547.9 11561.5 11577.4 11593.2 12128.3 12164.2 12176.7 12269.5 12404.9 5263.9 5305.8 5306.7 5306.8 5321.2 889.8 895.6 972.8 972.9 1003.8 22558.9 23119.9 24283.8 24295.9 24368.6 1081.2 1083.4 1108.4 1116.1 1124.9 10189.8 12115.9 12235.3 12304.4 12323.9 425448.0 425875.0 426185.0 427832.0 428144.0 55440.7 55700.7 55711.2 55737.9 55800.0 1458.3 1474.8 1476.8 1522.8 1523.0 23562.5 23661.1 23707.4 23780.5 24133.0 38177.8 48695.3 49580.3 49611.0 49662.0 336685.0 397910.0 399015.0 401416.0 401451.0 25402.4 25791.7 25941.6 31513.2 32209.5 35137.5 41634.0 41704.0 43064.3 43128.8 28067.7 28232.7 29248.7 29659.0 30001.5 29132.3 29393.2 29902.3 30014.8 30248.1 34985.8 35895.6 35898.1 35945.6 36109.6 29532.4 29799.6 30111.0 30476.2 30483.2 22600.2 23299.9 23409.9 23770.8 23994.8 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | [#2] jquery.html Cycles:180 Average:40150.13 Median:22634.94 stddev:115519.78 (510.4%) stddev-sans-first:115805.34 18:50:45 INFO - PID 1631 | Values: 427.1 429.2 437.6 440.3 446.4 20356.0 20482.2 21183.0 21208.4 21418.9 21156.6 21883.7 22612.9 22657.0 22965.8 5167.8 6069.0 6323.8 6333.7 6342.9 6159.0 6252.3 6314.4 6314.5 6322.7 5326.8 6113.4 6286.7 6288.2 6296.1 6049.0 6201.2 6202.3 6203.0 6224.1 5416.6 5434.8 5462.8 5488.0 5497.6 26933.2 26935.5 27060.2 27224.0 27273.0 2006.7 2020.8 2026.3 2029.1 2051.3 15060.1 15749.2 16004.3 16035.8 16109.9 1545.2 1621.2 1633.7 1641.9 1656.9 147696.3 163554.0 164824.0 165686.2 166860.2 12056.6 12371.4 12406.4 12414.1 12608.7 16695.8 16707.9 16724.3 16735.7 16800.6 8414.2 8509.5 8686.3 8757.3 9032.8 6634.9 8128.4 8264.9 8282.5 8386.7 7441.7 7499.6 7590.8 7616.5 7629.0 1834.4 2090.6 2122.6 2123.3 2130.0 910.8 924.7 925.9 965.4 966.7 19418.9 20617.8 20654.2 20675.5 21041.4 860.7 896.5 958.4 989.4 999.0 9870.0 10579.5 10653.8 10655.1 10708.7 670041.0 673316.0 689129.0 692801.0 699219.0 158410.0 160181.0 161596.0 163203.8 167177.0 1117.6 1148.7 1169.9 1170.6 1174.2 14535.7 14841.5 15561.5 17503.2 17801.3 60313.0 60479.7 61087.7 62272.8 62629.1 55398.0 70886.2 84303.0 85008.6 86522.6 8018.5 8114.7 8242.5 8419.9 8575.9 12721.2 12842.7 12931.9 13199.8 13287.8 9468.7 10968.4 11121.0 11226.7 11258.9 10113.6 10159.3 10209.4 10369.9 10385.9 11193.7 11236.5 11439.8 11442.9 11564.0 8093.4 8209.5 8396.7 8408.9 8417.9 10962.1 11269.3 11440.5 11449.0 11460.3 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | [#3] mootools.html Cycles:180 Average:6696.11 Median:4071.40 stddev:4062.36 (99.8%) stddev-sans-first:4052.52 18:50:45 INFO - PID 1631 | Values: 1169.8 1360.2 1432.3 1452.2 1462.7 9049.7 9449.0 10235.4 10605.4 10660.6 10380.1 10540.2 10555.2 10571.2 10575.1 2396.7 2450.3 2458.7 2461.0 2472.7 2067.1 2140.4 2374.6 2462.8 2465.3 2425.0 2427.8 2430.2 2437.6 2439.1 2401.4 2429.5 2432.2 2433.3 2437.6 2330.4 2393.4 2438.3 2444.0 2454.9 10703.1 10821.6 10823.4 10826.0 10833.7 6141.1 6376.5 6376.5 6377.2 6380.3 3775.2 3826.2 4008.3 4078.4 4082.6 1198.5 1221.8 1488.1 1549.5 1575.4 14468.5 14624.9 14706.5 14734.6 14760.5 5352.8 5666.7 5757.3 5762.8 5782.1 12706.8 12718.8 12724.3 12733.4 12753.7 6440.7 6449.9 6453.7 6454.3 6477.8 4884.9 5512.2 5838.6 5854.6 5870.3 3975.5 4066.2 4076.6 4087.7 4119.4 1275.4 1293.9 1307.6 1342.3 1378.8 760.6 764.2 765.0 775.3 814.8 6304.8 6544.7 6595.0 6674.9 6706.0 859.7 894.6 918.9 928.7 936.5 3989.1 4126.2 4148.8 4225.5 4263.6 13067.7 13232.9 13575.9 13597.6 13780.1 13046.8 13442.9 13508.9 13509.6 13515.0 8795.2 9831.5 9993.4 10096.7 10127.2 5868.6 5920.4 6543.6 6800.7 6823.9 10106.4 11824.3 12172.1 12182.6 12260.9 10002.8 12293.7 12306.8 12499.4 12697.2 8620.5 9004.6 9090.9 9121.3 9127.8 8570.0 9834.4 9934.7 9976.5 9990.0 8435.0 8435.9 8550.1 8552.8 8659.7 8198.1 8326.8 8397.0 8397.1 8557.8 7657.8 7670.5 7817.7 7828.1 7870.6 4703.9 5888.8 5940.2 6020.8 6081.9 5970.2 6004.7 6028.9 6057.2 6073.8 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | [#4] prototype.html Cycles:180 Average:5171.85 Median:5688.21 stddev:1561.36 (27.4%) stddev-sans-first:1523.91 18:50:45 INFO - PID 1631 | Values: 388.8 398.3 398.9 403.9 407.3 5153.5 5571.1 5955.9 6044.4 6114.5 4842.9 5121.4 5779.5 5780.7 5939.9 4505.8 4645.9 4649.9 4667.4 4672.4 3869.8 4683.7 4687.5 4706.2 4717.4 4038.2 4370.5 4612.9 4645.6 4671.7 4227.8 4597.7 4597.8 4625.3 4629.5 3545.9 3962.3 4094.2 4117.2 4129.7 5533.6 5782.9 5861.0 5895.2 5937.7 5384.9 5388.3 5405.8 5409.9 5415.8 5002.8 5249.9 5546.7 6358.3 6363.7 4017.7 4439.9 4504.7 4534.1 4548.8 5555.7 5858.0 6224.5 6347.0 6544.3 3806.5 4039.9 4648.3 4704.2 4710.6 4553.3 4807.4 4813.9 4824.7 4824.8 5034.5 5188.9 5325.8 5342.9 5355.3 5550.6 6352.4 6359.9 6392.8 6395.2 1291.6 1387.0 1528.7 1618.0 1642.6 1099.6 1122.2 1126.0 1134.7 1140.5 5923.5 5934.7 5939.2 5944.3 5961.7 6467.5 6469.3 6503.5 6515.8 6521.4 5357.3 5430.3 6005.4 6041.0 6069.2 3018.9 3385.3 3435.0 3449.4 3451.2 5864.5 6349.4 6575.7 6620.5 6633.7 6401.5 6585.9 6655.4 6712.4 6931.2 6430.5 6636.2 6655.7 6661.6 6722.4 6422.4 6486.3 6487.9 6490.3 6496.5 5126.8 6084.6 6406.7 6419.9 6500.8 5958.6 6579.2 6663.0 6697.5 6728.2 3413.2 3753.0 4266.4 4306.3 4309.8 6245.4 6524.6 6525.3 6561.8 6574.9 6310.8 6365.9 6370.9 6382.6 6405.8 6054.6 6337.9 6342.7 6369.9 6382.8 5178.6 5433.4 6173.3 6191.1 6192.8 6328.7 6349.8 6362.0 6365.0 6374.3 5596.9 5936.6 6146.3 6226.3 6256.6 18:50:45 INFO - PID 1631 | 18:50:45 INFO - PID 1631 | [#5] yui.html Cycles:180 Average:19409.25 Median:4162.47 stddev:27418.56 (658.7%) stddev-sans-first:27459.55 18:50:45 INFO - PID 1631 | Values: 716.6 718.5 736.7 738.5 767.3 14934.8 15662.2 15803.1 16790.4 17651.8 16252.4 16300.5 16643.3 16646.4 16743.5 939.2 971.9 972.2 975.2 975.6 942.1 975.3 979.4 983.3 986.7 1034.2 1035.2 1035.3 1035.5 1038.7 1027.4 1027.7 1031.5 1033.8 1033.8 761.7 762.8 766.6 767.8 774.0 15943.8 16125.5 16290.8 16419.9 16693.0 13862.9 14392.8 14672.8 14693.9 14828.9 11723.1 11732.5 11885.9 11927.9 12255.7 3000.8 3121.4 3153.4 3153.7 3155.0 98650.0 102324.0 103204.5 104106.0 106443.5 10903.7 11284.8 11333.2 11442.4 11603.8 20672.1 24199.4 24691.8 25007.7 25039.1 7746.3 7780.5 7812.8 7893.4 8022.9 4129.9 4183.8 4213.8 4217.3 4232.5 4064.5 4158.9 4166.0 4170.2 4174.0 771.7 779.2 786.2 790.0 808.7 536.7 553.6 576.9 583.4 589.7 9281.1 9683.1 9708.4 9710.5 9848.4 531.9 537.6 562.4 573.8 579.4 4422.9 4521.8 4550.3 4612.4 4646.0 94296.5 95478.0 96361.0 96685.5 99820.5 83698.2 84269.2 85051.0 86170.1 86575.6 73318.6 74588.6 74681.0 75526.0 76148.6 9196.0 9197.7 9202.9 9209.4 9316.7 35597.8 36124.6 36158.5 36428.0 36707.0 43001.8 57179.4 57606.0 59421.4 60256.4 10890.7 13697.2 13715.1 13793.5 14131.0 11706.4 14281.3 14376.9 14483.7 14630.0 13309.7 13352.7 13393.1 13670.5 13818.8 10802.2 12584.3 12963.7 12965.6 13378.3 13019.7 13092.9 13219.8 13539.0 13863.0 9345.8 9447.8 9615.2 9754.7 9964.8 8978.3 10787.7 11049.7 11143.7 11199.9 18:50:45 INFO - PID 1631 | -------- Summary: end -------- 18:50:45 INFO - PID 1631 | 18:50:45 INFO - TEST-INFO | 1631: exit 0 18:50:45 INFO - TEST-OK | dromaeo_css | took 1120528ms 18:50:45 INFO - TEST-START | kraken 18:50:45 INFO - operating with platform_type : mac_ 18:50:45 INFO - Initialising browser for kraken test... 18:50:46 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpEt0tN5/profile http://localhost:49249/getInfo.html) 18:50:48 INFO - PID 1641 | __metrics Screen width/height:1600/1200 18:50:48 INFO - PID 1641 | colorDepth:24 18:50:48 INFO - PID 1641 | Browser inner width/height: 1024/689 18:50:48 INFO - PID 1641 | __metrics 18:50:48 INFO - PID 1641 | 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" 18:50:48 INFO - PID 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:50:49 INFO - TEST-INFO | 1641: exit 0 18:50:49 INFO - Browser initialized. 18:50:49 INFO - Running cycle 1/1 for kraken test... 18:50:49 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpEt0tN5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:01 INFO - PID 1642 | RSS: Main: 234070016 18:51:01 INFO - PID 1642 | 18:51:04 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:05 INFO - PID 1642 | RSS: Main: 285519872 18:51:05 INFO - PID 1642 | 18:51:07 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 18:51:08 INFO - PID 1642 | RSS: Main: 287227904 18:51:08 INFO - PID 1642 | 18:51:11 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 18:51:12 INFO - PID 1642 | RSS: Main: 378118144 18:51:12 INFO - PID 1642 | 18:51:14 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 18:51:15 INFO - PID 1642 | RSS: Main: 281989120 18:51:15 INFO - PID 1642 | 18:51:17 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:17 INFO - PID 1642 | RSS: Main: 285249536 18:51:17 INFO - PID 1642 | 18:51:20 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:21 INFO - PID 1642 | RSS: Main: 325443584 18:51:21 INFO - PID 1642 | 18:51:24 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:25 INFO - PID 1642 | RSS: Main: 341041152 18:51:25 INFO - PID 1642 | 18:51:27 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 18:51:28 INFO - PID 1642 | RSS: Main: 350265344 18:51:28 INFO - PID 1642 | 18:51:30 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:30 INFO - PID 1642 | RSS: Main: 301678592 18:51:30 INFO - PID 1642 | 18:51:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:33 INFO - PID 1642 | RSS: Main: 307568640 18:51:33 INFO - PID 1642 | 18:51:35 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:36 INFO - PID 1642 | RSS: Main: 309432320 18:51:36 INFO - PID 1642 | 18:51:38 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:39 INFO - PID 1642 | RSS: Main: 325038080 18:51:39 INFO - PID 1642 | 18:51:42 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:43 INFO - PID 1642 | RSS: Main: 319139840 18:51:43 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 18:51:45 INFO - PID 1642 | RSS: Main: 380956672 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | __start_tp_report 18:51:45 INFO - PID 1642 | _x_x_mozilla_page_load 18:51:45 INFO - PID 1642 | _x_x_mozilla_page_load_details 18:51:45 INFO - PID 1642 | |i|pagename|runs| 18:51:45 INFO - PID 1642 | |0;ai-astar;111;113;125;121;113;113;111;112;112;112 18:51:45 INFO - PID 1642 | |1;audio-beat-detection;171;147;108;147;112;111;110;117;173;145 18:51:45 INFO - PID 1642 | |2;audio-dft;186;184;183;186;186;185;182;185;183;185 18:51:45 INFO - PID 1642 | |3;audio-fft;80;60;58;91;61;58;60;56;79;58 18:51:45 INFO - PID 1642 | |4;audio-oscillator;92;70;88;68;69;69;84;69;69;84 18:51:45 INFO - PID 1642 | |5;imaging-gaussian-blur;88;87;74;133;127;87;87;87;87;97 18:51:45 INFO - PID 1642 | |6;imaging-darkroom;94;95;95;94;95;94;95;94;94;94 18:51:45 INFO - PID 1642 | |7;imaging-desaturate;85;86;84;84;91;84;85;85;83;84 18:51:45 INFO - PID 1642 | |8;json-parse-financial;65;63;61;60;60;61;62;61;60;61 18:51:45 INFO - PID 1642 | |9;json-stringify-tinderbox;54;54;65;68;61;58;58;58;57;57 18:51:45 INFO - PID 1642 | |10;stanford-crypto-aes;83;82;75;82;82;81;82;81;81;81 18:51:45 INFO - PID 1642 | |11;stanford-crypto-ccm;130;140;148;154;146;137;138;136;182;144 18:51:45 INFO - PID 1642 | |12;stanford-crypto-pbkdf2;186;184;183;184;186;181;189;182;182;179 18:51:45 INFO - PID 1642 | |13;stanford-crypto-sha256-iterative;67;68;65;85;99;77;69;68;70;67 18:51:45 INFO - PID 1642 | __end_tp_report 18:51:45 INFO - PID 1642 | __start_cc_report 18:51:45 INFO - PID 1642 | _x_x_mozilla_cycle_collect,2153 18:51:45 INFO - PID 1642 | __end_cc_report 18:51:45 INFO - PID 1642 | __startTimestamp1490406705520__endTimestamp 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | ------- Summary: start ------- 18:51:45 INFO - PID 1642 | Number of tests: 14 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#0] ai-astar Cycles:10 Average:114.30 Median:113.00 stddev:4.74 (4.2%) stddev-sans-first:4.87 18:51:45 INFO - PID 1642 | Values: 111.0 113.0 125.0 121.0 113.0 113.0 111.0 112.0 112.0 112.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:146.00 stddev:25.61 (17.5%) stddev-sans-first:23.43 18:51:45 INFO - PID 1642 | Values: 171.0 147.0 108.0 147.0 112.0 111.0 110.0 117.0 173.0 145.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.43 (0.8%) stddev-sans-first:1.41 18:51:45 INFO - PID 1642 | Values: 186.0 184.0 183.0 186.0 186.0 185.0 182.0 185.0 183.0 185.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:12.38 (20.5%) stddev-sans-first:12.06 18:51:45 INFO - PID 1642 | Values: 80.0 60.0 58.0 91.0 61.0 58.0 60.0 56.0 79.0 58.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.00 stddev:9.57 (12.4%) stddev-sans-first:8.26 18:51:45 INFO - PID 1642 | Values: 92.0 70.0 88.0 68.0 69.0 69.0 84.0 69.0 69.0 84.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:95.40 Median:87.00 stddev:19.09 (21.9%) stddev-sans-first:20.06 18:51:45 INFO - PID 1642 | Values: 88.0 87.0 74.0 133.0 127.0 87.0 87.0 87.0 87.0 97.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:51:45 INFO - PID 1642 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:2.23 (2.6%) stddev-sans-first:2.37 18:51:45 INFO - PID 1642 | Values: 85.0 86.0 84.0 84.0 91.0 84.0 85.0 85.0 83.0 84.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:61.00 stddev:1.58 (2.6%) stddev-sans-first:1.00 18:51:45 INFO - PID 1642 | Values: 65.0 63.0 61.0 60.0 60.0 61.0 62.0 61.0 60.0 61.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:58.00 stddev:4.50 (7.8%) stddev-sans-first:4.39 18:51:45 INFO - PID 1642 | Values: 54.0 54.0 65.0 68.0 61.0 58.0 58.0 58.0 57.0 57.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:82.00 stddev:2.21 (2.7%) stddev-sans-first:2.22 18:51:45 INFO - PID 1642 | Values: 83.0 82.0 75.0 82.0 82.0 81.0 82.0 81.0 81.0 81.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:145.00 stddev:14.54 (10.0%) stddev-sans-first:14.30 18:51:45 INFO - PID 1642 | Values: 130.0 140.0 148.0 154.0 146.0 137.0 138.0 136.0 182.0 144.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:184.00 stddev:2.88 (1.6%) stddev-sans-first:2.92 18:51:45 INFO - PID 1642 | Values: 186.0 184.0 183.0 184.0 186.0 181.0 189.0 182.0 182.0 179.0 18:51:45 INFO - PID 1642 | 18:51:45 INFO - PID 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:69.50 stddev:10.77 (15.5%) stddev-sans-first:11.17 18:51:45 INFO - PID 1642 | Values: 67.0 68.0 65.0 85.0 99.0 77.0 69.0 68.0 70.0 67.0 18:51:45 INFO - PID 1642 | -------- Summary: end -------- 18:51:45 INFO - PID 1642 | 18:51:46 INFO - TEST-INFO | 1642: exit 0 18:51:46 INFO - TEST-OK | kraken | took 60502ms 18:51:46 INFO - SUITE-END | took 1181s 18:51:46 INFO - Completed test suite (00:19:41) 18:51:46 INFO - javascript benchmark 18:51:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7593.980881444481, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3331.883384081558, 3456.1014136324548, 3483.703885169762, 3517.7361697872648, 3543.805090720011, 6123.4046368898735, 6203.193584833976, 6223.782167624134, 6224.066390041496, 6244.718987645556, 6100.603460775058, 6135.324535308564, 6164.59930104544, 6183.567150299481, 6199.44205021548, 5060.569851562622, 5391.892162156764, 5500.889982200353, 5506.752196151183, 5641.097424412095, 5564.443555644443, 5599.468050535193, 5605.355384130837, 5617.0, 5634.352049514297, 5407.215953686713, 5447.346318441772, 5455.563554915597, 5463.972680136574, 5524.364698059734, 5480.287562616874, 5497.670139791625, 5499.615026948115, 5558.777648894039, 5576.693281869496, 5471.972640136773, 5483.561315094823, 5485.4788795064405, 5503.834884953418, 5506.807261745819, 5995.550333724988, 6076.210092687967, 6079.20970273866, 6193.535484838655, 6197.566170368076, 5381.919271210935, 6282.654454005028, 6319.936800631981, 6328.493720502349, 6383.138276332728, 6510.739570417178, 6543.541952063358, 6547.3125321841, 6549.279579246279, 6560.639164845931, 6150.938490615082, 6209.751609935597, 6237.095621135, 6250.468710159642, 6254.21822272216, 6386.584871983307, 6719.865602687919, 6725.6973436195485, 6729.226138994079, 6740.595564266062, 6304.527160462983, 6326.177596912464, 6344.619322840645, 6375.2668443128705, 6377.362263773678, 6439.8068057958335, 6460.515461340418, 6484.870302593922, 6501.934980650133, 6505.674716264168, 5385.3268341457315, 6403.807885763435, 6410.455111315498, 6413.967930160319, 6417.935820641827, 5085.771140298695, 6302.212223472066, 6307.810765677037, 6309.7160627770945, 6318.557700960889, 5068.746562671851, 5147.897042059138, 5191.662541934762, 5213.296205012351, 5215.113430716788, 4632.953670463319, 4693.272542755878, 4697.6711630185555, 4720.33915251865, 4731.668783185144, 6224.0, 6237.064440333896, 6269.279032911274, 6296.685165741695, 6306.463950564162, 6448.065030570541, 6510.609363438209, 6528.08606795049, 6533.216014078341, 6545.312742162005, 6122.1542093545395, 6167.506599472032, 6182.0, 6262.874742505124, 6275.497960163176, 5774.451427114417, 5812.505936995318, 5814.941850581525, 5823.7379317929945, 5843.035899076604, 6671.966640166768, 6709.228438729511, 6712.966435167793, 6715.966420167868, 6727.966360168168, 6298.968505157445, 6366.363363663597, 6429.132067170872, 6539.346065393423, 6550.934490655032, 6672.432843208382, 6700.731970721116, 6721.227058888095, 6727.293634168537, 6727.461803055841, 6388.616682999035, 6426.807195784134, 6430.099786029866, 6431.517636177212, 6432.2281326241155, 6269.404406581368, 6322.36776322364, 6337.334579869047, 6440.6135631862235, 6529.216494020748, 5711.514521265739, 6314.242290924934, 6318.905216421849, 6323.20959880015, 6330.52521060913, 6143.754249830135, 6300.369963003663, 6304.779332723333, 6311.779087731908, 6312.5581209314905, 6279.215098112736, 6291.811245662638, 6306.9684651576445, 6316.084167795736, 6316.463100636497, 5204.765785539584, 6258.7809426671665, 6282.780102696383, 6318.968405157945, 6324.683765811783, 6267.655278959701, 6268.498520118288, 6295.401936815995, 6298.149749783721, 6306.779262725782], "value": 5974.895762576561, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7348081209951, 812.0945146162029, 1139.1001109123793, 1165.7668466306736, 1166.3410173252107, 37003.25993480129, 37592.812035939816, 37733.81133094331, 37805.43291850617, 37865.62134378655, 41677.37483937744, 42040.369394459034, 42058.0, 42070.0, 42138.0, 6123.540734444912, 8607.569621518931, 8745.693900713477, 8759.78100547485, 8764.123587641217, 6163.537734669895, 8499.065102838682, 8690.695825646104, 8694.347923905701, 8723.25852302555, 8844.5577721114, 8875.822483550324, 8907.975582807963, 8916.777080573005, 8921.286297096216, 6098.2682078150465, 8826.73519794404, 8857.778555536132, 8893.644254229823, 8910.688125915627, 6136.294326152505, 8335.583220838933, 8487.02399224091, 8493.745187644381, 8495.235428811437, 38694.61305386967, 39233.215335693414, 39288.214235715124, 39331.016724582114, 39443.40834887479, 3017.89437369691, 3020.864061117233, 3025.1227144128175, 3052.206426329148, 3078.507438809802, 27346.863265683543, 27583.724162758517, 27624.447511049668, 28035.29911752202, 28626.856865715537, 2818.3517790908, 2837.294405244176, 2848.2879280179955, 2868.3976364963382, 2905.1575043237435, 318673.0, 320991.0, 321571.0, 321583.0, 321676.9999999977, 38631.0, 39251.82244532669, 50541.98916021659, 50793.74603127035, 51044.744776276624, 40796.0, 47890.0, 49066.50933490619, 49149.330813572655, 49182.50817491851, 14010.509632162826, 14126.85873141276, 14152.71694566103, 14154.36305366261, 14154.929225353808, 11545.653630391102, 11547.942260288644, 11561.479733412016, 11577.363245021605, 11593.188476806543, 12128.272303661808, 12164.209326393757, 12176.695582610506, 12269.509219631293, 12404.875951240552, 5263.921041184385, 5305.761240744176, 5306.708131052829, 5306.761195746123, 5321.175217841241, 889.8476472967393, 895.5611750242334, 972.7859870828406, 972.9318947673736, 1003.8293490106553, 22558.887205563868, 23119.88440057789, 24283.757162428148, 24295.878520607283, 24368.563143685846, 1081.1512962324537, 1083.4311986207147, 1108.3903852880883, 1116.1071143085499, 1124.9493772780245, 10189.796204075878, 12115.878841211475, 12235.265884046985, 12304.446299916524, 12323.876761232452, 425448.0, 425875.0, 426185.0, 427832.0, 428144.0, 55440.722796386566, 55700.72149639226, 55711.164332535045, 55737.86883442818, 55800.0, 1458.329168582464, 1474.8156480439945, 1476.7932489451484, 1522.824875139329, 1522.9923850380678, 23562.52874942457, 23661.05355785818, 23707.40731481727, 23780.524389511767, 24133.0, 38177.80911095538, 48695.26957095717, 49580.25629615631, 49611.0, 49662.0, 336685.0, 397910.0, 399015.0, 401416.0, 401451.0, 25402.364940875887, 25791.710414479578, 25941.6108758365, 31513.21216969594, 32209.51685724763, 35137.47293790647, 41634.0, 41704.0, 43064.2774289025, 43128.78435607802, 28067.71932280651, 28232.717672823008, 29248.707512924597, 29659.0, 30001.54997674993, 29132.27169320784, 29393.19954743085, 29902.25244368908, 30014.84992575023, 30248.108744685207, 34985.82507087448, 35895.64104358923, 35898.10254743652, 35945.64054359423, 36109.63890361168, 29532.409351813272, 29799.55300670535, 30111.0, 30476.238094046937, 30483.237919051313, 22600.208992685177, 23299.88350058239, 23409.88295058582, 23770.762292376854, 23994.76005239925], "value": 17439.453832115694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.12226374799775, 429.167494536062, 437.590852552863, 440.2581649919885, 446.43080072907037, 20355.982200889972, 20482.18071277149, 21183.04676289567, 21208.36374908751, 21418.89290553549, 21156.57686846262, 21883.67174492384, 22612.8869355653, 22657.0, 22965.77034229657, 5167.844964651066, 6069.0, 6323.810285691414, 6333.683315834213, 6342.936570634304, 6158.983767678328, 6252.3435039320675, 6314.400131987477, 6314.526410519206, 6322.652254126021, 5326.786928522854, 6113.358097399776, 6286.685665716719, 6288.182536270278, 6296.055591661242, 6048.969755151218, 6201.16284301618, 6202.317745048041, 6202.9689851550675, 6224.128621992924, 5416.620836541444, 5434.75543600535, 5462.781488740446, 5488.0, 5497.587680923947, 26933.17201693833, 26935.461290774074, 27060.1881943542, 27224.0, 27273.0, 2006.7190593316948, 2020.7676117246558, 2026.3313106674761, 2029.076770069615, 2051.312810208582, 15060.096394216382, 15749.212539372986, 16004.279807408695, 16035.759463608056, 16109.919450402791, 1545.1887758926541, 1621.2137113499944, 1633.6732653469235, 1641.9014859108493, 1656.9171541422882, 147696.2615186928, 163554.0, 164824.0, 165686.17156914138, 166860.16569917073, 12056.63830085099, 12371.381430928417, 12406.441710123067, 12414.131010829155, 12608.74782504363, 16695.83304166967, 16707.916460417862, 16724.331026759035, 16735.6652866942, 16800.579985500215, 8414.158584141536, 8509.531975741394, 8686.261667758312, 8757.255633271243, 9032.774180645536, 6634.900476492857, 8128.431009829374, 8264.876026859602, 8282.461639993382, 8386.706465273808, 7441.739539116105, 7499.638337249359, 7590.7722768317035, 7616.543007419462, 7629.046369203849, 1834.3763120538813, 2090.571432856261, 2122.630903067513, 2123.309924274617, 2129.98935005324, 910.7540963939699, 924.6717415317465, 925.9027802080684, 965.4496936746128, 966.6809952715587, 19418.902905485666, 20617.79382206189, 20654.178976889325, 20675.483112921997, 21041.368758937257, 860.7159637319795, 896.462122726359, 958.3818437108026, 989.4113002763344, 999.0, 9869.950650246703, 10579.471026448648, 10653.78692426147, 10655.147588192925, 10708.678739637824, 670041.0, 673316.0, 689129.0, 692801.0, 699219.0, 158410.0, 160180.98190180887, 161596.0, 163203.80729565068, 167177.0, 1117.6088369070924, 1148.735790768128, 1169.8830116988404, 1170.6136974798296, 1174.2015429508017, 14535.709285814013, 14841.480548180762, 15561.533154004945, 17503.212355443782, 17801.308875656792, 60313.0, 60479.69760151347, 61087.69456152691, 62272.75454490794, 62629.060564090665, 55398.0, 70886.16455341729, 84303.0, 85008.57495712482, 86522.56738716266, 8018.4787988780545, 8114.715984940499, 8242.505449673039, 8419.915800841913, 8575.914240857512, 12721.236725796482, 12842.67893302675, 12931.870681293443, 13199.802002969771, 13287.80068298957, 9468.715938521855, 10968.396738179157, 11121.0, 11226.719332016764, 11258.887411125785, 10113.64602238918, 10159.288849780445, 10209.38743675352, 10369.948150259503, 10385.896141038493, 11193.66419007431, 11236.494357753758, 11439.771204576029, 11442.885571144181, 11563.95924366811, 8093.35253179756, 8209.507429554245, 8396.706115285935, 8408.873866892123, 8417.915820841714, 10962.068224201032, 11269.267497612629, 11440.542378304775, 11449.026832719312, 11460.312381257152], "value": 10174.739007590704, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1169.8303745956832, 1360.2314692198906, 1432.3339647064113, 1452.2012892908904, 1462.7074585082983, 9049.728508144757, 9449.007854175316, 10235.437050962195, 10605.363678179314, 10660.573577056928, 10380.11768999636, 10540.209484288689, 10555.208359373059, 10571.207159463032, 10575.101116405114, 2396.7363590005084, 2450.338408629678, 2458.6926634170727, 2460.987695061522, 2472.7279999200073, 2067.1214733738175, 2140.368591265573, 2374.5725769361507, 2462.802975761944, 2465.285067330481, 2425.0, 2427.8421902576274, 2430.16159424999, 2437.5856104462196, 2439.0609615298063, 2401.423658321999, 2429.477662302596, 2432.2095319021214, 2433.2700189943125, 2437.6465412515263, 2330.3940975346363, 2393.401649587603, 2438.2807071913826, 2444.046821739523, 2454.9263522094366, 10703.1437485001, 10821.621243256526, 10823.404712740796, 10825.971532704381, 10833.67498975032, 6141.078838174265, 6376.48988080957, 6376.521760867953, 6377.23473183221, 6380.266269379034, 3775.2260786538695, 3826.1773718650625, 4008.2584721826556, 4078.4086307485545, 4082.632563069308, 1198.4726720243066, 1221.822835688829, 1488.1220080152655, 1549.4886687393134, 1575.4092215419219, 14468.49360272396, 14624.853751462562, 14706.4852730155, 14734.557963261119, 14760.483383081648, 5352.759125839347, 5666.688332141689, 5757.337906140848, 5762.761006383647, 5782.074868021181, 12706.809397859039, 12718.809217861739, 12724.300163490912, 12733.426995785212, 12753.68115797094, 6440.677966101676, 6449.935500644933, 6453.677316134174, 6454.32229615893, 6477.838054048687, 4884.853454396374, 5512.228288039678, 5838.649681019152, 5854.560907931922, 5870.295564532198, 3975.522937247491, 4066.1664358806374, 4076.6331030207425, 4087.652549533323, 4119.361498967664, 1275.4196840437578, 1293.9223646581236, 1307.5946456598485, 1342.3489607540334, 1378.7656098463285, 760.6044856674608, 764.2395816162842, 765.0398749569366, 775.3293401208027, 814.771863878115, 6304.810855674337, 6544.70548825304, 6594.9670251649395, 6674.933250667528, 6705.966470167618, 859.6991053131354, 894.5884892949316, 918.93108016899, 928.6888892221182, 936.4989730494153, 3989.0625702959783, 4126.236646220459, 4148.751074935513, 4225.535191128974, 4263.59495847894, 13067.673308167372, 13232.933835330954, 13575.864241357658, 13597.592072237849, 13780.10429322111, 13046.804297935538, 13442.865571344162, 13508.932455337661, 13509.59471215865, 13515.0, 8795.164459376349, 9831.508424578742, 9993.350432221881, 10096.69709908704, 10127.24045696561, 5868.589198756217, 5920.437558431942, 6543.607383557001, 6800.6599670017295, 6823.93176068233, 10106.444145572064, 11824.290542567473, 12172.14794964344, 12182.634520964386, 12260.877391225973, 10002.799944001225, 12293.692657683272, 12306.81539776922, 12499.375031248583, 12697.238165710087, 8620.52587107715, 9004.59479323419, 9090.863637045582, 9121.270298376247, 9127.817443651222, 8570.0, 9834.360766550151, 9934.652287169914, 9976.50117494137, 9989.950050249703, 8434.957825210835, 8435.915640843514, 8550.1449855014, 8552.786180345542, 8659.740207793777, 8198.139195384638, 8326.750197494084, 8397.0, 8397.118302578385, 8557.828843423222, 7657.808554785952, 7670.539767613961, 7817.687292508236, 7828.099768526692, 7870.645820937957, 4703.929441058319, 5888.764449422147, 5940.198073260054, 6020.819375418744, 6081.939180608314, 5970.223870896929, 6004.699765011819, 6028.939710602838, 6057.18228039209, 6073.817785466443], "value": 5161.341199474714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.755084296893, 398.2705373687462, 398.9381645844893, 403.8768175706408, 407.3157096078589, 5153.4846515348445, 5571.13647384655, 5955.88088238235, 6044.395560443953, 6114.5108391328695, 4842.927356089653, 5121.385433747946, 5779.508741756945, 5780.739866705998, 5939.910901336483, 4505.8422955196575, 4645.883852903679, 4649.907001859978, 4667.413079552951, 4672.369230153937, 3869.8452061917487, 4683.672142949995, 4687.507811679776, 4706.176419126639, 4717.433907931053, 4038.1721747041934, 4370.475542934836, 4612.907741845161, 4645.628349732014, 4671.672982891199, 4227.795078402641, 4597.7241365518175, 4597.804570811596, 4625.283081122415, 4629.490756016836, 3545.85816567337, 3962.2669806085964, 4094.2016306820183, 4117.155983023473, 4129.669626429878, 5533.6403133796575, 5782.9421705782825, 5861.036552754832, 5895.204147440127, 5937.67342796146, 5384.892302153974, 5388.299521062276, 5405.783768649249, 5409.864753381157, 5415.756290966916, 5002.799888004475, 5249.947500525022, 5546.667199968015, 6358.268799088118, 6363.713632886531, 4017.7388469749667, 4439.889002774924, 4504.684672072956, 4534.070515544306, 4548.7725613719185, 5555.722213889329, 5857.970710146422, 6224.470919971763, 6347.0, 6544.312847151028, 3806.5051543299196, 4039.939400908989, 4648.349231107648, 4704.1767690654, 4710.599599034052, 4553.269757492198, 4807.423109226916, 4813.855584332476, 4824.734639594786, 4824.831130910471, 5034.496550344937, 5188.896222075613, 5325.786968521294, 5342.91985620216, 5355.30381050461, 5550.639208451437, 6352.428281454599, 6359.887019771614, 6392.808215753535, 6395.20059992501, 1291.560869304441, 1386.9930650346685, 1528.678977414733, 1617.9595510112106, 1642.5647203491085, 1099.571167244775, 1122.2424863217295, 1125.9549618015187, 1134.7390100276818, 1140.492480846032, 5923.526117910556, 5934.703264836828, 5939.22790037301, 5944.316403613553, 5961.731722072517, 6467.547271691031, 6469.256035555877, 6503.536704241508, 6515.7719479818925, 6521.380468855546, 5357.276767636397, 5430.348358197041, 6005.369436209223, 6041.0, 6069.211002569726, 3018.9396212075635, 3385.25524384635, 3435.003848883796, 3449.3618680543677, 3451.240727040047, 5864.501517370986, 6349.428551430301, 6575.671216439255, 6620.503462240351, 6633.668316584151, 6401.487880969511, 6585.934140658532, 6655.401013908771, 6712.42944349726, 6931.202911665223, 6430.453411459985, 6636.203655561363, 6655.733770649314, 6661.634364955173, 6722.428593569503, 6422.3577642235405, 6486.318936511599, 6487.902681459687, 6490.3185165558825, 6496.512761542808, 5126.769295381791, 6084.574079814371, 6406.679666016774, 6419.903701444388, 6500.804975850732, 5958.642481450954, 6579.2104947406615, 6663.0, 6697.531172817856, 6728.226253980659, 3413.2490852012515, 3752.9624703753707, 4266.360045993126, 4306.332518459643, 4309.784510774512, 6245.437910588069, 6524.608523488606, 6525.314841941527, 6561.770338038145, 6574.901376479261, 6310.7791227306825, 6365.936340636535, 6370.90443643355, 6382.5532212744665, 6405.790002449147, 6054.636721796706, 6337.904931426125, 6342.746290148342, 6369.8849104859855, 6382.840428989312, 5178.61160412963, 5433.429489903503, 6173.259208894961, 6191.133241346305, 6192.752289908353, 6328.683565821782, 6349.777757778455, 6361.968190159205, 6364.968175159094, 6374.3306952771145, 5596.90860282241, 5936.5844390892225, 6146.262448506029, 6226.346233645402, 6256.624602523863], "value": 4693.860392407343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.6022857314189, 718.5257729898268, 736.6611358774963, 738.4941315199087, 767.3439209475898, 14934.77597836032, 15662.21688915554, 15803.130827804465, 16790.412335568257, 17651.76437649365, 16252.43116490923, 16300.510984670449, 16643.25105370258, 16646.417375391833, 16743.497695069138, 939.2016785732108, 971.946542940138, 972.2416515118219, 975.1516180922572, 975.5707488704948, 942.1379437814426, 975.3367709957226, 979.4368238262991, 983.2969426859794, 986.6990567876795, 1034.2139973620065, 1035.1977217656301, 1035.3011717090933, 1035.4719093262452, 1038.7247379444452, 1027.434910799065, 1027.696829435311, 1031.4791030529573, 1033.8139134955704, 1033.819081660714, 761.7219714804056, 762.7826069570201, 766.5898744171897, 767.7658314214162, 773.9574323412266, 15943.760843587355, 16125.516234512983, 16290.755638665429, 16419.917900410543, 16693.0, 13862.861371386358, 14392.784108238386, 14672.810322941788, 14693.853061469463, 14828.925855370762, 11723.062155027577, 11732.53069877204, 11885.881141188564, 11927.88072119285, 12255.69360765979, 3000.819950802959, 3121.3601211751766, 3153.4323821712082, 3153.7003984621424, 3155.0, 98650.0, 102323.99999999926, 103204.48397758038, 104106.0, 106443.46778266136, 10903.727406814734, 11284.830727539094, 11333.206675532798, 11442.37066961325, 11603.76792464146, 20672.069756860976, 24199.39501512441, 24691.753082469306, 25007.749922500905, 25039.12363067284, 7746.264104910025, 7780.533168009937, 7812.765617031499, 7893.447458677952, 8022.879656805153, 4129.855455059059, 4183.832646694098, 4213.768242746617, 4217.283061879488, 4232.470941132358, 4064.532578753422, 4158.9376159357635, 4166.0, 4170.249355116048, 4174.019105510202, 771.733751855609, 779.174075479993, 786.2137862137862, 789.960501974899, 808.6967387229789, 536.7262696025056, 553.5875772549476, 576.9019266724667, 583.4049269744921, 589.7139887154726, 9281.071892810665, 9683.080107389927, 9708.437806878073, 9710.465924374228, 9848.35985660944, 531.8803269264384, 537.5941164420838, 562.4038519169693, 573.8020382967869, 579.3829571506333, 4422.911541769146, 4521.84173553924, 4550.317452382103, 4612.43810223183, 4645.958550761933, 94296.52851735697, 95478.0, 96361.0, 96685.51657241669, 99820.50089749505, 83698.16301837025, 84269.15730842736, 85051.0, 86170.07577633574, 86575.56712216524, 73318.63340683369, 74588.62705686546, 74681.0, 75526.0, 76148.61925690447, 9195.954020229856, 9197.678081267124, 9202.907970920205, 9209.355345125778, 9316.673916412892, 35597.82201088978, 36124.638753612126, 36158.457623135146, 36428.0, 36707.0, 43001.78499107484, 57179.42820571741, 57606.0, 59421.405785941584, 60256.39743602508, 10890.727731806768, 13697.246651434267, 13715.1085179463, 13793.517226897011, 14131.0, 11706.414679266172, 14281.285935702965, 14376.928115359775, 14483.710325793214, 14629.981024668103, 13309.66725831862, 13352.666183345105, 13393.129446585941, 13670.52153174634, 13818.792718109034, 10802.243842930919, 12584.307863067253, 12963.740725185633, 12965.611031669065, 13378.264195469343, 13019.739605208033, 13092.869071309166, 13219.801702974655, 13539.0, 13863.029587928748, 9345.766355841159, 9447.811043779224, 9615.2307815376, 9754.658586949423, 9964.800703986024, 8978.281737461119, 10787.730306742395, 11049.723756906142, 11143.665690029313, 11199.88800112021], "value": 7466.306320229019, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 125.0, 121.0, 113.0, 113.0, 111.0, 112.0, 112.0, 112.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 147.0, 108.0, 147.0, 112.0, 111.0, 110.0, 117.0, 173.0, 145.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 183.0, 186.0, 186.0, 185.0, 182.0, 185.0, 183.0, 185.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 91.0, 61.0, 58.0, 60.0, 56.0, 79.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 88.0, 68.0, 69.0, 69.0, 84.0, 69.0, 69.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 74.0, 133.0, 127.0, 87.0, 87.0, 87.0, 87.0, 97.0], "value": 95.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 84.0, 91.0, 84.0, 85.0, 85.0, 83.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 61.0, 60.0, 60.0, 61.0, 62.0, 61.0, 60.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 65.0, 68.0, 61.0, 58.0, 58.0, 58.0, 57.0, 57.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 75.0, 82.0, 82.0, 81.0, 82.0, 81.0, 81.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 140.0, 148.0, 154.0, 146.0, 137.0, 138.0, 136.0, 182.0, 144.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 183.0, 184.0, 186.0, 181.0, 189.0, 182.0, 182.0, 179.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 65.0, 85.0, 99.0, 77.0, 69.0, 68.0, 70.0, 67.0], "value": 73.5, "unit": "score"}]}]} 18:51:46 INFO - Return code: 0 18:51:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:46 ERROR - # TBPL SUCCESS # 18:51:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:46 INFO - 2017-03-24 18:51:46.843 screenresolution[1646:9814] starting screenresolution argv=screenresolution get 18:51:46 INFO - 2017-03-24 18:51:46.846 screenresolution[1646:9814] Display 0: 1600x1200x32@60 18:51:46 INFO - 2017-03-24 18:51:46.852 screenresolution[1647:9817] starting screenresolution argv=screenresolution list 18:51:46 INFO - Available Modes on Display 0 18:51:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:47 INFO - Intel Iris: 18:51:47 INFO - Chipset Model: Intel Iris 18:51:47 INFO - Type: GPU 18:51:47 INFO - Bus: Built-In 18:51:47 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:47 INFO - Vendor: Intel (0x8086) 18:51:47 INFO - Device ID: 0x0a2e 18:51:47 INFO - Revision ID: 0x0009 18:51:47 INFO - Displays: 18:51:47 INFO - Display: 18:51:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:47 INFO - Display Serial Number: 1600x1200 60 18:51:47 INFO - Main Display: Yes 18:51:47 INFO - Mirror: Off 18:51:47 INFO - Online: Yes 18:51:47 INFO - Rotation: Supported 18:51:47 INFO - Return code: 0 18:51:47 INFO - Running post-action listener: _resource_record_post_action 18:51:47 INFO - [mozharness: 2017-03-25 01:51:47.091070Z] Finished run-tests step (success) 18:51:47 INFO - Running post-run listener: _resource_record_post_run 18:51:47 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 39408640; Write bytes: 515372032; Read time: 393; Write time: 1879 18:51:47 INFO - TinderboxPrint: CPU usage
53.6% 18:51:47 INFO - TinderboxPrint: I/O read bytes / time
39,408,640 / 393 18:51:47 INFO - TinderboxPrint: I/O write bytes / time
515,372,032 / 1,879 18:51:47 INFO - TinderboxPrint: CPU idle
2,234.0 (46.4%) 18:51:47 INFO - TinderboxPrint: CPU system
962.7 (20.0%) 18:51:47 INFO - TinderboxPrint: CPU user
1,613.0 (33.5%) 18:51:47 INFO - TinderboxPrint: Swap in / out
250,531,840 / 0 18:51:47 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204982784; Write bytes: 205735936; Read time: 15640; Write time: 462 18:51:47 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 37577728; Write bytes: 298818560; Read time: 367; Write time: 1378 18:51:47 INFO - Running post-run listener: _upload_blobber_files 18:51:47 INFO - Blob upload gear active. 18:51:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:47 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 18:51:47 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'] 18:51:47 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 18:51:47 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:49 INFO - (blobuploader) - INFO - Done attempting. 18:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:50 INFO - (blobuploader) - INFO - Done attempting. 18:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:51 INFO - (blobuploader) - INFO - Done attempting. 18:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:54 INFO - (blobuploader) - INFO - Done attempting. 18:51:54 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:54 INFO - Return code: 0 18:51:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:51:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8be08b49a4919487ab8fdd258b8f4c02f26fc06c052458cb47470ed704073dc2529237e50e2c286b83f085c7e951c515bc2fccfd5887e247d3b1cb2adddb86db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ab0b87a4a8e34e1c8a6ae7eb689205465adfd610454f46baf87cdc63f880f9f290e6c68dc02a1a6ac0211cf267098250a29526bd0d661456cfdc7a1c0747612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83cc04330ee12a87f2632fcbc2e0a6ef62e743535116e72b0d9515d2a19485a6182ff9d8d496ad7a85a4d6faa2d6669963b64a0032ba6fa766bb0ed9da99f1a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb8ade4b449b77fbc4b9858fd11e78e9495b96d37b4eca29e0502d29f6132969ca4247b2405fb3d60764c94ea22ab9f77fa1dbdbaba951350183953331e9e64"} 18:51:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:51:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:51:54 INFO - Contents: 18:51:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8be08b49a4919487ab8fdd258b8f4c02f26fc06c052458cb47470ed704073dc2529237e50e2c286b83f085c7e951c515bc2fccfd5887e247d3b1cb2adddb86db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ab0b87a4a8e34e1c8a6ae7eb689205465adfd610454f46baf87cdc63f880f9f290e6c68dc02a1a6ac0211cf267098250a29526bd0d661456cfdc7a1c0747612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83cc04330ee12a87f2632fcbc2e0a6ef62e743535116e72b0d9515d2a19485a6182ff9d8d496ad7a85a4d6faa2d6669963b64a0032ba6fa766bb0ed9da99f1a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb8ade4b449b77fbc4b9858fd11e78e9495b96d37b4eca29e0502d29f6132969ca4247b2405fb3d60764c94ea22ab9f77fa1dbdbaba951350183953331e9e64"} 18:51:54 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:54 INFO - Copying logs to upload dir... 18:51:54 INFO - mkdir: /builds/slave/test/build/upload/logs 18:51:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.532279 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-24 18:51:54.270013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:54.273519) ========= 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.1fwIg7jkox/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.pGUPcZdaNL/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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/8be08b49a4919487ab8fdd258b8f4c02f26fc06c052458cb47470ed704073dc2529237e50e2c286b83f085c7e951c515bc2fccfd5887e247d3b1cb2adddb86db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ab0b87a4a8e34e1c8a6ae7eb689205465adfd610454f46baf87cdc63f880f9f290e6c68dc02a1a6ac0211cf267098250a29526bd0d661456cfdc7a1c0747612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83cc04330ee12a87f2632fcbc2e0a6ef62e743535116e72b0d9515d2a19485a6182ff9d8d496ad7a85a4d6faa2d6669963b64a0032ba6fa766bb0ed9da99f1a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb8ade4b449b77fbc4b9858fd11e78e9495b96d37b4eca29e0502d29f6132969ca4247b2405fb3d60764c94ea22ab9f77fa1dbdbaba951350183953331e9e64"} build_url:https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010606 build_url: 'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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/8be08b49a4919487ab8fdd258b8f4c02f26fc06c052458cb47470ed704073dc2529237e50e2c286b83f085c7e951c515bc2fccfd5887e247d3b1cb2adddb86db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ab0b87a4a8e34e1c8a6ae7eb689205465adfd610454f46baf87cdc63f880f9f290e6c68dc02a1a6ac0211cf267098250a29526bd0d661456cfdc7a1c0747612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83cc04330ee12a87f2632fcbc2e0a6ef62e743535116e72b0d9515d2a19485a6182ff9d8d496ad7a85a4d6faa2d6669963b64a0032ba6fa766bb0ed9da99f1a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb8ade4b449b77fbc4b9858fd11e78e9495b96d37b4eca29e0502d29f6132969ca4247b2405fb3d60764c94ea22ab9f77fa1dbdbaba951350183953331e9e64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:54.306868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:54.307196) ========= 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.1fwIg7jkox/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.pGUPcZdaNL/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005054 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:54.355676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 18:51:54.355973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 18:51:54.356297) ========= ========= Total master_lag: 0.18 =========