builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0140 starttime: 1484754252.48 results: success (0) buildid: 20170118062528 builduid: 4720d3a9f4424c668939d3f6ed1873da revision: 5b544b8ab06b0d75bb3abb4095cceefeeebec525 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.483925) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.484434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.484726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.511867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.512236) ========= 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.nKLiA4NObO/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.Olhe9TONSv/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-18 07:44:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-01-18 07:44:12 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.684949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.685264) ========= 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.nKLiA4NObO/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.Olhe9TONSv/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.027504 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:12.735168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 07:44:12.735570) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b544b8ab06b0d75bb3abb4095cceefeeebec525 --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 5b544b8ab06b0d75bb3abb4095cceefeeebec525 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nKLiA4NObO/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.Olhe9TONSv/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-18 07:44:12,834 truncating revision to first 12 chars 2017-01-18 07:44:12,835 Setting DEBUG logging. 2017-01-18 07:44:12,835 attempt 1/10 2017-01-18 07:44:12,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b544b8ab06b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 07:44:14,007 unpacking tar archive at: mozilla-central-5b544b8ab06b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.441958 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 07:44:14.351560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:14.351927) ========= script_repo_revision: 5b544b8ab06b0d75bb3abb4095cceefeeebec525 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:14.352417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:14.352711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 07:44:14.373722) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-18 07:44:14.374178) ========= /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.nKLiA4NObO/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.Olhe9TONSv/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:44:14 INFO - MultiFileLogger online at 20170118 07:44:14 in /builds/slave/test 07:44:14 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 07:44:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:14 INFO - {'append_to_log': False, 07:44:14 INFO - 'base_work_dir': '/builds/slave/test', 07:44:14 INFO - 'blob_upload_branch': 'Firefox', 07:44:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:14 INFO - 'branch': 'Firefox', 07:44:14 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:14 INFO - 'config_files': ('talos/mac_config.py',), 07:44:14 INFO - 'default_actions': ('clobber', 07:44:14 INFO - 'read-buildbot-config', 07:44:14 INFO - 'download-and-extract', 07:44:14 INFO - 'populate-webroot', 07:44:14 INFO - 'create-virtualenv', 07:44:14 INFO - 'install', 07:44:14 INFO - 'run-tests'), 07:44:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:14 INFO - 'download_minidump_stackwalk': True, 07:44:14 INFO - 'download_symbols': 'ondemand', 07:44:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:14 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:14 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:14 INFO - 'installer_path': 'installer.exe', 07:44:14 INFO - 'log_level': 'info', 07:44:14 INFO - 'log_name': 'talos', 07:44:14 INFO - 'log_to_console': True, 07:44:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:44:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:44:14 INFO - 'opt_config_files': (), 07:44:14 INFO - 'pip_index': False, 07:44:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:44:14 INFO - 'cmd': ('bash', 07:44:14 INFO - '-c', 07:44:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:44:14 INFO - 'enabled': True, 07:44:14 INFO - 'halt_on_failure': False, 07:44:14 INFO - 'name': 'check_screen_resolution'},), 07:44:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:44:14 INFO - 'cmd': ('bash', 07:44:14 INFO - '-c', 07:44:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:44:14 INFO - 'enabled': True, 07:44:14 INFO - 'halt_on_failure': False, 07:44:14 INFO - 'name': 'check_screen_resolution'},), 07:44:14 INFO - 'run_cmd_checks_enabled': True, 07:44:14 INFO - 'sps_profile': False, 07:44:14 INFO - 'sps_profile_interval': 0, 07:44:14 INFO - 'suite': 'dromaeojs', 07:44:14 INFO - 'system_bits': '32', 07:44:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:14 INFO - 'title': 't-yosemite-r7-0140', 07:44:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:14 INFO - 'use_talos_json': True, 07:44:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:14 INFO - 'work_dir': 'build'} 07:44:14 INFO - [mozharness: 2017-01-18 15:44:14.589293Z] Running clobber step. 07:44:14 INFO - Running pre-action listener: _resource_record_pre_action 07:44:14 INFO - Running main action method: clobber 07:44:14 INFO - rmtree: /builds/slave/test/build 07:44:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:17 INFO - Running post-action listener: _resource_record_post_action 07:44:17 INFO - [mozharness: 2017-01-18 15:44:17.074860Z] Finished clobber step (success) 07:44:17 INFO - [mozharness: 2017-01-18 15:44:17.075147Z] Running read-buildbot-config step. 07:44:17 INFO - Running pre-action listener: _resource_record_pre_action 07:44:17 INFO - Running main action method: read_buildbot_config 07:44:17 INFO - Using buildbot properties: 07:44:17 INFO - { 07:44:17 INFO - "project": "", 07:44:17 INFO - "product": "firefox", 07:44:17 INFO - "script_repo_revision": "production", 07:44:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:44:17 INFO - "repository": "", 07:44:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:44:17 INFO - "buildid": "20170118062528", 07:44:17 INFO - "pgo_build": "False", 07:44:17 INFO - "basedir": "/builds/slave/test", 07:44:17 INFO - "buildnumber": 19, 07:44:17 INFO - "slavename": "t-yosemite-r7-0140", 07:44:17 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:44:17 INFO - "platform": "yosemite_r7", 07:44:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:44:17 INFO - "branch": "mozilla-central", 07:44:17 INFO - "repo_path": "mozilla-central", 07:44:17 INFO - "revision": "5b544b8ab06b0d75bb3abb4095cceefeeebec525", 07:44:17 INFO - "stage_platform": "macosx64", 07:44:17 INFO - "builduid": "4720d3a9f4424c668939d3f6ed1873da", 07:44:17 INFO - "slavebuilddir": "test" 07:44:17 INFO - } 07:44:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:44:17 INFO - Running post-action listener: _resource_record_post_action 07:44:17 INFO - [mozharness: 2017-01-18 15:44:17.080784Z] Finished read-buildbot-config step (success) 07:44:17 INFO - [mozharness: 2017-01-18 15:44:17.081030Z] Running download-and-extract step. 07:44:17 INFO - Running pre-action listener: _resource_record_pre_action 07:44:17 INFO - Running main action method: download_and_extract 07:44:17 INFO - mkdir: /builds/slave/test/build/tests 07:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:17 INFO - trying https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:44:17 INFO - Downloading https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:44:17 INFO - Downloaded 1199 bytes. 07:44:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:44:17 INFO - Using the following test package requirements: 07:44:17 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:44:17 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:44:17 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:44:17 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'jsshell-mac.zip'], 07:44:17 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:44:17 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:44:17 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:44:17 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:44:17 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:44:17 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:44:17 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:44:17 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:44:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:44:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:44:17 INFO - Fetch https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:44:18 INFO - Expected file size: 16328484 07:44:18 INFO - Obtained file size: 16328484 07:44:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:44:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:44:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:44:25 INFO - Fetch https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:44:26 INFO - Expected file size: 16328484 07:44:26 INFO - Obtained file size: 16328484 07:44:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:44:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:44:32 INFO - Fetch https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:44:37 INFO - Expected file size: 14403463 07:44:37 INFO - Obtained file size: 14403463 07:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:37 INFO - trying https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:44:37 INFO - Downloading https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:44:39 INFO - Downloaded 69927871 bytes. 07:44:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:44:39 INFO - mkdir: /builds/slave/test/properties 07:44:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:39 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:39 INFO - Contents: 07:44:39 INFO - build_url:https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:44:40 INFO - Running post-action listener: _resource_record_post_action 07:44:40 INFO - Running post-action listener: set_extra_try_arguments 07:44:40 INFO - [mozharness: 2017-01-18 15:44:40.613687Z] Finished download-and-extract step (success) 07:44:40 INFO - [mozharness: 2017-01-18 15:44:40.613818Z] Running populate-webroot step. 07:44:40 INFO - Running pre-action listener: _resource_record_pre_action 07:44:40 INFO - Running main action method: populate_webroot 07:44:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:40 INFO - '--tppagecycles', 07:44:40 INFO - '7'], 07:44:40 INFO - 'tests': ['tsvgm']}}, 07:44:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:44:40 INFO - 'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:44:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:44:40 INFO - 'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['damp', 'tps']}, 07:44:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:44:40 INFO - 'tests': ['damp', 'tps']}, 07:44:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['dromaeo_dom']}, 07:44:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['basic_compositor_video']}, 07:44:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:44:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['a11yr', 07:44:40 INFO - 'ts_paint', 07:44:40 INFO - 'tpaint', 07:44:40 INFO - 'sessionrestore', 07:44:40 INFO - 'sessionrestore_no_auto_restore', 07:44:40 INFO - 'tabpaint']}, 07:44:40 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:40 INFO - 'ts_paint', 07:44:40 INFO - 'tpaint', 07:44:40 INFO - 'sessionrestore', 07:44:40 INFO - 'sessionrestore_no_auto_restore', 07:44:40 INFO - 'tabpaint']}, 07:44:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:40 INFO - 'ts_paint', 07:44:40 INFO - 'tpaint', 07:44:40 INFO - 'sessionrestore', 07:44:40 INFO - 'sessionrestore_no_auto_restore', 07:44:40 INFO - 'tabpaint']}, 07:44:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:40 INFO - 'ts_paint', 07:44:40 INFO - 'tpaint', 07:44:40 INFO - 'sessionrestore', 07:44:40 INFO - 'sessionrestore_no_auto_restore', 07:44:40 INFO - 'tabpaint']}, 07:44:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['a11yr', 07:44:40 INFO - 'ts_paint', 07:44:40 INFO - 'tpaint', 07:44:40 INFO - 'sessionrestore', 07:44:40 INFO - 'sessionrestore_no_auto_restore', 07:44:40 INFO - 'tabpaint']}, 07:44:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['a11yr', 07:44:40 INFO - 'ts_paint', 07:44:40 INFO - 'tpaint', 07:44:40 INFO - 'sessionrestore', 07:44:40 INFO - 'sessionrestore_no_auto_restore', 07:44:40 INFO - 'tabpaint']}, 07:44:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['tsvgx', 07:44:40 INFO - 'tsvgr_opacity', 07:44:40 INFO - 'tart', 07:44:40 INFO - 'tscrollx', 07:44:40 INFO - 'cart', 07:44:40 INFO - 'tsvg_static']}, 07:44:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:40 INFO - 'tsvgr_opacity', 07:44:40 INFO - 'tart', 07:44:40 INFO - 'tscrollx', 07:44:40 INFO - 'cart', 07:44:40 INFO - 'tsvg_static']}, 07:44:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:44:40 INFO - 'talos_options': ['--disable-e10s'], 07:44:40 INFO - 'tests': ['tp5o']}, 07:44:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:44:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:44:40 INFO - 'talos_options': ['--disable-e10s', 07:44:40 INFO - '--xperf_path', 07:44:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:40 INFO - 'tests': ['tp5n']}, 07:44:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:44:40 INFO - 'talos_options': ['--xperf_path', 07:44:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:40 INFO - 'tests': ['tp5n']}}, 07:44:40 INFO - 'talos.zip': {'path': '', 07:44:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:40 INFO - Running post-action listener: _resource_record_post_action 07:44:40 INFO - [mozharness: 2017-01-18 15:44:40.630890Z] Finished populate-webroot step (success) 07:44:40 INFO - [mozharness: 2017-01-18 15:44:40.630984Z] Running create-virtualenv step. 07:44:40 INFO - Running pre-action listener: _resource_record_pre_action 07:44:40 INFO - Running main action method: create_virtualenv 07:44:40 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:40 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 07:44:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:40 INFO - Using real prefix '/tools/python27' 07:44:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:44 INFO - Installing pip.................done. 07:44:44 INFO - Return code: 0 07:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:44:44 INFO - Reading from file tmpfile_stdout 07:44:44 INFO - Output received: 07:44:44 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) 07:44:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:44 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')]} 07:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:44 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')]} 07:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:44 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:44:44 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 07:44:44 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 07:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:44 INFO - 'HOME': '/Users/cltbld', 07:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:44 INFO - 'LOGNAME': 'cltbld', 07:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:44 INFO - 'MOZ_NO_REMOTE': '1', 07:44:44 INFO - 'NO_EM_RESTART': '1', 07:44:44 INFO - 'PAGER': '/bin/cat', 07:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:44 INFO - 'PWD': '/builds/slave/test', 07:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:44 INFO - 'SHELL': '/bin/bash', 07:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:44:44 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:44 INFO - 'USER': 'cltbld', 07:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:44 INFO - 'XPC_FLAGS': '0x0', 07:44:44 INFO - 'XPC_SERVICE_NAME': '0', 07:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:44 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 07:44:44 INFO - Cleaning up... 07:44:44 INFO - Return code: 0 07:44:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44:44 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')]} 07:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:44 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')]} 07:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:44 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:44:44 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 07:44:44 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 07:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:44 INFO - 'HOME': '/Users/cltbld', 07:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:44 INFO - 'LOGNAME': 'cltbld', 07:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:44 INFO - 'MOZ_NO_REMOTE': '1', 07:44:44 INFO - 'NO_EM_RESTART': '1', 07:44:44 INFO - 'PAGER': '/bin/cat', 07:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:44 INFO - 'PWD': '/builds/slave/test', 07:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:44 INFO - 'SHELL': '/bin/bash', 07:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:44:44 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:44 INFO - 'USER': 'cltbld', 07:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:44 INFO - 'XPC_FLAGS': '0x0', 07:44:44 INFO - 'XPC_SERVICE_NAME': '0', 07:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:45 INFO - Downloading/unpacking psutil>=3.1.1 07:44:45 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 07:44:45 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 07:44:45 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 07:44:45 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 07:44:45 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 07:44:45 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 07:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:48 INFO - Installing collected packages: psutil 07:44:48 INFO - Running setup.py install for psutil 07:44:48 INFO - building 'psutil._psutil_osx' extension 07:44:48 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 07:44:49 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 07:44:49 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 07:44:49 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 07:44:49 INFO - building 'psutil._psutil_posix' extension 07:44:49 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 07:44:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:44:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:44:49 INFO - ^ 07:44:49 INFO - 1 warning generated. 07:44:49 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 07:44:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:49 INFO - Successfully installed psutil 07:44:49 INFO - Cleaning up... 07:44:49 INFO - Return code: 0 07:44:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:49 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:44:49 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 07:44:49 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 07:44:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:44:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:49 INFO - 'HOME': '/Users/cltbld', 07:44:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:49 INFO - 'LOGNAME': 'cltbld', 07:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:49 INFO - 'MOZ_NO_REMOTE': '1', 07:44:49 INFO - 'NO_EM_RESTART': '1', 07:44:49 INFO - 'PAGER': '/bin/cat', 07:44:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:49 INFO - 'PWD': '/builds/slave/test', 07:44:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:49 INFO - 'SHELL': '/bin/bash', 07:44:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:44:49 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:44:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:49 INFO - 'USER': 'cltbld', 07:44:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:49 INFO - 'XPC_FLAGS': '0x0', 07:44:49 INFO - 'XPC_SERVICE_NAME': '0', 07:44:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44:50 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 07:44:50 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 07:44:50 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 07:44:50 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 07:44:50 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 07:44:50 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 07:44:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:52 INFO - Installing collected packages: mozsystemmonitor 07:44:52 INFO - Running setup.py install for mozsystemmonitor 07:44:53 INFO - Successfully installed mozsystemmonitor 07:44:53 INFO - Cleaning up... 07:44:53 INFO - Return code: 0 07:44:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:44:53 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')]} 07:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:53 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')]} 07:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:53 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:44:53 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 07:44:53 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 07:44:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:44:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:53 INFO - 'HOME': '/Users/cltbld', 07:44:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:53 INFO - 'LOGNAME': 'cltbld', 07:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:53 INFO - 'MOZ_NO_REMOTE': '1', 07:44:53 INFO - 'NO_EM_RESTART': '1', 07:44:53 INFO - 'PAGER': '/bin/cat', 07:44:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:53 INFO - 'PWD': '/builds/slave/test', 07:44:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:53 INFO - 'SHELL': '/bin/bash', 07:44:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:44:53 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:44:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:53 INFO - 'USER': 'cltbld', 07:44:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:53 INFO - 'XPC_FLAGS': '0x0', 07:44:53 INFO - 'XPC_SERVICE_NAME': '0', 07:44:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:53 INFO - Downloading/unpacking jsonschema==2.5.1 07:44:53 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 07:44:53 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 07:44:53 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 07:44:53 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 07:44:53 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 07:44:53 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 07:44:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:44:56 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 07:44:56 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 07:44:56 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 07:44:56 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 07:44:56 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 07:44:56 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 07:44:56 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:56 INFO - warning: no files found matching '*.txt' 07:44:56 INFO - no previously-included directories found matching 'build' 07:44:56 INFO - no previously-included directories found matching 'dist' 07:44:56 INFO - no previously-included directories found matching '.git*' 07:44:56 INFO - Installing collected packages: jsonschema, functools32 07:44:57 INFO - Running setup.py install for functools32 07:44:57 INFO - warning: no files found matching '*.txt' 07:44:57 INFO - no previously-included directories found matching 'build' 07:44:57 INFO - no previously-included directories found matching 'dist' 07:44:57 INFO - no previously-included directories found matching '.git*' 07:44:57 INFO - Successfully installed jsonschema functools32 07:44:57 INFO - Cleaning up... 07:44:57 INFO - Return code: 0 07:44:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:44:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:44:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:57 INFO - 'HOME': '/Users/cltbld', 07:44:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:57 INFO - 'LOGNAME': 'cltbld', 07:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:57 INFO - 'MOZ_NO_REMOTE': '1', 07:44:57 INFO - 'NO_EM_RESTART': '1', 07:44:57 INFO - 'PAGER': '/bin/cat', 07:44:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:57 INFO - 'PWD': '/builds/slave/test', 07:44:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:57 INFO - 'SHELL': '/bin/bash', 07:44:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:44:57 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:44:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:57 INFO - 'USER': 'cltbld', 07:44:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:57 INFO - 'XPC_FLAGS': '0x0', 07:44:57 INFO - 'XPC_SERVICE_NAME': '0', 07:44:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:44:57 INFO - Cleaning up... 07:44:57 INFO - Return code: 0 07:44:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:44:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:44:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:57 INFO - 'HOME': '/Users/cltbld', 07:44:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:57 INFO - 'LOGNAME': 'cltbld', 07:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:57 INFO - 'MOZ_NO_REMOTE': '1', 07:44:57 INFO - 'NO_EM_RESTART': '1', 07:44:57 INFO - 'PAGER': '/bin/cat', 07:44:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:57 INFO - 'PWD': '/builds/slave/test', 07:44:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:57 INFO - 'SHELL': '/bin/bash', 07:44:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:44:57 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:44:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:57 INFO - 'USER': 'cltbld', 07:44:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:57 INFO - 'XPC_FLAGS': '0x0', 07:44:57 INFO - 'XPC_SERVICE_NAME': '0', 07:44:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:58 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 07:44:58 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 07:44:58 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 07:44:58 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 07:44:58 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 07:44:58 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 07:45:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:45:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:45:00 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 07:45:00 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 07:45:00 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 07:45:00 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 07:45:00 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 07:45:00 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 07:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:45:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:01 INFO - Downloading docopt-0.6.1.tar.gz 07:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:45:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:45:02 INFO - Running setup.py install for blobuploader 07:45:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:45:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:45:02 INFO - Running setup.py install for requests 07:45:02 INFO - Running setup.py install for docopt 07:45:02 INFO - Successfully installed blobuploader requests docopt 07:45:02 INFO - Cleaning up... 07:45:02 INFO - Return code: 0 07:45:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:02 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:45:02 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 07:45:02 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 07:45:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:45:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:02 INFO - 'HOME': '/Users/cltbld', 07:45:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:02 INFO - 'LOGNAME': 'cltbld', 07:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:02 INFO - 'MOZ_NO_REMOTE': '1', 07:45:02 INFO - 'NO_EM_RESTART': '1', 07:45:02 INFO - 'PAGER': '/bin/cat', 07:45:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:02 INFO - 'PWD': '/builds/slave/test', 07:45:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:02 INFO - 'SHELL': '/bin/bash', 07:45:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:45:02 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:45:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:02 INFO - 'USER': 'cltbld', 07:45:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:02 INFO - 'XPC_FLAGS': '0x0', 07:45:02 INFO - 'XPC_SERVICE_NAME': '0', 07:45:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-gYF2aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-27SUvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-r0D8jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-syOt5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-rapULM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-XddUqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-D4kFfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:03 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-tnjaQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-YJ7HUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-zLyJOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-j8gWOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-pyPCpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ZhYf0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-AOvENe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yUcSmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SxKDpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:04 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-EZTVLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:45:04 INFO - Running setup.py install for manifestparser 07:45:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:45:05 INFO - Running setup.py install for mozcrash 07:45:05 INFO - Running setup.py install for mozdebug 07:45:05 INFO - Running setup.py install for mozdevice 07:45:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:45:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:45:05 INFO - Running setup.py install for mozfile 07:45:05 INFO - Running setup.py install for mozhttpd 07:45:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:45:05 INFO - Running setup.py install for mozinfo 07:45:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Running setup.py install for mozInstall 07:45:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Running setup.py install for mozleak 07:45:06 INFO - Running setup.py install for mozlog 07:45:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Running setup.py install for moznetwork 07:45:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Running setup.py install for mozprocess 07:45:06 INFO - Running setup.py install for mozprofile 07:45:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:45:06 INFO - Running setup.py install for mozrunner 07:45:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Running setup.py install for mozscreenshot 07:45:07 INFO - Running setup.py install for moztest 07:45:07 INFO - Running setup.py install for mozversion 07:45:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:45:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:45:07 INFO - Cleaning up... 07:45:07 INFO - Return code: 0 07:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:07 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:45:07 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 07:45:07 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 07:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:07 INFO - 'HOME': '/Users/cltbld', 07:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:07 INFO - 'LOGNAME': 'cltbld', 07:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:07 INFO - 'MOZ_NO_REMOTE': '1', 07:45:07 INFO - 'NO_EM_RESTART': '1', 07:45:07 INFO - 'PAGER': '/bin/cat', 07:45:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:07 INFO - 'PWD': '/builds/slave/test', 07:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:07 INFO - 'SHELL': '/bin/bash', 07:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:45:07 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:07 INFO - 'USER': 'cltbld', 07:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:07 INFO - 'XPC_FLAGS': '0x0', 07:45:07 INFO - 'XPC_SERVICE_NAME': '0', 07:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:07 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-N6X48w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:07 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)) 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:07 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xPEv4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SX67Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-l7kLCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-gURAKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ZwFy44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-kBVINm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MO7cNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-0qZH6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-0dzchW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:08 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)) 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:08 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-k6lvFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-5lj49U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-arSDaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-DSmhQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ZhJWMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-sdpFey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:09 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)) 07:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-c4gcLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:09 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)) 07:45:09 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)) 07:45:09 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)) 07:45:09 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)) 07:45:09 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)) 07:45:09 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)) 07:45:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:45:09 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 07:45:09 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 07:45:09 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 07:45:09 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 07:45:09 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 07:45:09 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 07:45:12 INFO - Downloading blessings-1.6.tar.gz 07:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:45:12 INFO - Installing collected packages: blessings 07:45:12 INFO - Running setup.py install for blessings 07:45:12 INFO - Successfully installed blessings 07:45:12 INFO - Cleaning up... 07:45:12 INFO - Return code: 0 07:45:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:12 INFO - Reading from file tmpfile_stdout 07:45:12 INFO - Current package versions: 07:45:12 INFO - blessings == 1.6 07:45:12 INFO - blobuploader == 1.2.4 07:45:12 INFO - docopt == 0.6.1 07:45:12 INFO - functools32 == 3.2.3-2 07:45:12 INFO - jsonschema == 2.5.1 07:45:12 INFO - manifestparser == 1.1 07:45:12 INFO - mozInstall == 1.12 07:45:12 INFO - mozcrash == 1.0 07:45:12 INFO - mozdebug == 0.1 07:45:12 INFO - mozdevice == 0.49 07:45:12 INFO - mozfile == 1.2 07:45:12 INFO - mozhttpd == 0.7 07:45:12 INFO - mozinfo == 0.9 07:45:12 INFO - mozleak == 0.1 07:45:12 INFO - mozlog == 3.4 07:45:12 INFO - moznetwork == 0.27 07:45:12 INFO - mozprocess == 0.24 07:45:12 INFO - mozprofile == 0.28 07:45:12 INFO - mozrunner == 6.13 07:45:12 INFO - mozscreenshot == 0.1 07:45:12 INFO - mozsystemmonitor == 0.3 07:45:12 INFO - moztest == 0.8 07:45:12 INFO - mozversion == 1.4 07:45:12 INFO - psutil == 3.1.1 07:45:12 INFO - requests == 1.2.3 07:45:12 INFO - wsgiref == 0.1.2 07:45:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:12 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:45:12 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 07:45:12 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 07:45:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:45:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:12 INFO - 'HOME': '/Users/cltbld', 07:45:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:12 INFO - 'LOGNAME': 'cltbld', 07:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:12 INFO - 'MOZ_NO_REMOTE': '1', 07:45:12 INFO - 'NO_EM_RESTART': '1', 07:45:12 INFO - 'PAGER': '/bin/cat', 07:45:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:12 INFO - 'PWD': '/builds/slave/test', 07:45:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:12 INFO - 'SHELL': '/bin/bash', 07:45:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:45:12 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:45:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:12 INFO - 'USER': 'cltbld', 07:45:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:12 INFO - 'XPC_FLAGS': '0x0', 07:45:12 INFO - 'XPC_SERVICE_NAME': '0', 07:45:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 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)) 07:45:13 INFO - Cleaning up... 07:45:13 INFO - Return code: 0 07:45:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:13 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 0x102874b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102877768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f944cbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, '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.nKLiA4NObO/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.Olhe9TONSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:45:13 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 07:45:13 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 07:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:13 INFO - 'HOME': '/Users/cltbld', 07:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:13 INFO - 'LOGNAME': 'cltbld', 07:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:13 INFO - 'MOZ_NO_REMOTE': '1', 07:45:13 INFO - 'NO_EM_RESTART': '1', 07:45:13 INFO - 'PAGER': '/bin/cat', 07:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:13 INFO - 'PWD': '/builds/slave/test', 07:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:13 INFO - 'SHELL': '/bin/bash', 07:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:45:13 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:13 INFO - 'USER': 'cltbld', 07:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:13 INFO - 'XPC_FLAGS': '0x0', 07:45:13 INFO - 'XPC_SERVICE_NAME': '0', 07:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:45:13 INFO - Cleaning up... 07:45:13 INFO - Return code: 0 07:45:13 INFO - Running post-action listener: _resource_record_post_action 07:45:13 INFO - Running post-action listener: _start_resource_monitoring 07:45:13 INFO - Starting resource monitoring. 07:45:13 INFO - [mozharness: 2017-01-18 15:45:13.546446Z] Finished create-virtualenv step (success) 07:45:13 INFO - [mozharness: 2017-01-18 15:45:13.547412Z] Running install step. 07:45:13 INFO - Running pre-action listener: _resource_record_pre_action 07:45:13 INFO - Running main action method: install 07:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:13 INFO - Reading from file tmpfile_stdout 07:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:45:13 INFO - Reading from file tmpfile_stdout 07:45:13 INFO - Output received: 07:45:13 INFO - Usage: mozinstall [options] installer 07:45:13 INFO - Options: 07:45:13 INFO - -h, --help show this help message and exit 07:45:13 INFO - -d DEST, --destination=DEST 07:45:13 INFO - Directory to install application into. [default: 07:45:13 INFO - "/builds/slave/test"] 07:45:13 INFO - --app=APP Application being installed. [default: firefox] 07:45:13 INFO - mkdir: /builds/slave/test/build/application 07:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:45:35 INFO - Reading from file tmpfile_stdout 07:45:35 INFO - Output received: 07:45:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:45:35 INFO - Running post-action listener: _resource_record_post_action 07:45:35 INFO - [mozharness: 2017-01-18 15:45:35.862173Z] Finished install step (success) 07:45:35 INFO - [mozharness: 2017-01-18 15:45:35.862331Z] Running run-tests step. 07:45:35 INFO - Running pre-action listener: _resource_record_pre_action 07:45:35 INFO - Running main action method: run_tests 07:45:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:45:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:45:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:45:35 INFO - 2017-01-18 07:45:35.876 screenresolution[1633:7665] starting screenresolution argv=screenresolution get 07:45:35 INFO - 2017-01-18 07:45:35.879 screenresolution[1633:7665] Display 0: 1600x1200x32@60 07:45:35 INFO - 2017-01-18 07:45:35.885 screenresolution[1634:7667] starting screenresolution argv=screenresolution list 07:45:35 INFO - Available Modes on Display 0 07:45:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:45:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:45:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:45:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:45:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:45:36 INFO - Intel Iris: 07:45:36 INFO - Chipset Model: Intel Iris 07:45:36 INFO - Type: GPU 07:45:36 INFO - Bus: Built-In 07:45:36 INFO - VRAM (Dynamic, Max): 1536 MB 07:45:36 INFO - Vendor: Intel (0x8086) 07:45:36 INFO - Device ID: 0x0a2e 07:45:36 INFO - Revision ID: 0x0009 07:45:36 INFO - Displays: 07:45:36 INFO - Display: 07:45:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:45:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:45:36 INFO - Display Serial Number: 1600x1200 60 07:45:36 INFO - Main Display: Yes 07:45:36 INFO - Mirror: Off 07:45:36 INFO - Online: Yes 07:45:36 INFO - Rotation: Supported 07:45:36 INFO - Return code: 0 07:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:36 INFO - Python 2.7.3 07:45:36 INFO - Return code: 0 07:45:36 INFO - grabbing minidump binary from tooltool 07:45:36 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')]} 07:45:36 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 0x102652d30>, '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 0x102579db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102647be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:36 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 07:45:36 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 07:45:36 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 07:45:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:36 INFO - Return code: 0 07:45:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:45:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:45:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:36 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/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 07:45:36 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/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --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 07:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKLiA4NObO/Render', 07:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:36 INFO - 'HOME': '/Users/cltbld', 07:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:36 INFO - 'LOGNAME': 'cltbld', 07:45:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:36 INFO - 'MOZ_NO_REMOTE': '1', 07:45:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:36 INFO - 'NO_EM_RESTART': '1', 07:45:36 INFO - 'PAGER': '/bin/cat', 07:45:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:36 INFO - 'PWD': '/builds/slave/test', 07:45:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:36 INFO - 'SHELL': '/bin/bash', 07:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Olhe9TONSv/Listeners', 07:45:36 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:36 INFO - 'USER': 'cltbld', 07:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:36 INFO - 'XPC_FLAGS': '0x0', 07:45:36 INFO - 'XPC_SERVICE_NAME': '0', 07:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:45:36 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/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 07:45:36 INFO - mozversion application_buildid: 20170118062528 07:45:36 INFO - mozversion application_changeset: 5b544b8ab06b0d75bb3abb4095cceefeeebec525 07:45:36 INFO - mozversion application_display_name: Nightly 07:45:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:36 INFO - mozversion application_name: Firefox 07:45:36 INFO - mozversion application_remotingname: firefox 07:45:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:45:36 INFO - mozversion application_vendor: Mozilla 07:45:36 INFO - mozversion application_version: 53.0a1 07:45:36 INFO - mozversion platform_buildid: 20170118062528 07:45:36 INFO - mozversion platform_changeset: 5b544b8ab06b0d75bb3abb4095cceefeeebec525 07:45:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:45:36 INFO - mozversion platform_version: 53.0a1 07:45:36 INFO - using testdate: 1484754336 07:45:36 INFO - actual date: 1484754336 07:45:36 INFO - starting webserver on 'localhost:49243' 07:45:36 INFO - SUITE-START | Running 2 tests 07:45:36 INFO - TEST-START | dromaeo_css 07:45:36 INFO - operating with platform_type : mac_ 07:45:36 INFO - Initialising browser for dromaeo_css test... 07:45:36 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpW_YsCr/profile http://localhost:49243/getInfo.html) 07:45:39 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 07:45:39 INFO - PROCESS | 1644 | colorDepth:24 07:45:39 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 07:45:39 INFO - PROCESS | 1644 | __metrics 07:45:39 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:45:39 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:45:39 INFO - TEST-INFO | 1644: exit 0 07:45:39 INFO - Browser initialized. 07:45:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:39 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpW_YsCr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:51 INFO - PROCESS | 1646 | RSS: Main: 235245568 07:45:51 INFO - PROCESS | 1646 | 07:48:56 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 07:48:57 INFO - PROCESS | 1646 | RSS: Main: 364396544 07:48:57 INFO - PROCESS | 1646 | 07:50:41 INFO - PROCESS | 1646 | ************************* 07:50:41 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 07:50:41 INFO - PROCESS | 1646 | 07:50:41 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:50:41 INFO - PROCESS | 1646 | Full stack: 07:50:41 INFO - PROCESS | 1646 | ************************* 07:52:00 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 07:52:01 INFO - PROCESS | 1646 | RSS: Main: 367177728 07:52:01 INFO - PROCESS | 1646 | 07:55:03 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 07:55:04 INFO - PROCESS | 1646 | RSS: Main: 335593472 07:55:04 INFO - PROCESS | 1646 | 07:58:06 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 07:58:07 INFO - PROCESS | 1646 | RSS: Main: 338939904 07:58:07 INFO - PROCESS | 1646 | 08:01:10 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 08:01:11 INFO - PROCESS | 1646 | RSS: Main: 327368704 08:01:11 INFO - PROCESS | 1646 | 08:04:14 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 08:04:15 INFO - PROCESS | 1646 | RSS: Main: 377069568 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | __start_tp_report 08:04:15 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 08:04:15 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 08:04:15 INFO - PROCESS | 1646 | |i|pagename|runs| 08:04:15 INFO - PROCESS | 1646 | |0;dojo.html;3343.180920674435;3346.3976484232835;3347.7656564040512;3375.9493607595873;3418.5214070030183;5501.944980550194;5568.52667523261;5632;5659.094544872826;5668.036433806253;5611.887762244753;5617.4382561743805;5675.432456754323;5704.828855134353;5725.971370143154;5042.571381432583;5088.567471764904;5100.0054989277105;5138.434772175057;5193.45468725784;5256.947430525704;5264.447233040533;5267.23625074364;5267.65760225586;5315.548178404821;5091.312672789163;5232.2413250078525;5247.9737601311745;5249.317588713462;5262.710550919698;5139.254808052811;5142.280080788655;5197.402298735656;5206.895862082737;5228.8692782680355;5132.076226279269;5163.948360516384;5190.299309593194;5195.142801437796;5237.397699264558;5679;5693.843792972871;5702.429757024306;5720.056190728525;5771.105478650816;6104.572679912408;6116.305337586;6130.04269582218;6134.467201660894;6246.531510136712;6225.097360882647;6246.250449946036;6299.65351905645;6302.401271879165;6308.432241098278;5790;5816.70916454184;5817.854553636193;5828.446297601721;5863.061910094407;6184.783532576338;6209.068639704081;6272.560920735596;6314.62112273265;6315.621062736159;5659.471942575482;5724.856878577985;6073.574849760563;6091.725872335755;6131.325554189036;6140.815775526741;6208.31757281354;6240.375962403723;6256.405641464054;6266.373362663789;6082.0876868469195;6109.14471973924;6122.062734707273;6138.265785110792;6177.938220617826;6246.46905013079;6257.217847769029;6269.122322874801;6281.434670879551;6283.874322513524;4847.224444088929;4896.95103048972;4899.2896030075435;4899.412070551557;4905.7301848397965;4421.270490369117;4427.247367947457;4428.535003824552;4433.866983990485;4472.15029144468;5802.013657678205;5810.941890581124;5823.505002074787;5823.82528524145;5825.155352473867;6112.26032301701;6194.101855231056;6307.653079080603;6310.432061114522;6320.367963203643;5746.626469279567;5773.336066352424;5806.564507661942;5839.0949402842625;5851.327097383855;5410.972945135328;5415.891682166334;5425.240466334716;5429.294191755125;5429.972850135803;6253.343398943137;6255.937440625536;6285.5600107992;6306.621602703853;6328.0824280478155;6145.6927153641245;6178.382161783786;6193.81418557444;6221.595596286227;6245.7189426476825;6243.687815609293;6258.843528911631;6261.3112557617715;6268.435840774352;6276.309605943434;6167.6916154193;6196.318404975359;6197.25632924052;6198.907016394667;6202.534809889186;6107.27984577779;6158.137860699416;6188.783392581238;6194.81415557534;6199;4807.6153907688;5772.9031484017905;6130.111133885473;6144.03390914903;6157.599756016024;5944.3164036136395;6005.939940600713;6013.699315034319;6100.8779824404155;6146.293176284606;5733.770649173986;5775.48020678141;5846.035404158266;5853.94146058534;5877.324107727666;5950.851228719317;6005.039193728982;6014.1580178775885;6086.573939824347;6106;5868.970655146697;5876.676782776988;5890.558208134493;5972.223610930551;6006.459418652343 08:04:15 INFO - PROCESS | 1646 | |1;ext.html;428.7470392468444;494.38202247190986;495.45005044400733;519.2704250528008;522.2505704314309;23270.364817591206;39100.41349379761;40178.99552511189;40470.595294047125;40542.18915621686;41476.17047659045;41754.16491670165;41800.163996720046;41850;41864.162716745726;9227.907720922789;9454.385464944757;9462.668806591771;9464.1009104135;9472.336936414455;8373.07896131425;8593.699220527284;11011.724706882313;11263.943680281587;11328.943355283212;11277.492512836941;11299;11370.14723895707;11384.658460246206;11385.032272256869;8413.579321033923;11214.551417943272;11301.830472542919;11315.717107072307;11334.886651133465;8325.750227493185;10889.183311251609;11157.66527004191;11204.271722338022;11297.435128243555;39297.017574560865;39677;39752.60247397547;39758.80120599378;39802.80098599517;4052.1490486997764;4069.4302797608357;4071.185762847442;4095;4234.280172370673;29125.271868203254;29643.55534666982;30119.247018824484;30143.397132057456;30188;3162.5256211568217;3240.416724989501;3332.6500717424565;3332.800031998088;3336.2660214752714;368222;372434;373965;375517.448255175;375855;56248.15627765587;56794.43205567892;56872.146917796264;56873.715631422405;56902.14646780219;59639.40360596425;59757;59803.401965979785;59812.401875980686;59834.70082649559;15553;15812.446564370191;15818;15852.841471585367;15885.841141588668;11011.669649910515;11356.034737047443;12251.264924104404;12339.93830030844;12352.814707779391;13625.18248905049;13689.452421903212;13937.163770173822;14988.651021407908;15285.847141528664;5232.895342093213;6019.307779605314;6083.330833608299;6094.360092190256;6121.724522396503;843.4896887383168;858.6822875535967;867.2671592504324;867.297489033872;896.1576118448637;29169.56245656317;29429.822807087905;29486.410271794874;30035.849820751195;30067.849660751555;1038.672818062308;1054.1303424674675;1058.8517607534952;1092.7104317355906;1097.8847221041676;14659.780103298459;15044.097354158786;15138.318775655121;15357.078575285519;15484.845151548341;622163;628771.6912555115;629029;630848;631891;57529.84940301171;57820;57870;57871;57881.71059144761;1431.1270125223605;1445.6096853849401;1445.8337291211224;1448.16730380034;1460.2041887171517;27661;28336.716632833406;29131;29165.416691666473;29206.7079329204;45637.31544026776;48455.75772121117;49084.77288067827;49161.01677966492;51685.7415712919;561691;569511;570320;570396;571557;23718.762812372344;24071.157509487082;24072.39819004469;24127.155549556384;24175.395615109763;34030.31939361248;39811.40282895817;41508.792456037525;41768.791156044026;44026.03765660978;35144.121396964256;35207.64792352044;35433.82283088568;36324.63675363318;36508.45237321389;24451.877740611184;34809.65190348165;35461;35847.82076089603;36587.63412365842;34331.970040898814;34396.48405273873;34891.9532414028;34986.65013349834;35259.589616415054;29540.409191815612;32677.019689409357;32709.509357360133;32791.67208327982;32818.50772238466;21396.465088372915;23065.308040758806;23276.76723232746;23912.88043559771;24285.271441856774 08:04:15 INFO - PROCESS | 1646 | |2;jquery.html;371.84940099259774;389.26429049097203;390.97849618270993;395.2569169960474;424.1432306740385;15275.00712453691;15408.84591154088;18592.814071859262;21082.89458552709;21128.683069753966;21294.984132053243;21427.250046248384;21922.780772192273;21952.902354882273;22378.55242895145;5847.26909136358;5929.851753706149;5954.553408494358;6032.66820324882;6091.14723938649;4201.558836322172;4413.58070983256;5812.593118481687;5966.67183304918;5971.552133589977;6368.936310636904;6674.1323627928305;6678;6752.527323087385;6772.356626120511;6497.415232629086;6682.732690692366;6712.56368336059;6741.797746067626;6744.325567443266;5648.3222013358245;5866.2960444746905;5871.706414679249;5879.882402351972;5892.823215303548;22704.65943010856;22890.65664015041;23180.18869339565;25258.74741252601;26163.476730465285;2707.539718247903;2720.8095433319677;2722.414680843628;2729.3858881751644;2730.808843380964;13722.245276509788;15215.087094774239;15550.455734049367;15730;16586.336546538125;1826.8629852761096;1867.030059482357;1869.140195510067;1870.6819840627127;1885.198790514026;112985.87014129918;115634;115667;116684;116762.8323716769;11355.886441135648;11364.94317528407;11498.25261358009;11512.481938312796;11624.767504649859;14453.421863125357;14459.710805783825;14477.638059048397;14489.855101449062;14507.274636268145;8524.190201930807;8662.566871656392;8708.521031343336;8736.78158046054;8813.911860881437;7772.961135194288;7975.84048319042;8547.922747810782;8714.302855771522;8734.213920747163;7010.018597396369;7126.287371262936;7154.069970903749;7161.212266650664;7164.570125792469;1586.8095828500655;1900.9524761881064;1901.4010586665156;1904.200235900925;1913.5598812272976;1009.9646512372032;1012.964546240878;1017.7201269650906;1025.6974192613047;1051.695008447557;21330.680039799416;21660.56678866414;21878.89060554687;21988.450288742588;22147.335579932627;895.9372843900865;1034.4414016431042;1050.7005503431485;1057.2757661002238;1057.8889216632297;10358.844617330746;11158.489339898459;11326.377049262204;12041.578544750892;12222.694432639255;438853;540651.5934840679;732447;742936;743428;133384;135203;140482.1903561923;144356.27821860823;151752.2412387931;1043.7683533430472;1054.2409465185056;1089.2865173311493;1099.5272033025876;1109.7003808971533;18215.80849457898;20017.796262784977;20021.399358019284;20076.297329593395;20102.39692809218;58810.41189588049;59166;59523.107153391866;59958.10062849148;60986;85396;88049.55975220083;88341.67487487564;89246;91489;8074.111847696866;8171.346292296483;8364.289035432057;8450;8589.828203436022;9359.812803744024;13046.54337098197;13256.93371533136;13466.528671496842;13512.324383780575;11045.171612128961;11404.828927565926;11443.542258309575;11478.94260528692;11521.292496263204;11116.055135313265;11134.27627204229;11359.48882300282;11509.02173315244;11516.82724759146;5855.9121613176685;7676.501027433199;10172.338797978107;11572.826407603725;11834.408279585814;6735.461163106842;7029.437644988287;8286.544240066612;8451.577421128795;8602.741917742478;10020.498975051363;10417.583296668048;11012.063974562252;11452.14108941816;11696.590619328623 08:04:15 INFO - PROCESS | 1646 | |3;mootools.html;1426.6861290516083;1434.8923830712695;1438.6331485471203;1447.421031587365;1449.3477934929278;8050.3157231635305;8446.873296900543;8452.577371131449;8475.83048339033;8491.193336633025;6285.528585356094;7632.198619144993;7632.542047477155;7949.523028618287;8255.42212045157;1976.179885347579;2305.3429772514837;2319.698439202901;2321.8042708005305;2326.5579539887453;2289.347535952254;2322.0711715313923;2330.2193765088714;2331.1258278145697;2337.555864385761;2032.227753453693;2109.4093653776968;2287.0623044551735;2304.4238940264936;2310.503241803012;2220.566989437052;2295.896684649186;2296.1045192374986;2297.0811675329833;2298.3909264044873;2253.58308712887;2300.988495057514;2304.976950230493;2311.5030268492187;2331.160782118436;8328.167183281685;8404.28563572091;8405.957970210171;8422.620982055761;8444.788880277982;5062.190049592047;5219.739013049332;5220.556252718524;5225.608079394023;5228.320318358627;3303.5629501166827;3323.7507186961075;3356.580427446569;3510.7542472026967;3592.299931071001;1182.722060315825;1189.173524400542;1217.1419149499582;1266.2972050511962;1268.517963173988;10714.73213169677;10744.409057501913;10760.13918886495;10762.784744305149;10774.515146818334;4470.307102399133;4597.586217240464;4642.396488456479;4694.718316900997;4714.010057887814;7424.294692004251;8615.39692221551;8688.174623410765;8691.95654021726;8731.869021964676;5146.536811686966;5148.3564554430695;5148.407933087743;5148.56237219833;5150.381954165449;4326.63223625989;4760.928586071212;4833.468318484964;4835.298881662139;4835.443923948791;3564.091156755011;3626.655467730561;3646.2525182338086;3668.614795446493;3701.0747313171705;972.7179118055826;1116.1126904111252;1160.4197901049474;1162.2910024884814;1168.8714241433436;810.3679130278392;839.8572242718752;893.6425429827991;926.2960150285832;927.1701826864918;5146.459621739738;5254.264402983586;5558.583106267046;5910.970445147746;5933.792317268962;935.2471260635118;959.7504648791225;970.0638883477478;974.4202199691173;1004.5730564510054;3451.5858097028517;3470.408127587985;3617.638236176414;3620.7103431725927;3686.4838922550866;9624.3744156631;9664.661736839176;9961.203103751683;9980.351277167107;9981.251406144569;9596.328257021942;9609.47147906858;9639.759006024906;9859.556319965619;10031.749206269757;5239.842804715865;7490.6629201686055;7491.026166598416;7730.806729831686;7903.288704016666;4750.738709370879;5575.944240557543;5622.718864056863;5631.900865835279;5647.463490968352;8780;8909.73270801877;9257.490838003974;9306;9313.115254050854;8442.178087910865;9053.139951704577;9469.242460603273;9511.096445837635;9525.714228573153;5981.431763982415;7183.102112235971;7183.5330703504105;7268.96365518169;7289.4168466523615;7793.610319484116;7891.84216315659;7944.165862584346;7973.601319933864;8043.396745244013;7107.928920710727;7144.3570078693165;7172.677229524579;7206.135263768381;7227.530210536298;6675.933240667531;6900.7929762107215;6968.825779355557;7050.858982820418;7071.328223818729;6270.059491076375;6382.36176382358;6384.9042264367;6386.90419643715;6403.167588213502;4825.758712064453;4832.468428472936;4976.800927962986;4993.925091123709;5191.32512773337;4827.444843843003;4956.529129732669;4980.950190498049;5018.473060328759;5107.799667078308 08:04:15 INFO - PROCESS | 1646 | |4;prototype.html;356.37812018028535;362.1471434771114;367.1225770408724;377.99055023624425;378.89201577550403;4929.630277729171;5074.441811400743;5229.450907654698;5293.6294459387855;5371.75827087781;4472.489096059594;4934.827281045164;5142.974285128578;5191.5846732261425;5192.3249977502965;3645.489631451599;3887.8250478728523;4084.4690190275223;4101.405296232045;4116.991337122402;3456.5160877477174;4128.422020917074;4133.0035724099935;4133.987173142585;4148.875533733993;3938.72428929975;3971.86098486553;3984.8605298814546;3987.900302492432;3988.7407318524347;3154.936901261985;3786.3563194256767;3863.98068009661;3959.663428608572;4000.959990400088;2828.8019838611303;3024.123004328742;3351.916202094943;3404.3872103021445;3552.7335449841366;3959.2873282809082;4959.008198360342;5062;5125.488510629764;5141.820036298712;3953.762774233526;4495.617872480843;4559.381419596062;4559.886002849922;4581.5647513486165;5542.612017158801;5562.3591040642705;5563.499285064323;5637.182608521783;5662.716864156776;3397.6432474590306;3663.816809159531;3803.448499967489;3853.997960530254;3861.3049651062797;4642.814287428465;5339.716074614084;5734.254546908875;5756.683382413966;5780.88438231233;3828.770273783582;3833.789141597239;3852.2295540891932;3852.9614703852603;3862.748921320105;3892.9610703893163;3909.2181563687377;3917.2557214129224;3926.9607303926596;3931.1916518401285;4289.549597292302;4478.305862591304;4495.9325610115875;4508.81964721414;4547.386102876069;4866.878328041827;5333.799895023666;5563.972180139073;5569.749361278752;5598.328200615871;1091.7761858818924;1150.6192568917165;1191.70803153228;1192.7197108679454;1247.5820600098887;756.6557216466495;842.439777547936;870.2037635563515;870.7243887704543;879.4679219072497;4434.600885920283;4587.9541204588195;4593.563611456906;4862.586680132228;4922.507749225048;4879.194228501774;4919.434265059493;5201.271821944931;5415.48552887475;5432.91850622241;3960.960390396059;4050.1697152083752;4158;4315.396643802397;4762.52374762521;2530.3041663542303;2651.764846886795;2678.25008997481;2768.5465130806488;2839.361143742641;4684.718916864999;5361.825838066285;5396.815878631626;5465.508104270635;5563.36021357541;4490.640748740093;5724.885502289931;5758.539316854642;5868.823935281948;5917.408259174048;5610.551155907436;5873.765049398062;5905.940940590539;5956.612820166675;6026.638401695912;5028.34631497903;5489;5620.85947851307;5640.7001903886685;5713.314402271754;5304.575633949352;5491.28613280271;5604.85987850307;5615.606907516435;5693.9430605693415;5559;5685.658860468385;5913.215542053175;5948.256467941507;5952.523798096228;3675.7426980111136;3747.6015350176453;4100.917981640291;4133.359329303963;4173.227952828736;5102.413222479314;5454.290942177491;5758.193852860687;5769.624974376652;5792.522906658944;4689.7655117244685;4698.976505117453;5267.3152490176035;5628.410930971799;5639.379668236573;4735.337052812678;5120.487951204998;5198.610104242272;5587;5588.273524441796;5046.924296135634;5164.561012313845;5332.33345831771;5354.411014788292;5466.808661696821;4807.879803004953;4904.460509343898;5456.863578410413;5490.423505531861;5609.971950140223;4447.132809102194;4748.525147485224;5461.590380721541;5473.343198816167;5529.815722789556 08:04:15 INFO - PROCESS | 1646 | |5;yui.html;719.4280546965163;731.1847290271346;747.5103807006411;766.3256334425705;869.1135042256898;12105.697357566065;13617.863821361783;13735.17588944664;16032.957857739239;16090.51728448147;12466.314352710597;14459.20474373909;14500;14837.109773413602;14847.628809279773;853.7225401744427;874.6107981948036;880.2429910277189;881.3610132653806;882.5940067568926;698.3784431855653;721.5093736259341;856.297835774665;887.6493784954939;892.6027917576681;929.2705226397279;931.1340453378356;931.5575101826646;934.2992755433424;935.5322338830584;918.9264858811279;924.9825192288496;929.9163075323186;929.9442033477945;932.2122806228726;528.643165863041;545.8444343362163;668.2782594797607;685.0170006041346;687.7970998555388;15461.149636769973;15490.690186196212;15510.302036408277;15516.456924007605;15518.224088795629;13734.65663358414;13744.65638359039;13766.65583360414;13869.653258668513;13882.4447022119;12547.686307842378;12720.300383478905;12786.232826030468;12801.807972880415;13085.672858178526;4391.341298805173;4398.8020539075815;4415.094905544356;4471.329300604935;4577.862664120082;89111;91714.08285917122;92021.07978920192;92177;92404.53797730968;10442.269041167197;10678.62624808128;11025.283356581796;11028.172887033505;11274.463245769637;21376.824274665043;21715.23996660141;21748.89125554362;21750.89124554367;21751.891240543697;7453.142888567776;7686.884696729554;7694.07671079474;7749.070111586533;7750.224977502317;3792.3173828710546;4264.466941632296;4361.214981303332;4385.846495372647;4447.043885564619;3408.642092580293;3456.343294773985;3476.7392445566684;3490.7905525668543;3500.5099286099967;633.2527617411498;636.3541005879036;648.6108334999058;655.9639219842954;656.6224420957873;545.9945400546023;583.6264790534061;617.8733359661259;653.3074940563018;654.5745265577318;8960.955195223982;9957.80084398308;10147;10214.182865370902;10292.176625869912;544.2786069651742;585.2976428286074;588.2822955993681;601.9187409699634;705.7670968580459;4470.977645111753;4847.297141914402;4999.475055119233;5012.298278241049;5040.798368065236;91336;100626;102207.48896255619;104235;105341;90440;90854.54572727095;92037.07962920419;92041;92521;58858.41141588529;66306.66846665736;78097.21902781013;79748.6012569945;81798;10801.02790748805;10879.619213327496;11111.944440277746;11117.610883619034;11146.442677866236;44627.77686111549;46872.53127468818;48389;50699;50818.74590627023;50119.74940125276;63768.53620246538;64510.67744661247;65706.34293657193;66288;10983.50574224146;12879.420426081037;13060.412281447549;13230.338483076;13402.597922062354;14615.34230959588;14727.852721473077;14931;14975.850241497881;15357.232138392812;13151.671208219872;13687.863121369057;13702.45190192381;13724.588262352145;13989.790153147915;13407.597772066854;13508.527201547899;13808.309584520935;14045.595440456282;14223.857761422254;10254.948725256327;13371.465141394236;13545.458181672622;13662.975276854077;13791.586252412444;11281.379524126252;11455.656330310105;11734.458826851438;11906.821397679216;11940;10335.379877207391;10785.245032847626;11031.503582338975;11041.06150977176;11047.447627618427 08:04:15 INFO - PROCESS | 1646 | __end_tp_report 08:04:15 INFO - PROCESS | 1646 | __start_cc_report 08:04:15 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1265 08:04:15 INFO - PROCESS | 1646 | __end_cc_report 08:04:15 INFO - PROCESS | 1646 | __startTimestamp1484755455232__endTimestamp 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | ------- Summary: start ------- 08:04:15 INFO - PROCESS | 1646 | Number of tests: 6 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5718.88 Median:5863.06 stddev:632.45 (10.8%) stddev-sans-first:606.30 08:04:15 INFO - PROCESS | 1646 | Values: 3343.2 3346.4 3347.8 3375.9 3418.5 5501.9 5568.5 5632.0 5659.1 5668.0 5611.9 5617.4 5675.4 5704.8 5726.0 5042.6 5088.6 5100.0 5138.4 5193.5 5256.9 5264.4 5267.2 5267.7 5315.5 5091.3 5232.2 5248.0 5249.3 5262.7 5139.3 5142.3 5197.4 5206.9 5228.9 5132.1 5163.9 5190.3 5195.1 5237.4 5679.0 5693.8 5702.4 5720.1 5771.1 6104.6 6116.3 6130.0 6134.5 6246.5 6225.1 6246.3 6299.7 6302.4 6308.4 5790.0 5816.7 5817.9 5828.4 5863.1 6184.8 6209.1 6272.6 6314.6 6315.6 5659.5 5724.9 6073.6 6091.7 6131.3 6140.8 6208.3 6240.4 6256.4 6266.4 6082.1 6109.1 6122.1 6138.3 6177.9 6246.5 6257.2 6269.1 6281.4 6283.9 4847.2 4897.0 4899.3 4899.4 4905.7 4421.3 4427.2 4428.5 4433.9 4472.2 5802.0 5810.9 5823.5 5823.8 5825.2 6112.3 6194.1 6307.7 6310.4 6320.4 5746.6 5773.3 5806.6 5839.1 5851.3 5411.0 5415.9 5425.2 5429.3 5430.0 6253.3 6255.9 6285.6 6306.6 6328.1 6145.7 6178.4 6193.8 6221.6 6245.7 6243.7 6258.8 6261.3 6268.4 6276.3 6167.7 6196.3 6197.3 6198.9 6202.5 6107.3 6158.1 6188.8 6194.8 6199.0 4807.6 5772.9 6130.1 6144.0 6157.6 5944.3 6005.9 6013.7 6100.9 6146.3 5733.8 5775.5 5846.0 5853.9 5877.3 5950.9 6005.0 6014.2 6086.6 6106.0 5869.0 5876.7 5890.6 5972.2 6006.5 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:65270.84 Median:35233.62 stddev:143098.28 (406.1%) stddev-sans-first:143416.89 08:04:15 INFO - PROCESS | 1646 | Values: 428.7 494.4 495.5 519.3 522.3 23270.4 39100.4 40179.0 40470.6 40542.2 41476.2 41754.2 41800.2 41850.0 41864.2 9227.9 9454.4 9462.7 9464.1 9472.3 8373.1 8593.7 11011.7 11263.9 11328.9 11277.5 11299.0 11370.1 11384.7 11385.0 8413.6 11214.6 11301.8 11315.7 11334.9 8325.8 10889.2 11157.7 11204.3 11297.4 39297.0 39677.0 39752.6 39758.8 39802.8 4052.1 4069.4 4071.2 4095.0 4234.3 29125.3 29643.6 30119.2 30143.4 30188.0 3162.5 3240.4 3332.7 3332.8 3336.3 368222.0 372434.0 373965.0 375517.4 375855.0 56248.2 56794.4 56872.1 56873.7 56902.1 59639.4 59757.0 59803.4 59812.4 59834.7 15553.0 15812.4 15818.0 15852.8 15885.8 11011.7 11356.0 12251.3 12339.9 12352.8 13625.2 13689.5 13937.2 14988.7 15285.8 5232.9 6019.3 6083.3 6094.4 6121.7 843.5 858.7 867.3 867.3 896.2 29169.6 29429.8 29486.4 30035.8 30067.8 1038.7 1054.1 1058.9 1092.7 1097.9 14659.8 15044.1 15138.3 15357.1 15484.8 622163.0 628771.7 629029.0 630848.0 631891.0 57529.8 57820.0 57870.0 57871.0 57881.7 1431.1 1445.6 1445.8 1448.2 1460.2 27661.0 28336.7 29131.0 29165.4 29206.7 45637.3 48455.8 49084.8 49161.0 51685.7 561691.0 569511.0 570320.0 570396.0 571557.0 23718.8 24071.2 24072.4 24127.2 24175.4 34030.3 39811.4 41508.8 41768.8 44026.0 35144.1 35207.6 35433.8 36324.6 36508.5 24451.9 34809.7 35461.0 35847.8 36587.6 34332.0 34396.5 34892.0 34986.7 35259.6 29540.4 32677.0 32709.5 32791.7 32818.5 21396.5 23065.3 23276.8 23912.9 24285.3 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:37195.12 Median:21900.84 stddev:108856.10 (497.0%) stddev-sans-first:109126.36 08:04:15 INFO - PROCESS | 1646 | Values: 371.8 389.3 391.0 395.3 424.1 15275.0 15408.8 18592.8 21082.9 21128.7 21295.0 21427.3 21922.8 21952.9 22378.6 5847.3 5929.9 5954.6 6032.7 6091.1 4201.6 4413.6 5812.6 5966.7 5971.6 6368.9 6674.1 6678.0 6752.5 6772.4 6497.4 6682.7 6712.6 6741.8 6744.3 5648.3 5866.3 5871.7 5879.9 5892.8 22704.7 22890.7 23180.2 25258.7 26163.5 2707.5 2720.8 2722.4 2729.4 2730.8 13722.2 15215.1 15550.5 15730.0 16586.3 1826.9 1867.0 1869.1 1870.7 1885.2 112985.9 115634.0 115667.0 116684.0 116762.8 11355.9 11364.9 11498.3 11512.5 11624.8 14453.4 14459.7 14477.6 14489.9 14507.3 8524.2 8662.6 8708.5 8736.8 8813.9 7773.0 7975.8 8547.9 8714.3 8734.2 7010.0 7126.3 7154.1 7161.2 7164.6 1586.8 1901.0 1901.4 1904.2 1913.6 1010.0 1013.0 1017.7 1025.7 1051.7 21330.7 21660.6 21878.9 21988.5 22147.3 895.9 1034.4 1050.7 1057.3 1057.9 10358.8 11158.5 11326.4 12041.6 12222.7 438853.0 540651.6 732447.0 742936.0 743428.0 133384.0 135203.0 140482.2 144356.3 151752.2 1043.8 1054.2 1089.3 1099.5 1109.7 18215.8 20017.8 20021.4 20076.3 20102.4 58810.4 59166.0 59523.1 59958.1 60986.0 85396.0 88049.6 88341.7 89246.0 91489.0 8074.1 8171.3 8364.3 8450.0 8589.8 9359.8 13046.5 13256.9 13466.5 13512.3 11045.2 11404.8 11443.5 11478.9 11521.3 11116.1 11134.3 11359.5 11509.0 11516.8 5855.9 7676.5 10172.3 11572.8 11834.4 6735.5 7029.4 8286.5 8451.6 8602.7 10020.5 10417.6 11012.1 11452.1 11696.6 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5339.53 Median:5223.08 stddev:2897.57 (55.5%) stddev-sans-first:2890.77 08:04:15 INFO - PROCESS | 1646 | Values: 1426.7 1434.9 1438.6 1447.4 1449.3 8050.3 8446.9 8452.6 8475.8 8491.2 6285.5 7632.2 7632.5 7949.5 8255.4 1976.2 2305.3 2319.7 2321.8 2326.6 2289.3 2322.1 2330.2 2331.1 2337.6 2032.2 2109.4 2287.1 2304.4 2310.5 2220.6 2295.9 2296.1 2297.1 2298.4 2253.6 2301.0 2305.0 2311.5 2331.2 8328.2 8404.3 8406.0 8422.6 8444.8 5062.2 5219.7 5220.6 5225.6 5228.3 3303.6 3323.8 3356.6 3510.8 3592.3 1182.7 1189.2 1217.1 1266.3 1268.5 10714.7 10744.4 10760.1 10762.8 10774.5 4470.3 4597.6 4642.4 4694.7 4714.0 7424.3 8615.4 8688.2 8692.0 8731.9 5146.5 5148.4 5148.4 5148.6 5150.4 4326.6 4760.9 4833.5 4835.3 4835.4 3564.1 3626.7 3646.3 3668.6 3701.1 972.7 1116.1 1160.4 1162.3 1168.9 810.4 839.9 893.6 926.3 927.2 5146.5 5254.3 5558.6 5911.0 5933.8 935.2 959.8 970.1 974.4 1004.6 3451.6 3470.4 3617.6 3620.7 3686.5 9624.4 9664.7 9961.2 9980.4 9981.3 9596.3 9609.5 9639.8 9859.6 10031.7 5239.8 7490.7 7491.0 7730.8 7903.3 4750.7 5575.9 5622.7 5631.9 5647.5 8780.0 8909.7 9257.5 9306.0 9313.1 8442.2 9053.1 9469.2 9511.1 9525.7 5981.4 7183.1 7183.5 7269.0 7289.4 7793.6 7891.8 7944.2 7973.6 8043.4 7107.9 7144.4 7172.7 7206.1 7227.5 6675.9 6900.8 6968.8 7050.9 7071.3 6270.1 6382.4 6384.9 6386.9 6403.2 4825.8 4832.5 4976.8 4993.9 5191.3 4827.4 4956.5 4981.0 5018.5 5107.8 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4420.31 Median:4873.04 stddev:1367.70 (28.1%) stddev-sans-first:1337.09 08:04:15 INFO - PROCESS | 1646 | Values: 356.4 362.1 367.1 378.0 378.9 4929.6 5074.4 5229.5 5293.6 5371.8 4472.5 4934.8 5143.0 5191.6 5192.3 3645.5 3887.8 4084.5 4101.4 4117.0 3456.5 4128.4 4133.0 4134.0 4148.9 3938.7 3971.9 3984.9 3987.9 3988.7 3154.9 3786.4 3864.0 3959.7 4001.0 2828.8 3024.1 3351.9 3404.4 3552.7 3959.3 4959.0 5062.0 5125.5 5141.8 3953.8 4495.6 4559.4 4559.9 4581.6 5542.6 5562.4 5563.5 5637.2 5662.7 3397.6 3663.8 3803.4 3854.0 3861.3 4642.8 5339.7 5734.3 5756.7 5780.9 3828.8 3833.8 3852.2 3853.0 3862.7 3893.0 3909.2 3917.3 3927.0 3931.2 4289.5 4478.3 4495.9 4508.8 4547.4 4866.9 5333.8 5564.0 5569.7 5598.3 1091.8 1150.6 1191.7 1192.7 1247.6 756.7 842.4 870.2 870.7 879.5 4434.6 4588.0 4593.6 4862.6 4922.5 4879.2 4919.4 5201.3 5415.5 5432.9 3961.0 4050.2 4158.0 4315.4 4762.5 2530.3 2651.8 2678.3 2768.5 2839.4 4684.7 5361.8 5396.8 5465.5 5563.4 4490.6 5724.9 5758.5 5868.8 5917.4 5610.6 5873.8 5905.9 5956.6 6026.6 5028.3 5489.0 5620.9 5640.7 5713.3 5304.6 5491.3 5604.9 5615.6 5693.9 5559.0 5685.7 5913.2 5948.3 5952.5 3675.7 3747.6 4100.9 4133.4 4173.2 5102.4 5454.3 5758.2 5769.6 5792.5 4689.8 4699.0 5267.3 5628.4 5639.4 4735.3 5120.5 5198.6 5587.0 5588.3 5046.9 5164.6 5332.3 5354.4 5466.8 4807.9 4904.5 5456.9 5490.4 5610.0 4447.1 4748.5 5461.6 5473.3 5529.8 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19813.09 Median:4388.59 stddev:27748.74 (632.3%) stddev-sans-first:27789.55 08:04:15 INFO - PROCESS | 1646 | Values: 719.4 731.2 747.5 766.3 869.1 12105.7 13617.9 13735.2 16033.0 16090.5 12466.3 14459.2 14500.0 14837.1 14847.6 853.7 874.6 880.2 881.4 882.6 698.4 721.5 856.3 887.6 892.6 929.3 931.1 931.6 934.3 935.5 918.9 925.0 929.9 929.9 932.2 528.6 545.8 668.3 685.0 687.8 15461.1 15490.7 15510.3 15516.5 15518.2 13734.7 13744.7 13766.7 13869.7 13882.4 12547.7 12720.3 12786.2 12801.8 13085.7 4391.3 4398.8 4415.1 4471.3 4577.9 89111.0 91714.1 92021.1 92177.0 92404.5 10442.3 10678.6 11025.3 11028.2 11274.5 21376.8 21715.2 21748.9 21750.9 21751.9 7453.1 7686.9 7694.1 7749.1 7750.2 3792.3 4264.5 4361.2 4385.8 4447.0 3408.6 3456.3 3476.7 3490.8 3500.5 633.3 636.4 648.6 656.0 656.6 546.0 583.6 617.9 653.3 654.6 8961.0 9957.8 10147.0 10214.2 10292.2 544.3 585.3 588.3 601.9 705.8 4471.0 4847.3 4999.5 5012.3 5040.8 91336.0 100626.0 102207.5 104235.0 105341.0 90440.0 90854.5 92037.1 92041.0 92521.0 58858.4 66306.7 78097.2 79748.6 81798.0 10801.0 10879.6 11111.9 11117.6 11146.4 44627.8 46872.5 48389.0 50699.0 50818.7 50119.7 63768.5 64510.7 65706.3 66288.0 10983.5 12879.4 13060.4 13230.3 13402.6 14615.3 14727.9 14931.0 14975.9 15357.2 13151.7 13687.9 13702.5 13724.6 13989.8 13407.6 13508.5 13808.3 14045.6 14223.9 10254.9 13371.5 13545.5 13663.0 13791.6 11281.4 11455.7 11734.5 11906.8 11940.0 10335.4 10785.2 11031.5 11041.1 11047.4 08:04:15 INFO - PROCESS | 1646 | -------- Summary: end -------- 08:04:15 INFO - PROCESS | 1646 | 08:04:15 INFO - TEST-INFO | 1646: exit 0 08:04:15 INFO - TEST-OK | dromaeo_css | took 1119455ms 08:04:15 INFO - TEST-START | kraken 08:04:15 INFO - operating with platform_type : mac_ 08:04:15 INFO - Initialising browser for kraken test... 08:04:15 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpxD9zMs/profile http://localhost:49243/getInfo.html) 08:04:18 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:04:18 INFO - PROCESS | 1652 | colorDepth:24 08:04:18 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:04:18 INFO - PROCESS | 1652 | __metrics 08:04:18 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:18 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:18 INFO - TEST-INFO | 1652: exit 0 08:04:18 INFO - Browser initialized. 08:04:18 INFO - Running cycle 1/1 for kraken test... 08:04:18 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpxD9zMs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:31 INFO - PROCESS | 1653 | RSS: Main: 226926592 08:04:31 INFO - PROCESS | 1653 | 08:04:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 08:04:34 INFO - PROCESS | 1653 | RSS: Main: 286842880 08:04:34 INFO - PROCESS | 1653 | 08:04:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 08:04:37 INFO - PROCESS | 1653 | RSS: Main: 288505856 08:04:37 INFO - PROCESS | 1653 | 08:04:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 08:04:41 INFO - PROCESS | 1653 | RSS: Main: 379486208 08:04:41 INFO - PROCESS | 1653 | 08:04:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 08:04:44 INFO - PROCESS | 1653 | RSS: Main: 285118464 08:04:44 INFO - PROCESS | 1653 | 08:04:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:47 INFO - PROCESS | 1653 | RSS: Main: 287670272 08:04:47 INFO - PROCESS | 1653 | 08:04:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:50 INFO - PROCESS | 1653 | RSS: Main: 329232384 08:04:50 INFO - PROCESS | 1653 | 08:04:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:53 INFO - PROCESS | 1653 | RSS: Main: 330661888 08:04:53 INFO - PROCESS | 1653 | 08:04:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 08:04:57 INFO - PROCESS | 1653 | RSS: Main: 327655424 08:04:57 INFO - PROCESS | 1653 | 08:04:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:59 INFO - PROCESS | 1653 | RSS: Main: 302510080 08:04:59 INFO - PROCESS | 1653 | 08:05:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:05:02 INFO - PROCESS | 1653 | RSS: Main: 306335744 08:05:02 INFO - PROCESS | 1653 | 08:05:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:05:04 INFO - PROCESS | 1653 | RSS: Main: 308076544 08:05:04 INFO - PROCESS | 1653 | 08:05:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:05:08 INFO - PROCESS | 1653 | RSS: Main: 326508544 08:05:08 INFO - PROCESS | 1653 | 08:05:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:05:12 INFO - PROCESS | 1653 | RSS: Main: 320954368 08:05:12 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 08:05:14 INFO - PROCESS | 1653 | RSS: Main: 364544000 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | __start_tp_report 08:05:14 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:05:14 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:05:14 INFO - PROCESS | 1653 | |i|pagename|runs| 08:05:14 INFO - PROCESS | 1653 | |0;ai-astar;112;114;115;114;114;116;115;114;113;115 08:05:14 INFO - PROCESS | 1653 | |1;audio-beat-detection;143;109;109;148;112;112;110;109;135;112 08:05:14 INFO - PROCESS | 1653 | |2;audio-dft;184;183;184;189;184;185;184;181;185;185 08:05:14 INFO - PROCESS | 1653 | |3;audio-fft;81;59;58;87;61;57;58;57;75;58 08:05:14 INFO - PROCESS | 1653 | |4;audio-oscillator;83;71;89;69;68;69;82;68;69;83 08:05:14 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;87;84;87;84;86;83;87;84;87;84 08:05:14 INFO - PROCESS | 1653 | |6;imaging-darkroom;96;97;96;96;95;96;108;97;96;97 08:05:14 INFO - PROCESS | 1653 | |7;imaging-desaturate;128;131;90;90;88;87;85;84;84;85 08:05:14 INFO - PROCESS | 1653 | |8;json-parse-financial;57;53;55;52;54;54;53;54;54;54 08:05:14 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;73;79;72;75;72;68;69;68;69;71 08:05:14 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;86;88;88;87;86;87;87;85;85;87 08:05:14 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;143;154;143;141;139;137;146;132;194;177 08:05:14 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;217;232;173;175;173;173;172;207;172;171 08:05:14 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;68;68;66;66;66;66;66;66;66 08:05:14 INFO - PROCESS | 1653 | __end_tp_report 08:05:14 INFO - PROCESS | 1653 | __start_cc_report 08:05:14 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1924 08:05:14 INFO - PROCESS | 1653 | __end_cc_report 08:05:14 INFO - PROCESS | 1653 | __startTimestamp1484755514277__endTimestamp 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:05:14 INFO - PROCESS | 1653 | Number of tests: 14 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.14 (1.0%) stddev-sans-first:0.88 08:05:14 INFO - PROCESS | 1653 | Values: 112.0 114.0 115.0 114.0 114.0 116.0 115.0 114.0 113.0 115.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:112.00 stddev:15.61 (13.9%) stddev-sans-first:14.14 08:05:14 INFO - PROCESS | 1653 | Values: 143.0 109.0 109.0 148.0 112.0 112.0 110.0 109.0 135.0 112.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:2.01 (1.1%) stddev-sans-first:2.13 08:05:14 INFO - PROCESS | 1653 | Values: 184.0 183.0 184.0 189.0 184.0 185.0 184.0 181.0 185.0 185.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.10 Median:60.00 stddev:11.39 (19.0%) stddev-sans-first:10.52 08:05:14 INFO - PROCESS | 1653 | Values: 81.0 59.0 58.0 87.0 61.0 57.0 58.0 57.0 75.0 58.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.50 stddev:8.13 (10.6%) stddev-sans-first:8.11 08:05:14 INFO - PROCESS | 1653 | Values: 83.0 71.0 89.0 69.0 68.0 69.0 82.0 68.0 69.0 83.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 08:05:14 INFO - PROCESS | 1653 | Values: 87.0 84.0 87.0 84.0 86.0 83.0 87.0 84.0 87.0 84.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:96.00 stddev:3.78 (3.9%) stddev-sans-first:3.97 08:05:14 INFO - PROCESS | 1653 | Values: 96.0 97.0 96.0 96.0 95.0 96.0 108.0 97.0 96.0 97.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:86.00 stddev:18.23 (21.2%) stddev-sans-first:14.98 08:05:14 INFO - PROCESS | 1653 | Values: 128.0 131.0 90.0 90.0 88.0 87.0 85.0 84.0 84.0 85.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.33 (2.5%) stddev-sans-first:0.87 08:05:14 INFO - PROCESS | 1653 | Values: 57.0 53.0 55.0 52.0 54.0 54.0 53.0 54.0 54.0 54.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:3.47 (4.8%) stddev-sans-first:3.64 08:05:14 INFO - PROCESS | 1653 | Values: 73.0 79.0 72.0 75.0 72.0 68.0 69.0 68.0 69.0 71.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:1.07 (1.2%) stddev-sans-first:1.12 08:05:14 INFO - PROCESS | 1653 | Values: 86.0 88.0 88.0 87.0 86.0 87.0 87.0 85.0 85.0 87.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:144.50 stddev:19.68 (13.6%) stddev-sans-first:20.68 08:05:14 INFO - PROCESS | 1653 | Values: 143.0 154.0 143.0 141.0 139.0 137.0 146.0 132.0 194.0 177.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.50 Median:174.00 stddev:23.00 (13.2%) stddev-sans-first:21.58 08:05:14 INFO - PROCESS | 1653 | Values: 217.0 232.0 173.0 175.0 173.0 173.0 172.0 207.0 172.0 171.0 08:05:14 INFO - PROCESS | 1653 | 08:05:14 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 08:05:14 INFO - PROCESS | 1653 | Values: 67.0 68.0 68.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 08:05:14 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:05:14 INFO - PROCESS | 1653 | 08:05:15 INFO - TEST-INFO | 1653: exit 0 08:05:15 INFO - TEST-OK | kraken | took 59250ms 08:05:15 INFO - SUITE-END | took 1178s 08:05:15 INFO - Completed test suite (00:19:38) 08:05:15 INFO - javascript benchmark 08:05:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.180920674435, 3346.3976484232835, 3347.7656564040512, 3375.9493607595873, 3418.5214070030183, 5501.944980550194, 5568.52667523261, 5632.0, 5659.094544872826, 5668.036433806253, 5611.887762244753, 5617.4382561743805, 5675.432456754323, 5704.828855134353, 5725.971370143154, 5042.571381432583, 5088.567471764904, 5100.0054989277105, 5138.434772175057, 5193.45468725784, 5256.947430525704, 5264.447233040533, 5267.23625074364, 5267.65760225586, 5315.548178404821, 5091.312672789163, 5232.2413250078525, 5247.9737601311745, 5249.317588713462, 5262.710550919698, 5139.254808052811, 5142.280080788655, 5197.402298735656, 5206.895862082737, 5228.8692782680355, 5132.076226279269, 5163.948360516384, 5190.299309593194, 5195.142801437796, 5237.397699264558, 5679.0, 5693.843792972871, 5702.429757024306, 5720.056190728525, 5771.105478650816, 6104.572679912408, 6116.305337586, 6130.04269582218, 6134.467201660894, 6246.531510136712, 6225.097360882647, 6246.250449946036, 6299.65351905645, 6302.401271879165, 6308.432241098278, 5790.0, 5816.70916454184, 5817.854553636193, 5828.446297601721, 5863.061910094407, 6184.783532576338, 6209.068639704081, 6272.560920735596, 6314.62112273265, 6315.621062736159, 5659.471942575482, 5724.856878577985, 6073.574849760563, 6091.725872335755, 6131.325554189036, 6140.815775526741, 6208.31757281354, 6240.375962403723, 6256.405641464054, 6266.373362663789, 6082.0876868469195, 6109.14471973924, 6122.062734707273, 6138.265785110792, 6177.938220617826, 6246.46905013079, 6257.217847769029, 6269.122322874801, 6281.434670879551, 6283.874322513524, 4847.224444088929, 4896.95103048972, 4899.2896030075435, 4899.412070551557, 4905.7301848397965, 4421.270490369117, 4427.247367947457, 4428.535003824552, 4433.866983990485, 4472.15029144468, 5802.013657678205, 5810.941890581124, 5823.505002074787, 5823.82528524145, 5825.155352473867, 6112.26032301701, 6194.101855231056, 6307.653079080603, 6310.432061114522, 6320.367963203643, 5746.626469279567, 5773.336066352424, 5806.564507661942, 5839.0949402842625, 5851.327097383855, 5410.972945135328, 5415.891682166334, 5425.240466334716, 5429.294191755125, 5429.972850135803, 6253.343398943137, 6255.937440625536, 6285.5600107992, 6306.621602703853, 6328.0824280478155, 6145.6927153641245, 6178.382161783786, 6193.81418557444, 6221.595596286227, 6245.7189426476825, 6243.687815609293, 6258.843528911631, 6261.3112557617715, 6268.435840774352, 6276.309605943434, 6167.6916154193, 6196.318404975359, 6197.25632924052, 6198.907016394667, 6202.534809889186, 6107.27984577779, 6158.137860699416, 6188.783392581238, 6194.81415557534, 6199.0, 4807.6153907688, 5772.9031484017905, 6130.111133885473, 6144.03390914903, 6157.599756016024, 5944.3164036136395, 6005.939940600713, 6013.699315034319, 6100.8779824404155, 6146.293176284606, 5733.770649173986, 5775.48020678141, 5846.035404158266, 5853.94146058534, 5877.324107727666, 5950.851228719317, 6005.039193728982, 6014.1580178775885, 6086.573939824347, 6106.0, 5868.970655146697, 5876.676782776988, 5890.558208134493, 5972.223610930551, 6006.459418652343], "value": 5678.585398785383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.7470392468444, 494.38202247190986, 495.45005044400733, 519.2704250528008, 522.2505704314309, 23270.364817591206, 39100.41349379761, 40178.99552511189, 40470.595294047125, 40542.18915621686, 41476.17047659045, 41754.16491670165, 41800.163996720046, 41850.0, 41864.162716745726, 9227.907720922789, 9454.385464944757, 9462.668806591771, 9464.1009104135, 9472.336936414455, 8373.07896131425, 8593.699220527284, 11011.724706882313, 11263.943680281587, 11328.943355283212, 11277.492512836941, 11299.0, 11370.14723895707, 11384.658460246206, 11385.032272256869, 8413.579321033923, 11214.551417943272, 11301.830472542919, 11315.717107072307, 11334.886651133465, 8325.750227493185, 10889.183311251609, 11157.66527004191, 11204.271722338022, 11297.435128243555, 39297.017574560865, 39677.0, 39752.60247397547, 39758.80120599378, 39802.80098599517, 4052.1490486997764, 4069.4302797608357, 4071.185762847442, 4095.0, 4234.280172370673, 29125.271868203254, 29643.55534666982, 30119.247018824484, 30143.397132057456, 30188.0, 3162.5256211568217, 3240.416724989501, 3332.6500717424565, 3332.800031998088, 3336.2660214752714, 368222.0, 372434.0, 373965.0, 375517.448255175, 375855.0, 56248.15627765587, 56794.43205567892, 56872.146917796264, 56873.715631422405, 56902.14646780219, 59639.40360596425, 59757.0, 59803.401965979785, 59812.401875980686, 59834.70082649559, 15553.0, 15812.446564370191, 15818.0, 15852.841471585367, 15885.841141588668, 11011.669649910515, 11356.034737047443, 12251.264924104404, 12339.93830030844, 12352.814707779391, 13625.18248905049, 13689.452421903212, 13937.163770173822, 14988.651021407908, 15285.847141528664, 5232.895342093213, 6019.307779605314, 6083.330833608299, 6094.360092190256, 6121.724522396503, 843.4896887383168, 858.6822875535967, 867.2671592504324, 867.297489033872, 896.1576118448637, 29169.56245656317, 29429.822807087905, 29486.410271794874, 30035.849820751195, 30067.849660751555, 1038.672818062308, 1054.1303424674675, 1058.8517607534952, 1092.7104317355906, 1097.8847221041676, 14659.780103298459, 15044.097354158786, 15138.318775655121, 15357.078575285519, 15484.845151548341, 622163.0, 628771.6912555115, 629029.0, 630848.0, 631891.0, 57529.84940301171, 57820.0, 57870.0, 57871.0, 57881.71059144761, 1431.1270125223605, 1445.6096853849401, 1445.8337291211224, 1448.16730380034, 1460.2041887171517, 27661.0, 28336.716632833406, 29131.0, 29165.416691666473, 29206.7079329204, 45637.31544026776, 48455.75772121117, 49084.77288067827, 49161.01677966492, 51685.7415712919, 561691.0, 569511.0, 570320.0, 570396.0, 571557.0, 23718.762812372344, 24071.157509487082, 24072.39819004469, 24127.155549556384, 24175.395615109763, 34030.31939361248, 39811.40282895817, 41508.792456037525, 41768.791156044026, 44026.03765660978, 35144.121396964256, 35207.64792352044, 35433.82283088568, 36324.63675363318, 36508.45237321389, 24451.877740611184, 34809.65190348165, 35461.0, 35847.82076089603, 36587.63412365842, 34331.970040898814, 34396.48405273873, 34891.9532414028, 34986.65013349834, 35259.589616415054, 29540.409191815612, 32677.019689409357, 32709.509357360133, 32791.67208327982, 32818.50772238466, 21396.465088372915, 23065.308040758806, 23276.76723232746, 23912.88043559771, 24285.271441856774], "value": 19185.884801951604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.84940099259774, 389.26429049097203, 390.97849618270993, 395.2569169960474, 424.1432306740385, 15275.00712453691, 15408.84591154088, 18592.814071859262, 21082.89458552709, 21128.683069753966, 21294.984132053243, 21427.250046248384, 21922.780772192273, 21952.902354882273, 22378.55242895145, 5847.26909136358, 5929.851753706149, 5954.553408494358, 6032.66820324882, 6091.14723938649, 4201.558836322172, 4413.58070983256, 5812.593118481687, 5966.67183304918, 5971.552133589977, 6368.936310636904, 6674.1323627928305, 6678.0, 6752.527323087385, 6772.356626120511, 6497.415232629086, 6682.732690692366, 6712.56368336059, 6741.797746067626, 6744.325567443266, 5648.3222013358245, 5866.2960444746905, 5871.706414679249, 5879.882402351972, 5892.823215303548, 22704.65943010856, 22890.65664015041, 23180.18869339565, 25258.74741252601, 26163.476730465285, 2707.539718247903, 2720.8095433319677, 2722.414680843628, 2729.3858881751644, 2730.808843380964, 13722.245276509788, 15215.087094774239, 15550.455734049367, 15730.0, 16586.336546538125, 1826.8629852761096, 1867.030059482357, 1869.140195510067, 1870.6819840627127, 1885.198790514026, 112985.87014129918, 115634.0, 115667.0, 116684.0, 116762.8323716769, 11355.886441135648, 11364.94317528407, 11498.25261358009, 11512.481938312796, 11624.767504649859, 14453.421863125357, 14459.710805783825, 14477.638059048397, 14489.855101449062, 14507.274636268145, 8524.190201930807, 8662.566871656392, 8708.521031343336, 8736.78158046054, 8813.911860881437, 7772.961135194288, 7975.84048319042, 8547.922747810782, 8714.302855771522, 8734.213920747163, 7010.018597396369, 7126.287371262936, 7154.069970903749, 7161.212266650664, 7164.570125792469, 1586.8095828500655, 1900.9524761881064, 1901.4010586665156, 1904.200235900925, 1913.5598812272976, 1009.9646512372032, 1012.964546240878, 1017.7201269650906, 1025.6974192613047, 1051.695008447557, 21330.680039799416, 21660.56678866414, 21878.89060554687, 21988.450288742588, 22147.335579932627, 895.9372843900865, 1034.4414016431042, 1050.7005503431485, 1057.2757661002238, 1057.8889216632297, 10358.844617330746, 11158.489339898459, 11326.377049262204, 12041.578544750892, 12222.694432639255, 438853.0, 540651.5934840679, 732447.0, 742936.0, 743428.0, 133384.0, 135203.0, 140482.1903561923, 144356.27821860823, 151752.2412387931, 1043.7683533430472, 1054.2409465185056, 1089.2865173311493, 1099.5272033025876, 1109.7003808971533, 18215.80849457898, 20017.796262784977, 20021.399358019284, 20076.297329593395, 20102.39692809218, 58810.41189588049, 59166.0, 59523.107153391866, 59958.10062849148, 60986.0, 85396.0, 88049.55975220083, 88341.67487487564, 89246.0, 91489.0, 8074.111847696866, 8171.346292296483, 8364.289035432057, 8450.0, 8589.828203436022, 9359.812803744024, 13046.54337098197, 13256.93371533136, 13466.528671496842, 13512.324383780575, 11045.171612128961, 11404.828927565926, 11443.542258309575, 11478.94260528692, 11521.292496263204, 11116.055135313265, 11134.27627204229, 11359.48882300282, 11509.02173315244, 11516.82724759146, 5855.9121613176685, 7676.501027433199, 10172.338797978107, 11572.826407603725, 11834.408279585814, 6735.461163106842, 7029.437644988287, 8286.544240066612, 8451.577421128795, 8602.741917742478, 10020.498975051363, 10417.583296668048, 11012.063974562252, 11452.14108941816, 11696.590619328623], "value": 10063.475463879793, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.6861290516083, 1434.8923830712695, 1438.6331485471203, 1447.421031587365, 1449.3477934929278, 8050.3157231635305, 8446.873296900543, 8452.577371131449, 8475.83048339033, 8491.193336633025, 6285.528585356094, 7632.198619144993, 7632.542047477155, 7949.523028618287, 8255.42212045157, 1976.179885347579, 2305.3429772514837, 2319.698439202901, 2321.8042708005305, 2326.5579539887453, 2289.347535952254, 2322.0711715313923, 2330.2193765088714, 2331.1258278145697, 2337.555864385761, 2032.227753453693, 2109.4093653776968, 2287.0623044551735, 2304.4238940264936, 2310.503241803012, 2220.566989437052, 2295.896684649186, 2296.1045192374986, 2297.0811675329833, 2298.3909264044873, 2253.58308712887, 2300.988495057514, 2304.976950230493, 2311.5030268492187, 2331.160782118436, 8328.167183281685, 8404.28563572091, 8405.957970210171, 8422.620982055761, 8444.788880277982, 5062.190049592047, 5219.739013049332, 5220.556252718524, 5225.608079394023, 5228.320318358627, 3303.5629501166827, 3323.7507186961075, 3356.580427446569, 3510.7542472026967, 3592.299931071001, 1182.722060315825, 1189.173524400542, 1217.1419149499582, 1266.2972050511962, 1268.517963173988, 10714.73213169677, 10744.409057501913, 10760.13918886495, 10762.784744305149, 10774.515146818334, 4470.307102399133, 4597.586217240464, 4642.396488456479, 4694.718316900997, 4714.010057887814, 7424.294692004251, 8615.39692221551, 8688.174623410765, 8691.95654021726, 8731.869021964676, 5146.536811686966, 5148.3564554430695, 5148.407933087743, 5148.56237219833, 5150.381954165449, 4326.63223625989, 4760.928586071212, 4833.468318484964, 4835.298881662139, 4835.443923948791, 3564.091156755011, 3626.655467730561, 3646.2525182338086, 3668.614795446493, 3701.0747313171705, 972.7179118055826, 1116.1126904111252, 1160.4197901049474, 1162.2910024884814, 1168.8714241433436, 810.3679130278392, 839.8572242718752, 893.6425429827991, 926.2960150285832, 927.1701826864918, 5146.459621739738, 5254.264402983586, 5558.583106267046, 5910.970445147746, 5933.792317268962, 935.2471260635118, 959.7504648791225, 970.0638883477478, 974.4202199691173, 1004.5730564510054, 3451.5858097028517, 3470.408127587985, 3617.638236176414, 3620.7103431725927, 3686.4838922550866, 9624.3744156631, 9664.661736839176, 9961.203103751683, 9980.351277167107, 9981.251406144569, 9596.328257021942, 9609.47147906858, 9639.759006024906, 9859.556319965619, 10031.749206269757, 5239.842804715865, 7490.6629201686055, 7491.026166598416, 7730.806729831686, 7903.288704016666, 4750.738709370879, 5575.944240557543, 5622.718864056863, 5631.900865835279, 5647.463490968352, 8780.0, 8909.73270801877, 9257.490838003974, 9306.0, 9313.115254050854, 8442.178087910865, 9053.139951704577, 9469.242460603273, 9511.096445837635, 9525.714228573153, 5981.431763982415, 7183.102112235971, 7183.5330703504105, 7268.96365518169, 7289.4168466523615, 7793.610319484116, 7891.84216315659, 7944.165862584346, 7973.601319933864, 8043.396745244013, 7107.928920710727, 7144.3570078693165, 7172.677229524579, 7206.135263768381, 7227.530210536298, 6675.933240667531, 6900.7929762107215, 6968.825779355557, 7050.858982820418, 7071.328223818729, 6270.059491076375, 6382.36176382358, 6384.9042264367, 6386.90419643715, 6403.167588213502, 4825.758712064453, 4832.468428472936, 4976.800927962986, 4993.925091123709, 5191.32512773337, 4827.444843843003, 4956.529129732669, 4980.950190498049, 5018.473060328759, 5107.799667078308], "value": 4349.253801907993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.37812018028535, 362.1471434771114, 367.1225770408724, 377.99055023624425, 378.89201577550403, 4929.630277729171, 5074.441811400743, 5229.450907654698, 5293.6294459387855, 5371.75827087781, 4472.489096059594, 4934.827281045164, 5142.974285128578, 5191.5846732261425, 5192.3249977502965, 3645.489631451599, 3887.8250478728523, 4084.4690190275223, 4101.405296232045, 4116.991337122402, 3456.5160877477174, 4128.422020917074, 4133.0035724099935, 4133.987173142585, 4148.875533733993, 3938.72428929975, 3971.86098486553, 3984.8605298814546, 3987.900302492432, 3988.7407318524347, 3154.936901261985, 3786.3563194256767, 3863.98068009661, 3959.663428608572, 4000.959990400088, 2828.8019838611303, 3024.123004328742, 3351.916202094943, 3404.3872103021445, 3552.7335449841366, 3959.2873282809082, 4959.008198360342, 5062.0, 5125.488510629764, 5141.820036298712, 3953.762774233526, 4495.617872480843, 4559.381419596062, 4559.886002849922, 4581.5647513486165, 5542.612017158801, 5562.3591040642705, 5563.499285064323, 5637.182608521783, 5662.716864156776, 3397.6432474590306, 3663.816809159531, 3803.448499967489, 3853.997960530254, 3861.3049651062797, 4642.814287428465, 5339.716074614084, 5734.254546908875, 5756.683382413966, 5780.88438231233, 3828.770273783582, 3833.789141597239, 3852.2295540891932, 3852.9614703852603, 3862.748921320105, 3892.9610703893163, 3909.2181563687377, 3917.2557214129224, 3926.9607303926596, 3931.1916518401285, 4289.549597292302, 4478.305862591304, 4495.9325610115875, 4508.81964721414, 4547.386102876069, 4866.878328041827, 5333.799895023666, 5563.972180139073, 5569.749361278752, 5598.328200615871, 1091.7761858818924, 1150.6192568917165, 1191.70803153228, 1192.7197108679454, 1247.5820600098887, 756.6557216466495, 842.439777547936, 870.2037635563515, 870.7243887704543, 879.4679219072497, 4434.600885920283, 4587.9541204588195, 4593.563611456906, 4862.586680132228, 4922.507749225048, 4879.194228501774, 4919.434265059493, 5201.271821944931, 5415.48552887475, 5432.91850622241, 3960.960390396059, 4050.1697152083752, 4158.0, 4315.396643802397, 4762.52374762521, 2530.3041663542303, 2651.764846886795, 2678.25008997481, 2768.5465130806488, 2839.361143742641, 4684.718916864999, 5361.825838066285, 5396.815878631626, 5465.508104270635, 5563.36021357541, 4490.640748740093, 5724.885502289931, 5758.539316854642, 5868.823935281948, 5917.408259174048, 5610.551155907436, 5873.765049398062, 5905.940940590539, 5956.612820166675, 6026.638401695912, 5028.34631497903, 5489.0, 5620.85947851307, 5640.7001903886685, 5713.314402271754, 5304.575633949352, 5491.28613280271, 5604.85987850307, 5615.606907516435, 5693.9430605693415, 5559.0, 5685.658860468385, 5913.215542053175, 5948.256467941507, 5952.523798096228, 3675.7426980111136, 3747.6015350176453, 4100.917981640291, 4133.359329303963, 4173.227952828736, 5102.413222479314, 5454.290942177491, 5758.193852860687, 5769.624974376652, 5792.522906658944, 4689.7655117244685, 4698.976505117453, 5267.3152490176035, 5628.410930971799, 5639.379668236573, 4735.337052812678, 5120.487951204998, 5198.610104242272, 5587.0, 5588.273524441796, 5046.924296135634, 5164.561012313845, 5332.33345831771, 5354.411014788292, 5466.808661696821, 4807.879803004953, 4904.460509343898, 5456.863578410413, 5490.423505531861, 5609.971950140223, 4447.132809102194, 4748.525147485224, 5461.590380721541, 5473.343198816167, 5529.815722789556], "value": 3997.6589722902017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.4280546965163, 731.1847290271346, 747.5103807006411, 766.3256334425705, 869.1135042256898, 12105.697357566065, 13617.863821361783, 13735.17588944664, 16032.957857739239, 16090.51728448147, 12466.314352710597, 14459.20474373909, 14500.0, 14837.109773413602, 14847.628809279773, 853.7225401744427, 874.6107981948036, 880.2429910277189, 881.3610132653806, 882.5940067568926, 698.3784431855653, 721.5093736259341, 856.297835774665, 887.6493784954939, 892.6027917576681, 929.2705226397279, 931.1340453378356, 931.5575101826646, 934.2992755433424, 935.5322338830584, 918.9264858811279, 924.9825192288496, 929.9163075323186, 929.9442033477945, 932.2122806228726, 528.643165863041, 545.8444343362163, 668.2782594797607, 685.0170006041346, 687.7970998555388, 15461.149636769973, 15490.690186196212, 15510.302036408277, 15516.456924007605, 15518.224088795629, 13734.65663358414, 13744.65638359039, 13766.65583360414, 13869.653258668513, 13882.4447022119, 12547.686307842378, 12720.300383478905, 12786.232826030468, 12801.807972880415, 13085.672858178526, 4391.341298805173, 4398.8020539075815, 4415.094905544356, 4471.329300604935, 4577.862664120082, 89111.0, 91714.08285917122, 92021.07978920192, 92177.0, 92404.53797730968, 10442.269041167197, 10678.62624808128, 11025.283356581796, 11028.172887033505, 11274.463245769637, 21376.824274665043, 21715.23996660141, 21748.89125554362, 21750.89124554367, 21751.891240543697, 7453.142888567776, 7686.884696729554, 7694.07671079474, 7749.070111586533, 7750.224977502317, 3792.3173828710546, 4264.466941632296, 4361.214981303332, 4385.846495372647, 4447.043885564619, 3408.642092580293, 3456.343294773985, 3476.7392445566684, 3490.7905525668543, 3500.5099286099967, 633.2527617411498, 636.3541005879036, 648.6108334999058, 655.9639219842954, 656.6224420957873, 545.9945400546023, 583.6264790534061, 617.8733359661259, 653.3074940563018, 654.5745265577318, 8960.955195223982, 9957.80084398308, 10147.0, 10214.182865370902, 10292.176625869912, 544.2786069651742, 585.2976428286074, 588.2822955993681, 601.9187409699634, 705.7670968580459, 4470.977645111753, 4847.297141914402, 4999.475055119233, 5012.298278241049, 5040.798368065236, 91336.0, 100626.0, 102207.48896255619, 104235.0, 105341.0, 90440.0, 90854.54572727095, 92037.07962920419, 92041.0, 92521.0, 58858.41141588529, 66306.66846665736, 78097.21902781013, 79748.6012569945, 81798.0, 10801.02790748805, 10879.619213327496, 11111.944440277746, 11117.610883619034, 11146.442677866236, 44627.77686111549, 46872.53127468818, 48389.0, 50699.0, 50818.74590627023, 50119.74940125276, 63768.53620246538, 64510.67744661247, 65706.34293657193, 66288.0, 10983.50574224146, 12879.420426081037, 13060.412281447549, 13230.338483076, 13402.597922062354, 14615.34230959588, 14727.852721473077, 14931.0, 14975.850241497881, 15357.232138392812, 13151.671208219872, 13687.863121369057, 13702.45190192381, 13724.588262352145, 13989.790153147915, 13407.597772066854, 13508.527201547899, 13808.309584520935, 14045.595440456282, 14223.857761422254, 10254.948725256327, 13371.465141394236, 13545.458181672622, 13662.975276854077, 13791.586252412444, 11281.379524126252, 11455.656330310105, 11734.458826851438, 11906.821397679216, 11940.0, 10335.379877207391, 10785.245032847626, 11031.503582338975, 11041.06150977176, 11047.447627618427], "value": 7464.6322683212475, "unit": "score"}], "name": "dromaeo_css", "value": 7225.610270569481, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 114.0, 114.0, 116.0, 115.0, 114.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 109.0, 148.0, 112.0, 112.0, 110.0, 109.0, 135.0, 112.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 184.0, 189.0, 184.0, 185.0, 184.0, 181.0, 185.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 87.0, 61.0, 57.0, 58.0, 57.0, 75.0, 58.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 89.0, 69.0, 68.0, 69.0, 82.0, 68.0, 69.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 83.0, 87.0, 84.0, 87.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 108.0, 97.0, 96.0, 97.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 90.0, 90.0, 88.0, 87.0, 85.0, 84.0, 84.0, 85.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 55.0, 52.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 72.0, 75.0, 72.0, 68.0, 69.0, 68.0, 69.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 88.0, 87.0, 86.0, 87.0, 87.0, 85.0, 85.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 154.0, 143.0, 141.0, 139.0, 137.0, 146.0, 132.0, 194.0, 177.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 232.0, 173.0, 175.0, 173.0, 173.0, 172.0, 207.0, 172.0, 171.0], "value": 186.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1452.3999999999999, "alertThreshold": 2.0}]} 08:05:15 INFO - Return code: 0 08:05:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:05:15 ERROR - # TBPL SUCCESS # 08:05:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:05:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:05:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:05:15 INFO - 2017-01-18 08:05:15.583 screenresolution[1657:9848] starting screenresolution argv=screenresolution get 08:05:15 INFO - 2017-01-18 08:05:15.586 screenresolution[1657:9848] Display 0: 1600x1200x32@60 08:05:15 INFO - 2017-01-18 08:05:15.593 screenresolution[1658:9851] starting screenresolution argv=screenresolution list 08:05:15 INFO - Available Modes on Display 0 08:05:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:05:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:05:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:05:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:05:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:05:15 INFO - Intel Iris: 08:05:15 INFO - Chipset Model: Intel Iris 08:05:15 INFO - Type: GPU 08:05:15 INFO - Bus: Built-In 08:05:15 INFO - VRAM (Dynamic, Max): 1536 MB 08:05:15 INFO - Vendor: Intel (0x8086) 08:05:15 INFO - Device ID: 0x0a2e 08:05:15 INFO - Revision ID: 0x0009 08:05:15 INFO - Displays: 08:05:15 INFO - Display: 08:05:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:05:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:05:15 INFO - Display Serial Number: 1600x1200 60 08:05:15 INFO - Main Display: Yes 08:05:15 INFO - Mirror: Off 08:05:15 INFO - Online: Yes 08:05:15 INFO - Rotation: Supported 08:05:15 INFO - Return code: 0 08:05:15 INFO - Running post-action listener: _resource_record_post_action 08:05:15 INFO - [mozharness: 2017-01-18 16:05:15.828659Z] Finished run-tests step (success) 08:05:15 INFO - Running post-run listener: _resource_record_post_run 08:05:15 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38581248; Write bytes: 549115392; Read time: 379; Write time: 1578 08:05:15 INFO - TinderboxPrint: CPU usage
53.8% 08:05:15 INFO - TinderboxPrint: I/O read bytes / time
38,581,248 / 379 08:05:15 INFO - TinderboxPrint: I/O write bytes / time
549,115,392 / 1,578 08:05:15 INFO - TinderboxPrint: CPU idle
2,217.8 (46.1%) 08:05:15 INFO - TinderboxPrint: CPU system
962.8 (20.0%) 08:05:15 INFO - TinderboxPrint: CPU user
1,625.1 (33.8%) 08:05:15 INFO - TinderboxPrint: Swap in / out
288,870,400 / 0 08:05:15 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252242432; Write bytes: 238522368; Read time: 18199; Write time: 405 08:05:15 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31185920; Write bytes: 295888384; Read time: 284; Write time: 1140 08:05:16 INFO - Running post-run listener: _upload_blobber_files 08:05:16 INFO - Blob upload gear active. 08:05:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:05:16 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 08:05:16 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'] 08:05:16 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 08:05:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:05:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:05:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:05:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:17 INFO - (blobuploader) - INFO - Done attempting. 08:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:05:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:19 INFO - (blobuploader) - INFO - Done attempting. 08:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:20 INFO - (blobuploader) - INFO - Done attempting. 08:05:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:05:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:22 INFO - (blobuploader) - INFO - Done attempting. 08:05:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:22 INFO - Return code: 0 08:05:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc78f3ee4006476e684a9f8c2cac5ffc28b0bd71bbedc41c6be03627ba3004121dabc80876e2406ba803b83941ab4bbbb7edfc7d20ffde1d904c832dbb64d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dfc52c8af57533efc380d27b06ccf3827963f9fae1bb3b45cde6342b149fcf98df81a77a2bc54a5ac878b26d3778c8f99aa540ff2e8a3b24f4e4b9cf163698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1e202cf4fc1ac2889279238b8adc4edd3de910c014ed8ea08fcfce00c7b59f75e45a77c79a6c5ad7784f3960641e7af788975866d85c57a2e494287b545fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0734c2af1ed6a24887380fd4b6688bf64a208b9974fe18da9555b19e082b1c8653b7c2a5da681ddd42b15c836809661d854cdb9a43cec140a431604bb277af84"} 08:05:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:22 INFO - Contents: 08:05:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc78f3ee4006476e684a9f8c2cac5ffc28b0bd71bbedc41c6be03627ba3004121dabc80876e2406ba803b83941ab4bbbb7edfc7d20ffde1d904c832dbb64d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dfc52c8af57533efc380d27b06ccf3827963f9fae1bb3b45cde6342b149fcf98df81a77a2bc54a5ac878b26d3778c8f99aa540ff2e8a3b24f4e4b9cf163698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1e202cf4fc1ac2889279238b8adc4edd3de910c014ed8ea08fcfce00c7b59f75e45a77c79a6c5ad7784f3960641e7af788975866d85c57a2e494287b545fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0734c2af1ed6a24887380fd4b6688bf64a208b9974fe18da9555b19e082b1c8653b7c2a5da681ddd42b15c836809661d854cdb9a43cec140a431604bb277af84"} 08:05:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:05:22 INFO - Copying logs to upload dir... 08:05:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:05:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.636093 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-18 08:05:23.054009) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:05:23.057110) ========= 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.nKLiA4NObO/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.Olhe9TONSv/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/6cc78f3ee4006476e684a9f8c2cac5ffc28b0bd71bbedc41c6be03627ba3004121dabc80876e2406ba803b83941ab4bbbb7edfc7d20ffde1d904c832dbb64d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dfc52c8af57533efc380d27b06ccf3827963f9fae1bb3b45cde6342b149fcf98df81a77a2bc54a5ac878b26d3778c8f99aa540ff2e8a3b24f4e4b9cf163698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1e202cf4fc1ac2889279238b8adc4edd3de910c014ed8ea08fcfce00c7b59f75e45a77c79a6c5ad7784f3960641e7af788975866d85c57a2e494287b545fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0734c2af1ed6a24887380fd4b6688bf64a208b9974fe18da9555b19e082b1c8653b7c2a5da681ddd42b15c836809661d854cdb9a43cec140a431604bb277af84"} build_url:https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/aePGL6mUSJ2ysf9uKJDKxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc78f3ee4006476e684a9f8c2cac5ffc28b0bd71bbedc41c6be03627ba3004121dabc80876e2406ba803b83941ab4bbbb7edfc7d20ffde1d904c832dbb64d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dfc52c8af57533efc380d27b06ccf3827963f9fae1bb3b45cde6342b149fcf98df81a77a2bc54a5ac878b26d3778c8f99aa540ff2e8a3b24f4e4b9cf163698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1e202cf4fc1ac2889279238b8adc4edd3de910c014ed8ea08fcfce00c7b59f75e45a77c79a6c5ad7784f3960641e7af788975866d85c57a2e494287b545fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0734c2af1ed6a24887380fd4b6688bf64a208b9974fe18da9555b19e082b1c8653b7c2a5da681ddd42b15c836809661d854cdb9a43cec140a431604bb277af84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:05:23.092296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:05:23.092673) ========= 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.nKLiA4NObO/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.Olhe9TONSv/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005187 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:05:23.141728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:05:23.142100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:05:23.142467) ========= ========= Total master_lag: 0.33 =========