builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0146 starttime: 1481940258.14 results: success (0) buildid: 20161216162449 builduid: 208603212d1844e3bc21d2f87b4fef9f revision: 119f24606f99d82c6539763a778bb24f9df28037 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.141418) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.141853) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.142146) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.169732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.170109) ========= 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.SjreX73uBq/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.pk3PdmhtBI/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 --2016-12-16 18:04:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-12-16 18:04:18 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.323542) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.323869) ========= 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.SjreX73uBq/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.pk3PdmhtBI/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.027273 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:18.374550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-12-16 18:04:18.374928) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 119f24606f99d82c6539763a778bb24f9df28037 --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 119f24606f99d82c6539763a778bb24f9df28037 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SjreX73uBq/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.pk3PdmhtBI/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 2016-12-16 18:04:18,470 truncating revision to first 12 chars 2016-12-16 18:04:18,470 Setting DEBUG logging. 2016-12-16 18:04:18,471 attempt 1/10 2016-12-16 18:04:18,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/119f24606f99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 18:04:20,600 unpacking tar archive at: mozilla-central-119f24606f99/testing/mozharness/ program finished with exit code 0 elapsedTime=2.409922 ========= master_lag: 2.88 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-12-16 18:04:23.663456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:23.663791) ========= script_repo_revision: 119f24606f99d82c6539763a778bb24f9df28037 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:23.664185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:23.664460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 18:04:23.759169) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-16 18:04:23.759547) ========= /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.SjreX73uBq/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.pk3PdmhtBI/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:04:23 INFO - MultiFileLogger online at 20161216 18:04:23 in /builds/slave/test 18:04:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:04:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:23 INFO - {'append_to_log': False, 18:04:23 INFO - 'base_work_dir': '/builds/slave/test', 18:04:23 INFO - 'blob_upload_branch': 'Firefox', 18:04:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:23 INFO - 'branch': 'Firefox', 18:04:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:23 INFO - 'config_files': ('talos/mac_config.py',), 18:04:23 INFO - 'default_actions': ('clobber', 18:04:23 INFO - 'read-buildbot-config', 18:04:23 INFO - 'download-and-extract', 18:04:23 INFO - 'populate-webroot', 18:04:23 INFO - 'create-virtualenv', 18:04:23 INFO - 'install', 18:04:23 INFO - 'run-tests'), 18:04:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:23 INFO - 'download_minidump_stackwalk': True, 18:04:23 INFO - 'download_symbols': 'ondemand', 18:04:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:23 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:23 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:23 INFO - 'installer_path': 'installer.exe', 18:04:23 INFO - 'log_level': 'info', 18:04:23 INFO - 'log_name': 'talos', 18:04:23 INFO - 'log_to_console': True, 18:04:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:04:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:04:23 INFO - 'opt_config_files': (), 18:04:23 INFO - 'pip_index': False, 18:04:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:23 INFO - 'cmd': ('bash', 18:04:23 INFO - '-c', 18:04:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:23 INFO - 'enabled': True, 18:04:23 INFO - 'halt_on_failure': False, 18:04:23 INFO - 'name': 'check_screen_resolution'},), 18:04:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:23 INFO - 'cmd': ('bash', 18:04:23 INFO - '-c', 18:04:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:23 INFO - 'enabled': True, 18:04:23 INFO - 'halt_on_failure': False, 18:04:23 INFO - 'name': 'check_screen_resolution'},), 18:04:23 INFO - 'run_cmd_checks_enabled': True, 18:04:23 INFO - 'sps_profile': False, 18:04:23 INFO - 'sps_profile_interval': 0, 18:04:23 INFO - 'suite': 'dromaeojs', 18:04:23 INFO - 'system_bits': '32', 18:04:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:23 INFO - 'title': 't-yosemite-r7-0146', 18:04:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:23 INFO - 'use_talos_json': True, 18:04:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:23 INFO - 'work_dir': 'build'} 18:04:23 INFO - [mozharness: 2016-12-17 02:04:23.969443Z] Running clobber step. 18:04:23 INFO - Running pre-action listener: _resource_record_pre_action 18:04:23 INFO - Running main action method: clobber 18:04:23 INFO - rmtree: /builds/slave/test/build 18:04:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:26 INFO - Running post-action listener: _resource_record_post_action 18:04:26 INFO - [mozharness: 2016-12-17 02:04:26.491602Z] Finished clobber step (success) 18:04:26 INFO - [mozharness: 2016-12-17 02:04:26.491874Z] Running read-buildbot-config step. 18:04:26 INFO - Running pre-action listener: _resource_record_pre_action 18:04:26 INFO - Running main action method: read_buildbot_config 18:04:26 INFO - Using buildbot properties: 18:04:26 INFO - { 18:04:26 INFO - "project": "", 18:04:26 INFO - "product": "firefox", 18:04:26 INFO - "script_repo_revision": "production", 18:04:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:04:26 INFO - "repository": "", 18:04:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:04:26 INFO - "buildid": "20161216162449", 18:04:26 INFO - "pgo_build": "False", 18:04:26 INFO - "basedir": "/builds/slave/test", 18:04:26 INFO - "buildnumber": 56, 18:04:26 INFO - "slavename": "t-yosemite-r7-0146", 18:04:26 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:04:26 INFO - "platform": "yosemite_r7", 18:04:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:04:26 INFO - "branch": "mozilla-central", 18:04:26 INFO - "repo_path": "mozilla-central", 18:04:26 INFO - "revision": "119f24606f99d82c6539763a778bb24f9df28037", 18:04:26 INFO - "stage_platform": "macosx64", 18:04:26 INFO - "builduid": "208603212d1844e3bc21d2f87b4fef9f", 18:04:26 INFO - "slavebuilddir": "test" 18:04:26 INFO - } 18:04:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:04:26 INFO - Running post-action listener: _resource_record_post_action 18:04:26 INFO - [mozharness: 2016-12-17 02:04:26.497405Z] Finished read-buildbot-config step (success) 18:04:26 INFO - [mozharness: 2016-12-17 02:04:26.497566Z] Running download-and-extract step. 18:04:26 INFO - Running pre-action listener: _resource_record_pre_action 18:04:26 INFO - Running main action method: download_and_extract 18:04:26 INFO - mkdir: /builds/slave/test/build/tests 18:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:26 INFO - trying https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:04:26 INFO - Downloading https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/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 18:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/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 18:04:27 INFO - Downloaded 1199 bytes. 18:04:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:04:27 INFO - Using the following test package requirements: 18:04:27 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:04:27 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:04:27 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:04:27 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'jsshell-mac.zip'], 18:04:27 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:04:27 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:04:27 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:04:27 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:04:27 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:04:27 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:04:27 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:04:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:04:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:04:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:04:27 INFO - Fetch https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:04:28 INFO - Expected file size: 16277925 18:04:28 INFO - Obtained file size: 16277925 18:04:35 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 18:04:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:04:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:04:35 INFO - Fetch https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:04:36 INFO - Expected file size: 16277925 18:04:36 INFO - Obtained file size: 16277925 18:04:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:04:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:04:43 INFO - Fetch https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:04:44 INFO - Expected file size: 14409734 18:04:44 INFO - Obtained file size: 14409734 18:04: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')]} 18:04:44 INFO - trying https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:04:44 INFO - Downloading https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/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 18:04:46 INFO - Downloaded 69568520 bytes. 18:04:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:04:46 INFO - mkdir: /builds/slave/test/properties 18:04:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:04:46 INFO - Writing to file /builds/slave/test/properties/build_url 18:04:46 INFO - Contents: 18:04:46 INFO - build_url:https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:04:47 INFO - Running post-action listener: _resource_record_post_action 18:04:47 INFO - Running post-action listener: set_extra_try_arguments 18:04:47 INFO - [mozharness: 2016-12-17 02:04:47.038836Z] Finished download-and-extract step (success) 18:04:47 INFO - [mozharness: 2016-12-17 02:04:47.038963Z] Running populate-webroot step. 18:04:47 INFO - Running pre-action listener: _resource_record_pre_action 18:04:47 INFO - Running main action method: populate_webroot 18:04:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:04:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:04:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:04:47 INFO - '--tppagecycles', 18:04:47 INFO - '7'], 18:04:47 INFO - 'tests': ['tsvgm']}}, 18:04:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:04:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:04:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:04:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:04:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:04:47 INFO - 'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:04:47 INFO - 'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['damp', 'tps']}, 18:04:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:04:47 INFO - 'tests': ['damp', 'tps']}, 18:04:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['dromaeo_dom']}, 18:04:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:04:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['basic_compositor_video']}, 18:04:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:04:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['a11yr', 18:04:47 INFO - 'ts_paint', 18:04:47 INFO - 'tpaint', 18:04:47 INFO - 'sessionrestore', 18:04:47 INFO - 'sessionrestore_no_auto_restore', 18:04:47 INFO - 'tabpaint']}, 18:04:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:04:47 INFO - 'ts_paint', 18:04:47 INFO - 'tpaint', 18:04:47 INFO - 'sessionrestore', 18:04:47 INFO - 'sessionrestore_no_auto_restore', 18:04:47 INFO - 'tabpaint']}, 18:04:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:04:47 INFO - 'ts_paint', 18:04:47 INFO - 'tpaint', 18:04:47 INFO - 'sessionrestore', 18:04:47 INFO - 'sessionrestore_no_auto_restore', 18:04:47 INFO - 'tabpaint']}, 18:04:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:04:47 INFO - 'ts_paint', 18:04:47 INFO - 'tpaint', 18:04:47 INFO - 'sessionrestore', 18:04:47 INFO - 'sessionrestore_no_auto_restore', 18:04:47 INFO - 'tabpaint']}, 18:04:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['a11yr', 18:04:47 INFO - 'ts_paint', 18:04:47 INFO - 'tpaint', 18:04:47 INFO - 'sessionrestore', 18:04:47 INFO - 'sessionrestore_no_auto_restore', 18:04:47 INFO - 'tabpaint']}, 18:04:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['a11yr', 18:04:47 INFO - 'ts_paint', 18:04:47 INFO - 'tpaint', 18:04:47 INFO - 'sessionrestore', 18:04:47 INFO - 'sessionrestore_no_auto_restore', 18:04:47 INFO - 'tabpaint']}, 18:04:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['tsvgx', 18:04:47 INFO - 'tsvgr_opacity', 18:04:47 INFO - 'tart', 18:04:47 INFO - 'tscrollx', 18:04:47 INFO - 'cart', 18:04:47 INFO - 'tsvg_static']}, 18:04:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:04:47 INFO - 'tsvgr_opacity', 18:04:47 INFO - 'tart', 18:04:47 INFO - 'tscrollx', 18:04:47 INFO - 'cart', 18:04:47 INFO - 'tsvg_static']}, 18:04:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:04:47 INFO - 'talos_options': ['--disable-e10s'], 18:04:47 INFO - 'tests': ['tp5o']}, 18:04:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:04:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:04:47 INFO - 'talos_options': ['--disable-e10s', 18:04:47 INFO - '--xperf_path', 18:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:47 INFO - 'tests': ['tp5n']}, 18:04:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:04:47 INFO - 'talos_options': ['--xperf_path', 18:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:47 INFO - 'tests': ['tp5n']}}, 18:04:47 INFO - 'talos.zip': {'path': '', 18:04:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:04:47 INFO - Running post-action listener: _resource_record_post_action 18:04:47 INFO - [mozharness: 2016-12-17 02:04:47.057731Z] Finished populate-webroot step (success) 18:04:47 INFO - [mozharness: 2016-12-17 02:04:47.057858Z] Running create-virtualenv step. 18:04:47 INFO - Running pre-action listener: _resource_record_pre_action 18:04:47 INFO - Running main action method: create_virtualenv 18:04:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:04:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:04:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:04:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:04:47 INFO - Using real prefix '/tools/python27' 18:04:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:04:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:04:50 INFO - Installing pip.................done. 18:04:50 INFO - Return code: 0 18:04:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:04:51 INFO - Reading from file tmpfile_stdout 18:04:51 INFO - Output received: 18:04:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:04:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:51 INFO - 'HOME': '/Users/cltbld', 18:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:51 INFO - 'LOGNAME': 'cltbld', 18:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:51 INFO - 'MOZ_NO_REMOTE': '1', 18:04:51 INFO - 'NO_EM_RESTART': '1', 18:04:51 INFO - 'PAGER': '/bin/cat', 18:04:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:51 INFO - 'PWD': '/builds/slave/test', 18:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:51 INFO - 'SHELL': '/bin/bash', 18:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:04:51 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:51 INFO - 'USER': 'cltbld', 18:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:51 INFO - 'XPC_FLAGS': '0x0', 18:04:51 INFO - 'XPC_SERVICE_NAME': '0', 18:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:04:51 INFO - Cleaning up... 18:04:51 INFO - Return code: 0 18:04:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:51 INFO - 'HOME': '/Users/cltbld', 18:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:51 INFO - 'LOGNAME': 'cltbld', 18:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:51 INFO - 'MOZ_NO_REMOTE': '1', 18:04:51 INFO - 'NO_EM_RESTART': '1', 18:04:51 INFO - 'PAGER': '/bin/cat', 18:04:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:51 INFO - 'PWD': '/builds/slave/test', 18:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:51 INFO - 'SHELL': '/bin/bash', 18:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:04:51 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:51 INFO - 'USER': 'cltbld', 18:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:51 INFO - 'XPC_FLAGS': '0x0', 18:04:51 INFO - 'XPC_SERVICE_NAME': '0', 18:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:51 INFO - Downloading/unpacking psutil>=3.1.1 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:54 INFO - Installing collected packages: psutil 18:04:54 INFO - Running setup.py install for psutil 18:04:55 INFO - building 'psutil._psutil_osx' extension 18:04:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:04:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:04:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:04:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:04:55 INFO - building 'psutil._psutil_posix' extension 18:04:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:04:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:04:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:04:55 INFO - ^ 18:04:56 INFO - 1 warning generated. 18:04:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:04:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:56 INFO - Successfully installed psutil 18:04:56 INFO - Cleaning up... 18:04:56 INFO - Return code: 0 18:04:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:56 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:04:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:04:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:56 INFO - 'HOME': '/Users/cltbld', 18:04:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:56 INFO - 'LOGNAME': 'cltbld', 18:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:56 INFO - 'MOZ_NO_REMOTE': '1', 18:04:56 INFO - 'NO_EM_RESTART': '1', 18:04:56 INFO - 'PAGER': '/bin/cat', 18:04:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:56 INFO - 'PWD': '/builds/slave/test', 18:04:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:56 INFO - 'SHELL': '/bin/bash', 18:04:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:04:56 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:04:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:56 INFO - 'USER': 'cltbld', 18:04:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:56 INFO - 'XPC_FLAGS': '0x0', 18:04:56 INFO - 'XPC_SERVICE_NAME': '0', 18:04:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:04:59 INFO - Installing collected packages: mozsystemmonitor 18:04:59 INFO - Running setup.py install for mozsystemmonitor 18:04:59 INFO - Successfully installed mozsystemmonitor 18:04:59 INFO - Cleaning up... 18:04:59 INFO - Return code: 0 18:04:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:04:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:04:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:59 INFO - 'HOME': '/Users/cltbld', 18:04:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:59 INFO - 'LOGNAME': 'cltbld', 18:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:59 INFO - 'MOZ_NO_REMOTE': '1', 18:04:59 INFO - 'NO_EM_RESTART': '1', 18:04:59 INFO - 'PAGER': '/bin/cat', 18:04:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:59 INFO - 'PWD': '/builds/slave/test', 18:04:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:59 INFO - 'SHELL': '/bin/bash', 18:04:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:04:59 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:04:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:59 INFO - 'USER': 'cltbld', 18:04:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:59 INFO - 'XPC_FLAGS': '0x0', 18:04:59 INFO - 'XPC_SERVICE_NAME': '0', 18:04:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:59 INFO - Downloading/unpacking jsonschema==2.5.1 18:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:05:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:05:02 INFO - warning: no files found matching '*.txt' 18:05:02 INFO - no previously-included directories found matching 'build' 18:05:02 INFO - no previously-included directories found matching 'dist' 18:05:02 INFO - no previously-included directories found matching '.git*' 18:05:02 INFO - Installing collected packages: jsonschema, functools32 18:05:02 INFO - Running setup.py install for functools32 18:05:03 INFO - warning: no files found matching '*.txt' 18:05:03 INFO - no previously-included directories found matching 'build' 18:05:03 INFO - no previously-included directories found matching 'dist' 18:05:03 INFO - no previously-included directories found matching '.git*' 18:05:03 INFO - Successfully installed jsonschema functools32 18:05:03 INFO - Cleaning up... 18:05:03 INFO - Return code: 0 18:05:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:05:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:05:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:05:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:03 INFO - 'HOME': '/Users/cltbld', 18:05:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:03 INFO - 'LOGNAME': 'cltbld', 18:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:03 INFO - 'MOZ_NO_REMOTE': '1', 18:05:03 INFO - 'NO_EM_RESTART': '1', 18:05:03 INFO - 'PAGER': '/bin/cat', 18:05:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:03 INFO - 'PWD': '/builds/slave/test', 18:05:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:03 INFO - 'SHELL': '/bin/bash', 18:05:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:05:03 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:05:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:03 INFO - 'USER': 'cltbld', 18:05:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:03 INFO - 'XPC_FLAGS': '0x0', 18:05:03 INFO - 'XPC_SERVICE_NAME': '0', 18:05:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:05:03 INFO - Cleaning up... 18:05:03 INFO - Return code: 0 18:05:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:05:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:05:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:05:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:03 INFO - 'HOME': '/Users/cltbld', 18:05:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:03 INFO - 'LOGNAME': 'cltbld', 18:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:03 INFO - 'MOZ_NO_REMOTE': '1', 18:05:03 INFO - 'NO_EM_RESTART': '1', 18:05:03 INFO - 'PAGER': '/bin/cat', 18:05:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:03 INFO - 'PWD': '/builds/slave/test', 18:05:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:03 INFO - 'SHELL': '/bin/bash', 18:05:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:05:03 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:05:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:03 INFO - 'USER': 'cltbld', 18:05:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:03 INFO - 'XPC_FLAGS': '0x0', 18:05:03 INFO - 'XPC_SERVICE_NAME': '0', 18:05:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:06 INFO - Downloading blobuploader-1.2.4.tar.gz 18:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:05:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:05:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:07 INFO - Downloading docopt-0.6.1.tar.gz 18:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:05:07 INFO - Installing collected packages: blobuploader, requests, docopt 18:05:07 INFO - Running setup.py install for blobuploader 18:05:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:05:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:05:07 INFO - Running setup.py install for requests 18:05:08 INFO - Running setup.py install for docopt 18:05:08 INFO - Successfully installed blobuploader requests docopt 18:05:08 INFO - Cleaning up... 18:05:08 INFO - Return code: 0 18:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:08 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:05:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:05:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:08 INFO - 'HOME': '/Users/cltbld', 18:05:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:08 INFO - 'LOGNAME': 'cltbld', 18:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:08 INFO - 'MOZ_NO_REMOTE': '1', 18:05:08 INFO - 'NO_EM_RESTART': '1', 18:05:08 INFO - 'PAGER': '/bin/cat', 18:05:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:08 INFO - 'PWD': '/builds/slave/test', 18:05:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:08 INFO - 'SHELL': '/bin/bash', 18:05:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:05:08 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:05:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:08 INFO - 'USER': 'cltbld', 18:05:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:08 INFO - 'XPC_FLAGS': '0x0', 18:05:08 INFO - 'XPC_SERVICE_NAME': '0', 18:05:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:08 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-HqKWBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:08 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-aUFoIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:08 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-dUDS0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ObJ1lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ltDI6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-hntPHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-50lvRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ll4uIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-RzvMQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-TZbh6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NaWZXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ug_4QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-KQJFvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-qLWgli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-D93fwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-kcbYt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-5RhOLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:05:10 INFO - Running setup.py install for manifestparser 18:05:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:05:10 INFO - Running setup.py install for mozcrash 18:05:10 INFO - Running setup.py install for mozdebug 18:05:10 INFO - Running setup.py install for mozdevice 18:05:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Running setup.py install for mozfile 18:05:11 INFO - Running setup.py install for mozhttpd 18:05:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Running setup.py install for mozinfo 18:05:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Running setup.py install for mozInstall 18:05:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Running setup.py install for mozleak 18:05:11 INFO - Running setup.py install for mozlog 18:05:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:05:11 INFO - Running setup.py install for moznetwork 18:05:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Running setup.py install for mozprocess 18:05:12 INFO - Running setup.py install for mozprofile 18:05:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Running setup.py install for mozrunner 18:05:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:05:12 INFO - Running setup.py install for mozscreenshot 18:05:12 INFO - Running setup.py install for moztest 18:05:12 INFO - Running setup.py install for mozversion 18:05:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:05:13 INFO - Cleaning up... 18:05:13 INFO - Return code: 0 18:05:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:13 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:13 INFO - 'HOME': '/Users/cltbld', 18:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:13 INFO - 'LOGNAME': 'cltbld', 18:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:13 INFO - 'MOZ_NO_REMOTE': '1', 18:05:13 INFO - 'NO_EM_RESTART': '1', 18:05:13 INFO - 'PAGER': '/bin/cat', 18:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:13 INFO - 'PWD': '/builds/slave/test', 18:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:13 INFO - 'SHELL': '/bin/bash', 18:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:05:13 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:13 INFO - 'USER': 'cltbld', 18:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:13 INFO - 'XPC_FLAGS': '0x0', 18:05:13 INFO - 'XPC_SERVICE_NAME': '0', 18:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-maboAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-CHVCBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-QqUDcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ULd8zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-iFhkt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-fUpXW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-6Q2oRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-9svcJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:14 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-tHZaEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-kNSnEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-8IBv4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-49CXQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Rc1us0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-X0ul6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-GOeeKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-V_PHVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:15 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-f34ogu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:05:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:18 INFO - Downloading blessings-1.6.tar.gz 18:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:19 INFO - Installing collected packages: blessings 18:05:19 INFO - Running setup.py install for blessings 18:05:19 INFO - Successfully installed blessings 18:05:19 INFO - Cleaning up... 18:05:19 INFO - Return code: 0 18:05:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:19 INFO - Reading from file tmpfile_stdout 18:05:19 INFO - Current package versions: 18:05:19 INFO - blessings == 1.6 18:05:19 INFO - blobuploader == 1.2.4 18:05:19 INFO - docopt == 0.6.1 18:05:19 INFO - functools32 == 3.2.3-2 18:05:19 INFO - jsonschema == 2.5.1 18:05:19 INFO - manifestparser == 1.1 18:05:19 INFO - mozInstall == 1.12 18:05:19 INFO - mozcrash == 1.0 18:05:19 INFO - mozdebug == 0.1 18:05:19 INFO - mozdevice == 0.49 18:05:19 INFO - mozfile == 1.2 18:05:19 INFO - mozhttpd == 0.7 18:05:19 INFO - mozinfo == 0.9 18:05:19 INFO - mozleak == 0.1 18:05:19 INFO - mozlog == 3.4 18:05:19 INFO - moznetwork == 0.27 18:05:19 INFO - mozprocess == 0.23 18:05:19 INFO - mozprofile == 0.28 18:05:19 INFO - mozrunner == 6.13 18:05:19 INFO - mozscreenshot == 0.1 18:05:19 INFO - mozsystemmonitor == 0.3 18:05:19 INFO - moztest == 0.7 18:05:19 INFO - mozversion == 1.4 18:05:19 INFO - psutil == 3.1.1 18:05:19 INFO - requests == 1.2.3 18:05:19 INFO - wsgiref == 0.1.2 18:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 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 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:19 INFO - 'HOME': '/Users/cltbld', 18:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:19 INFO - 'LOGNAME': 'cltbld', 18:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:19 INFO - 'MOZ_NO_REMOTE': '1', 18:05:19 INFO - 'NO_EM_RESTART': '1', 18:05:19 INFO - 'PAGER': '/bin/cat', 18:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:19 INFO - 'PWD': '/builds/slave/test', 18:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:19 INFO - 'SHELL': '/bin/bash', 18:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:05:19 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:19 INFO - 'USER': 'cltbld', 18:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:19 INFO - 'XPC_FLAGS': '0x0', 18:05:19 INFO - 'XPC_SERVICE_NAME': '0', 18:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:05:19 INFO - Cleaning up... 18:05:19 INFO - Return code: 0 18:05:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1048923f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104808570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5a8463cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, '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.SjreX73uBq/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.pk3PdmhtBI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:19 INFO - 'HOME': '/Users/cltbld', 18:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:19 INFO - 'LOGNAME': 'cltbld', 18:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:19 INFO - 'MOZ_NO_REMOTE': '1', 18:05:19 INFO - 'NO_EM_RESTART': '1', 18:05:19 INFO - 'PAGER': '/bin/cat', 18:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:19 INFO - 'PWD': '/builds/slave/test', 18:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:19 INFO - 'SHELL': '/bin/bash', 18:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:05:19 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:19 INFO - 'USER': 'cltbld', 18:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:19 INFO - 'XPC_FLAGS': '0x0', 18:05:19 INFO - 'XPC_SERVICE_NAME': '0', 18:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:05:20 INFO - Cleaning up... 18:05:20 INFO - Return code: 0 18:05:20 INFO - Running post-action listener: _resource_record_post_action 18:05:20 INFO - Running post-action listener: _start_resource_monitoring 18:05:20 INFO - Starting resource monitoring. 18:05:20 INFO - [mozharness: 2016-12-17 02:05:20.169408Z] Finished create-virtualenv step (success) 18:05:20 INFO - [mozharness: 2016-12-17 02:05:20.170426Z] Running install step. 18:05:20 INFO - Running pre-action listener: _resource_record_pre_action 18:05:20 INFO - Running main action method: install 18:05:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:20 INFO - Reading from file tmpfile_stdout 18:05:20 INFO - Detecting whether we're running mozinstall >=1.0... 18:05:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:05:20 INFO - Reading from file tmpfile_stdout 18:05:20 INFO - Output received: 18:05:20 INFO - Usage: mozinstall [options] installer 18:05:20 INFO - Options: 18:05:20 INFO - -h, --help show this help message and exit 18:05:20 INFO - -d DEST, --destination=DEST 18:05:20 INFO - Directory to install application into. [default: 18:05:20 INFO - "/builds/slave/test"] 18:05:20 INFO - --app=APP Application being installed. [default: firefox] 18:05:20 INFO - mkdir: /builds/slave/test/build/application 18:05:20 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'] 18:05:20 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 18:05:42 INFO - Reading from file tmpfile_stdout 18:05:42 INFO - Output received: 18:05:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:05:42 INFO - Running post-action listener: _resource_record_post_action 18:05:42 INFO - [mozharness: 2016-12-17 02:05:42.097429Z] Finished install step (success) 18:05:42 INFO - [mozharness: 2016-12-17 02:05:42.097573Z] Running run-tests step. 18:05:42 INFO - Running pre-action listener: _resource_record_pre_action 18:05:42 INFO - Running main action method: run_tests 18:05:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:05:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:05:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:05:42 INFO - 2016-12-16 18:05:42.112 screenresolution[1620:7577] starting screenresolution argv=screenresolution get 18:05:42 INFO - 2016-12-16 18:05:42.114 screenresolution[1620:7577] Display 0: 1600x1200x32@60 18:05:42 INFO - 2016-12-16 18:05:42.120 screenresolution[1621:7580] starting screenresolution argv=screenresolution list 18:05:42 INFO - Available Modes on Display 0 18:05:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:05:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:05:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:05:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:05:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:05:42 INFO - Intel Iris: 18:05:42 INFO - Chipset Model: Intel Iris 18:05:42 INFO - Type: GPU 18:05:42 INFO - Bus: Built-In 18:05:42 INFO - VRAM (Dynamic, Max): 1536 MB 18:05:42 INFO - Vendor: Intel (0x8086) 18:05:42 INFO - Device ID: 0x0a2e 18:05:42 INFO - Revision ID: 0x0009 18:05:42 INFO - Displays: 18:05:42 INFO - Display: 18:05:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:05:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:05:42 INFO - Display Serial Number: 1600x1200 60 18:05:42 INFO - Main Display: Yes 18:05:42 INFO - Mirror: Off 18:05:42 INFO - Online: Yes 18:05:42 INFO - Rotation: Supported 18:05:42 INFO - Return code: 0 18:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:05:42 INFO - Python 2.7.3 18:05:42 INFO - Return code: 0 18:05:42 INFO - grabbing minidump binary from tooltool 18:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:42 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 0x1046a7d30>, '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 0x10450edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10469fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:05:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:05:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:05:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:05:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:05:42 INFO - Return code: 0 18:05:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:05:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:05:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:05:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:05:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:05:42 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/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:05:42 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/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:05:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjreX73uBq/Render', 18:05:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:42 INFO - 'HOME': '/Users/cltbld', 18:05:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:42 INFO - 'LOGNAME': 'cltbld', 18:05:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:42 INFO - 'MOZ_NO_REMOTE': '1', 18:05:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:42 INFO - 'NO_EM_RESTART': '1', 18:05:42 INFO - 'PAGER': '/bin/cat', 18:05:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:42 INFO - 'PWD': '/builds/slave/test', 18:05:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:42 INFO - 'SHELL': '/bin/bash', 18:05:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pk3PdmhtBI/Listeners', 18:05:42 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 18:05:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:42 INFO - 'USER': 'cltbld', 18:05:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:42 INFO - 'XPC_FLAGS': '0x0', 18:05:42 INFO - 'XPC_SERVICE_NAME': '0', 18:05:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:42 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/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:05:42 INFO - mozversion application_buildid: 20161216162449 18:05:42 INFO - mozversion application_changeset: 119f24606f99d82c6539763a778bb24f9df28037 18:05:42 INFO - mozversion application_display_name: Nightly 18:05:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:05:42 INFO - mozversion application_name: Firefox 18:05:42 INFO - mozversion application_remotingname: firefox 18:05:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:05:42 INFO - mozversion application_vendor: Mozilla 18:05:42 INFO - mozversion application_version: 53.0a1 18:05:42 INFO - mozversion platform_buildid: 20161216162449 18:05:42 INFO - mozversion platform_changeset: 119f24606f99d82c6539763a778bb24f9df28037 18:05:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:05:42 INFO - mozversion platform_version: 53.0a1 18:05:42 INFO - using testdate: 1481940342 18:05:42 INFO - actual date: 1481940342 18:05:42 INFO - starting webserver on 'localhost:49240' 18:05:42 INFO - SUITE-START | Running 2 tests 18:05:42 INFO - TEST-START | dromaeo_css 18:05:42 INFO - operating with platform_type : mac_ 18:05:42 INFO - Initialising browser for dromaeo_css test... 18:05:42 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpnOPhxP/profile http://localhost:49240/getInfo.html) 18:05:45 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 18:05:45 INFO - PROCESS | 1631 | colorDepth:24 18:05:45 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 18:05:45 INFO - PROCESS | 1631 | __metrics 18:05:45 INFO - PROCESS | 1631 | 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" 18:05:45 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:05:45 INFO - TEST-INFO | 1631: exit 0 18:05:45 INFO - Browser initialized. 18:05:45 INFO - Running cycle 1/1 for dromaeo_css test... 18:05:45 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpnOPhxP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:58 INFO - PROCESS | 1633 | RSS: Main: 230744064 18:05:58 INFO - PROCESS | 1633 | 18:06:48 INFO - PROCESS | 1633 | 1481940408922 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:09:00 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 18:09:04 INFO - PROCESS | 1633 | RSS: Main: 482152448 18:09:04 INFO - PROCESS | 1633 | 18:12:07 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 18:12:07 INFO - PROCESS | 1633 | RSS: Main: 372072448 18:12:07 INFO - PROCESS | 1633 | 18:15:10 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 18:15:10 INFO - PROCESS | 1633 | RSS: Main: 343261184 18:15:10 INFO - PROCESS | 1633 | 18:18:13 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 18:18:14 INFO - PROCESS | 1633 | RSS: Main: 343093248 18:18:14 INFO - PROCESS | 1633 | 18:21:17 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 18:21:18 INFO - PROCESS | 1633 | RSS: Main: 339947520 18:21:18 INFO - PROCESS | 1633 | 18:24:21 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 18:24:22 INFO - PROCESS | 1633 | RSS: Main: 473616384 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | __start_tp_report 18:24:22 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 18:24:22 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 18:24:22 INFO - PROCESS | 1633 | |i|pagename|runs| 18:24:22 INFO - PROCESS | 1633 | |0;dojo.html;3255.6907093826085;3256.983715081424;3276.688714572115;3323.152596087997;3342.231286804035;5425.077736784746;5518;5551.056320425528;5615;5630.521405680517;5536.75084621192;5553.250311207986;5573.164025396192;5628.915566266509;5641.605087643867;4172.770497622645;4679.415073115861;5030.874228144289;5094.057599344114;5130.794768209285;5076.796928122889;5131.871703207413;5154.639175257734;5172.069027575054;5179.326687530634;5117.462666420047;5118.897622047538;5136.203888397305;5168.586513078944;5189.2475591039465;4969.503049695038;5021.774020169065;5033.094043072246;5045.899082018339;5095.566876815476;5091.439941606421;5096.770645320932;5110.386753589593;5119.3088932994315;5147.433782283946;4300.161468513641;5481.945180548183;5567.66594004361;5570.442955704438;5571.275734154575;5877.471027607493;5925.259342582177;5933.792317268918;5995.400459954013;6049.455549000611;6014.51883849291;6045.183900173464;6071.878562428727;6082.9391706082815;6101.041992444471;5667.1782591524;5685.0619647758485;5687.488126068673;5724.513416359614;5729.942700572982;6127.785527506516;6250.218722659668;6263.71813268404;6271.404216599416;6369.299377068519;5819.127130930309;5867.530597552186;5878.764849406061;5965.955957707384;5979.372165922602;6078.45293923549;6113.637041974642;6138.063987693878;6138.78514252008;6141.731496609813;6016.819495415145;6060.151578778975;6090.817275481742;6100;6106.6336019838955;5751.798687046017;5787.102999035156;6101.0117056025665;6116.822755456448;6125.571219981412;4025.75845449274;4725.36207611968;4736.218523943579;4736.786844592001;4737.265723812815;4268.210381079448;4308.913821723548;4328.350747387917;4341.934870976938;4353.738775673406;5655.3779084300695;5656;5683.4884860361935;5685.346185188673;5716.171155182558;6110.969445152746;6133.938660613426;6152.538559608047;6155.199824022938;6173.104899789505;5539.889202215933;5574.498295153456;5609.635373700697;5621.100623900156;5671.688057156814;5275.393329767126;5279.762410691528;5292.761825717852;5323.0684630190335;5334.786608535615;6286.654234017173;6313.05304204373;6321.968390157927;6324.3043265240785;6343.809685709436;5908.970455147697;6003.939960600338;6169.84575385619;6180.412860778219;6184.412480814315;5221.9216711748595;5659.603827732184;5794.681292528951;6207.255129384503;6288.371162883858;5970.253718285215;5991.7902873399225;5992.901960197082;5995.310539287863;6031.396860313934;6043.063325184604;6046.546509011754;6058.939410605837;6068.089786532056;6086.330503644507;5715.257016587817;5728.79949201776;5825;5832.096025116114;5839.007368747239;5866.67733274674;5890.3226128994;5895;5895;5896.204012458264;5755.1367294906095;5759.884802304015;5768.077107662753;5769.94230057694;5770.711464426846;5843.970780146072;5872.911906321323;5895.14520394549;5897.616654917417;5898.380670029585;5758.93459709955;5761.654300741969;5764.365919748908;5765.827025189251;5774.451427114585 18:24:22 INFO - PROCESS | 1633 | |1;ext.html;402.41247778243763;447.63025143062214;457.31174582253726;477.76828238304427;510.6323447118074;29074.854625726868;38097.619023809755;38327;38412.277851376035;38515.80742096293;38609.22781544367;38997.805010974975;39025.41461878074;39032;39246.21507569847;7743.690252389898;8721.60752766127;9189.127032931878;9367.76580585484;9396.906030939672;8357.707480238192;10993.780124397506;11214;11253.156013298994;11397.974182323589;11132.666020019413;11185.049270811991;11216.551337946514;11216.887831121707;11306.604268850591;8377.45546539473;8593.097724738938;11023.17326200534;11120.61077862279;11120.833187502194;7370.96314518424;8422.452540584842;8484.575771211415;10822.891771082268;11104.777904441866;37283.81358093219;37569.812150939346;37674.81162594197;37714;37810.24379512422;3247.301830106515;3393.915152121192;3479.5476588043643;3593.9281214375565;3630.8910732678064;28671.28321791951;28919;28930.27674308138;29087.56368654472;29872.55191172134;2564.871756412172;3130.0922732407575;3138.7802853800245;3149.5275708643658;3249.8700051997894;356032;357687;358904;359049;359362;53915.46084539104;54297.45702543003;54361;54432.28461011537;54492.45507544953;55899.88200235972;55974.0032495938;56067;56184;56197;14807.333669984877;15174.393024278905;15210.163441010629;15213.847861521464;15214.847851521565;10812.297200681931;11093.611723589636;11101.500432480558;11938.94030529859;12050.337231452355;13328.266945317906;13455.932720336532;13473.730525389634;14488.85511144875;14686.41254349814;5756.683382414008;6901.447884169354;6982.371586557234;6992.6853291602;7021.368076873004;862.3230763850347;873.4148120759106;884.3190743127884;954.2318433660831;988.8084857746398;26162.6075608866;28398.148055558366;28507.714922850922;28786.856065719538;29023;913.7624217703445;930.7533503621546;1017.3336464615688;1056.8467572201987;1103.3710784852717;14767.26163691811;14863.405463781328;15049.924750376178;15160.696786064216;15217.695646087017;583533;589170;589651;590092;590806;53969.46030539723;53971.92056158855;54165.729171353894;54282;54368.45631543713;1248.3071895098126;1286.6397408725572;1365.7883028130457;1389.9513517026855;1416.0105052401393;28150.85924570364;29133.417331652825;29367.55948660729;29690.851545742134;30148.54777178388;37651;45110.32334515051;45521.772391137834;45548;45672.77163614161;484720;487350;487828;491147;492903;23005;23404.531909362056;23670.88164559166;23793.643095353236;24176.63735044011;39558.40662390124;39559;39617.009574760865;39950.60049399469;40025.799226023264;23596.882015590498;33461;34415;34874.82562587171;35953.022583758146;32997.50503742398;33314.500282496265;34243;34295.31409371849;34602.96191114271;26650.333741656614;32348.514772278904;32665.510017349283;32895.83552082224;32936;28429.573556396255;29917.952871649388;30086.849565752033;30130.72091235022;30522.84738576293;22420.103195872634;22952.081916723146;23058.769412306334;23306.766932330458;23367.76632233656 18:24:22 INFO - PROCESS | 1633 | |2;jquery.html;357.12682491308726;374.741428414394;375.036157076314;381.5916968843337;406.4391140226489;11870.999999999989;14159.433622655095;14760.966732328741;16221.594460138502;19488.512787180327;17610.911945440253;17674.64650706985;18889.62220755584;19318.130684119213;19524;5454.645448045884;5796.884062318751;5798.768049278045;5799.246098007253;5807.564432667546;5425.593080518957;5549.500544950954;5581.776728930838;5645.237892884449;5649.265595472582;5586.35756887957;5586.35756887957;5595.18869763884;5596.916046259309;5614.887702245973;5319.468053194688;5574.331080270394;5620.494155526002;5625.043742563774;5630.605857589971;4918.163912134945;4929.8028078876805;4935.111679897617;4937.136001199776;4937.629677774181;23115.7688423117;24107.638385424234;24232.030718771228;24241;24462.755372446227;2167.826573874086;2212.225720997654;2323.953520929572;2492.476579918219;2584.375326529915;14008.144962474631;14839.824511605435;14990.100593964287;15013.719330337546;15215.391384344613;1779.314963738957;1787.0975157545356;1815.5188874948149;1853.1753369750465;1914.2821441959265;93542;96264;96911.51544242234;97102;98542.50728746381;9878.901210987799;9932.80134397308;10097.495125243708;10321.174306055498;10590.682279531626;10740.516676749565;12837.807432888514;12856.100072994988;12863.742725145445;12868.871311286768;7691.269329413697;7929.563873986871;7931.801704957307;8031.598420078973;8063.233992770677;7856.175101614248;7868.606569671493;7871.960640196762;8027.799305017421;8036.316913062456;5326.45532795485;6096.481799047042;6245.656488893063;6263.185785847902;6392.360763923571;1728.2654871679485;1810.9456716298532;1816.9273229070955;1824.6168304655905;1852.8147185281634;886.6985225023523;939.6664184214505;953.5661274120258;986.4328011393477;1003.3779056984716;20234;20546.589068218553;20627.8968605156;20640.896795515928;20699.06854191565;789.3606178995033;805.6414895371504;961.8220629183623;994.1450352696675;1007.4408703169664;10528.684139475828;10587.311824731369;11120.110391168688;11169.329840209613;11239.381833999045;485031.5748421306;513324;565385;567605;573649;81653.5307698428;83766.58116709377;108478;112612;123537;977.6920270114891;992.2310209587628;1038.5430410619304;1039.4127318065268;1044.5247412427327;17961.371352002618;18142.45572632823;18444.668477693835;18595.34916277924;18786.906065469586;36187.81906090453;48669.5133048665;51438.48561514487;52083.69790755262;52735.736321318145;70174;70653.94019089821;70881.64559177378;71284;72738;7636.618169091635;7769.057735566108;7938.610743120046;7953.483023603448;8190.7952301192945;9606.51967401641;11557.826632600685;11909.464074116859;12339.383030848601;12382.380880955736;8708.032976223534;10486.685399438029;10649.8935010652;10723.89276107229;10860.565577377132;7788.415868809749;9599.136077753035;10294.794104118026;10644.095251903365;10685.626003089854;10620.734481638021;10698.62554810578;10777.784444311226;10792.568297268335;10814.945160419495;7551.924480755122;7593.620318984139;7618.771436856903;7721.845563088595;8033.638486268015;8477.915220847959;9026.684066057656;9084.863727044232;9330.507118860949;10456.477176141314 18:24:22 INFO - PROCESS | 1633 | |3;mootools.html;1364.6383708317303;1481.5481278210148;1524.3064405695409;1651.1991684033242;1734.4623166818287;7463.365613922816;7863.960680196598;8155.959220203898;8416.83166336673;8436.620352084155;8256.422050456455;8318.500889946592;8409.57952102394;8442.029166645838;8450.49297042178;1977.5748214133994;2053.0966374795116;2325.581395348845;2331.3821837213154;2336.2407217654245;1948.4154753573941;2139.144342263092;2248.4940888300166;2338.356951838241;2344.6483027545833;2277.3964899301614;2300.7469178390365;2317.8261630377788;2322.941926451835;2333.7199536055696;2298.793108620224;2315.5253173099472;2320.0951628864755;2329.010170677472;2331.0792237066435;2293.1515339324555;2335.521218150275;2340.32130682102;2342.3090188394294;2348.8120950323932;8071.112177660452;8170.67317307307;8217.95891020547;8264.297534709556;8268;5022.321986531808;5195.246689230041;5198.714070726109;5202.193659982709;5212.374515058179;3321.9501707474406;3390.8594224265;3486.3550243205086;3523.189666376722;3530.6998905093096;1036.5542816588863;1055.2138656700806;1069.0859315285397;1073.4471747050275;1081.588996181454;10264.846027309597;10564.735881602945;10572.36565806054;10581.312214706097;10823.29648572848;4529.6376289896725;4615.16926953145;4660.813567457331;4663.906721865544;4687.648426368036;9518.095780900803;9524.8571271431;9528.90471095294;9530;9532.332736708502;5215.217717342353;5217.973910130425;5224.817131400383;5226.902350506436;5227.555657769056;4260.786960651955;4401.6478681705385;4467.664925130628;4783.473817880031;4794.352762377034;3603.9099022524647;3728.5898551159353;3781.149241420658;3857.228554289153;3862.343401621731;1178.1693905796565;1180.6162997026001;1182.2906256246356;1192.7614477104614;1204.5302332090491;812.2689579378489;840.7141571865473;868.769776009358;923.2014307623857;923.4643906534194;5493.368262649767;5746.712664366765;5752.884942301131;5920.822375328747;5966.970165149147;903.70629545398;905.2215095018279;935.9672411465566;943.4575119306427;1001.369137443406;3438.82805859706;3632.4369722693023;3717.438675756189;3803.961960380361;3827.5981021992848;9708.368956017835;10022.899771002343;10029.598816047423;10043.799124017625;10063.345882517613;9771.21830253578;9971.551280192409;9983.051610097174;9987.9013308536;9990.800183996425;7634.732784352632;7798.103218129988;7805.297523222824;7818.804529886798;7837.1379148293645;5215.947840521546;5430.864228394164;5458.863528411822;5536.889262214652;5559.360673522597;9052.958909725203;9209.953950230207;9331.766705832408;9335;9340.486273254764;8933.821323573622;9288.907110929074;9315.487648179414;9385.530723463662;9406.764830879283;7179.569225846466;7633.274838890296;7920.089189743253;7920.801979950547;7923.286904178652;7457.993170922073;7679.462437629312;7905.407094467823;7910.920890791019;7929.008873890763;6949.478789090939;7000.194977577644;7022.4382049436945;7166;7215.67529461186;6615.735370585123;6934.757283495053;6936;7057.611831349325;7123.180834203926;6487.805365839033;6595.604263744191;6609.735610575715;6706.329367063449;6708.329167083252;3834.5015148031694;4088.141490286954;4737.24204127338;4739.644526660445;4927.556519913225;4591.540845915515;4815.879603009953;4825.227963525819;4900.1424750667775;4978.626603004862 18:24:22 INFO - PROCESS | 1633 | |4;prototype.html;330.4531001193026;358.34244161962795;365.4171596303895;376.7325199108631;376.76640482900604;4589.518100599439;4675.55582219689;4829.78265978031;5028.8239911603105;5083.568591200934;3874.7332810306007;4890;4963.702177869331;4976.601871850253;5012.624053196007;3172;3947.8551220146196;4004.7585248573037;4025.1144748155357;4077.633013028827;3978.622030907059;3983.2630963271886;3997.061425208771;4015.7188996770237;4060.3706425504092;3765.548134223897;3964.8215830287704;4006.6394024537785;4006.8998275043214;4043.2722110020186;3632.8183590820354;3959.4852669153115;3990.501187351581;4005.615255109428;4007.438958545806;3019.9430199430244;3465.9499640316362;3548.1307079765625;3570.232400033979;3581.265840502717;4370.531766147412;4644.651651126179;4950.603951683856;4979.551840334388;4987.700737955734;3854.8843534694006;4177.704911477452;4595.517470665565;4597.747123908183;4598.954010459886;4654.557817007379;4843.24929635907;5030.446650868402;5061.266116413136;5310.035286943817;3291.358185153896;3468;3941.487606611151;3976.1570477108717;3989.5810939851476;4655.976720116411;5353.973230133864;5533.197686335499;5544.944550554524;5616.775328986795;3570.8571657133944;3681.361794001697;3824.1586850893314;3969.861054863066;4005.399190121505;4051.8784436466954;4054.7769872657286;4062.3750499800317;4064.552899181088;4065.5121385433936;4123.793810309532;4566.315052742115;4584.931226031612;4594.908101837945;4602;5153.561947234527;5283.045273248922;5308.203769434615;5327.627066105335;5485.533729632946;1136.5681041204455;1173.9002184814215;1176.100283283289;1325.1514137777747;1331.9277981225207;779.2402407652494;781.9569923654253;829.344817594106;898.2275243290765;912.2792993535165;4542.409486766699;4934.629902757308;4962.627802914796;4970.304157417964;4993.825216117491;4948.752562371939;5150;5453.318335208099;5456.74494866183;5462.596457558661;4626.398568186114;4788.61691064714;4851.223804191312;4937.407511098691;4976.954839483677;2458.6803715516867;2496.3509487533374;2516.4589613233243;2538.390786211333;2566.0762125634756;4563;4691.3432119503295;5376.301080859542;5392.948375066902;5408.729563521808;4785.665003449725;4943.530364615356;5527.55779537636;5656.575756818255;5691.715414229355;5597.832065038056;5637.181409295353;5676.602637815313;5688.914666280009;5703.62926409782;5002.799888004439;5200.921986170135;5445.319335083114;5450.945490545202;5481.260029895913;4798.640101992434;4844.909895273535;5044.385796545071;5409.432009638931;5444.401115877171;5634.85912852182;5644.472204871955;5660.471672648444;5674.631148975303;5716.599433138907;3547.0136723434957;3569.8215089245955;3703;3707.3512135375663;3712.1833196696684;4840.491748366371;5423.538999185113;5455.809046683506;5463.617546771847;5469.784737181448;4535.754801373341;4754.4532378776885;5332.33345831771;5334.813281535127;5394.406615272238;4053.7973101344223;4921.704697718148;5352.474544754727;5358.84784771276;5419.83740487786;4657.906841863076;4899.080735411585;4900.509949005071;5231.686098834082;5241.790328386975;5024.964889219872;5051.772670229922;5234.528892399702;5240.9036385446125;5352.270342125622;4443.222436073739;4573.393165895408;5181.404138523967;5206.765695543634;5235.984146103854 18:24:22 INFO - PROCESS | 1633 | |5;yui.html;677.5155763629006;699.1749735312333;704.2429388407463;778.7040924448709;791.7703865878893;14750.778738318933;15269.770953435707;15649.374025038998;15909.761353579706;15922.601934951632;11817.35004574748;12371.381430928463;14134;14136.416115634343;14571.781423278659;839.5214727605268;868.6134670071821;871.4205053639322;872.1148034744739;872.8079822439086;686.4645576450376;706.8586282743446;869;870.9520976346298;878.8593824988003;753.480098731876;896.0770406481334;917.7109210598641;921.7326975177191;944.0512285153411;926.393212445849;929.1080562659821;929.3633860805336;931.6832277025776;933.1648174883509;685.7428464325877;685.8251145957748;687.556526040706;687.8658661560997;687.965601719917;11722.35527046012;12363.814542781776;14630.41478340865;15138.394464221528;15187.848121518753;14131.15213087218;14146;14235.359408826627;14315.14109153454;14331.28343582827;11677.416129193507;11720.531178752839;11753.23603965748;11957.641270761891;12072.879271207352;3640.7451478396524;3709.0541911812584;3811.4473401356927;3822.101806075598;3865.942010869839;75318.62340688317;78889.60555197188;99628.50928726768;100021;100720.98558028799;9795.216382689368;10925.890741092646;11108.666739997812;11208.439578021067;11361.091112710963;22703.205387811347;22715.772842271697;22739.317820465414;22746.976386062666;22800.429989250402;7516.098068231738;7858.528488290721;7916.208379162153;7917.208279172152;7917.722879699183;4177.498700156001;4282.336237883133;4383.912321753547;4438.644908407319;4518.209313370147;3460.2214501737412;3536.876209332661;3561.6082230954576;3574;3576.9821150894077;572.3332317849741;591.7071049830275;615.2002396884122;637.5154882289494;648.9383508566679;540.9323834520685;592.2005292854698;641.7016087519326;656.4780999105723;690.623610132479;7725.420593455513;8668.956655216809;9068.591913363915;9091.225505551569;9440.669576564787;658.614710394415;669.437672355224;670.7384120193128;671.1141293492641;672.1616379202876;4228.767417792051;4532.9546704533195;4601.654875884322;4658.836940707059;4928.310036594879;97193.51403242939;101264.49367753114;102203;104006.47996760119;104203;74626;78206;83636;91247.54376228077;92017;66308;82709.58645206735;83333.74999375014;84243.5787821057;85148.57425712832;9565.282603804604;9618;9682.419054856731;9683.709488715349;10004.149647280063;35955;40930.38604420877;51969;52725.68185795386;53824;52822.73588632032;75707.48585028379;76477.85283220868;76658;78477.60761196158;12728.23630582168;12807.359632018548;13017.609471715863;13099.672508187372;13501.662458438617;14359.497417590333;14430.134191948517;14648;14739.189344586151;15239.732874795076;12940.870591294342;13048.869511304765;13191.40638671243;13269.535566255136;13467.528636498067;13631.38658760378;13667.17996920188;13827.861721382658;14005.089669171472;14391.85608143947;13401.262930538524;13619.659508512366;13729.313534323444;14062.507812226522;14118.929405352908;11283.492242849255;11348.432578371214;11373.54505819758;11476.368799716096;11560;8922.509261990393;10588.84116738265;10645.946770266099;11354.318740875575;11579.478923448634 18:24:22 INFO - PROCESS | 1633 | __end_tp_report 18:24:22 INFO - PROCESS | 1633 | __start_cc_report 18:24:22 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,3174 18:24:22 INFO - PROCESS | 1633 | __end_cc_report 18:24:22 INFO - PROCESS | 1633 | __startTimestamp1481941462129__endTimestamp 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | ------- Summary: start ------- 18:24:22 INFO - PROCESS | 1633 | Number of tests: 6 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5577.56 Median:5759.88 stddev:645.59 (11.2%) stddev-sans-first:621.35 18:24:22 INFO - PROCESS | 1633 | Values: 3255.7 3257.0 3276.7 3323.2 3342.2 5425.1 5518.0 5551.1 5615.0 5630.5 5536.8 5553.3 5573.2 5628.9 5641.6 4172.8 4679.4 5030.9 5094.1 5130.8 5076.8 5131.9 5154.6 5172.1 5179.3 5117.5 5118.9 5136.2 5168.6 5189.2 4969.5 5021.8 5033.1 5045.9 5095.6 5091.4 5096.8 5110.4 5119.3 5147.4 4300.2 5481.9 5567.7 5570.4 5571.3 5877.5 5925.3 5933.8 5995.4 6049.5 6014.5 6045.2 6071.9 6082.9 6101.0 5667.2 5685.1 5687.5 5724.5 5729.9 6127.8 6250.2 6263.7 6271.4 6369.3 5819.1 5867.5 5878.8 5966.0 5979.4 6078.5 6113.6 6138.1 6138.8 6141.7 6016.8 6060.2 6090.8 6100.0 6106.6 5751.8 5787.1 6101.0 6116.8 6125.6 4025.8 4725.4 4736.2 4736.8 4737.3 4268.2 4308.9 4328.4 4341.9 4353.7 5655.4 5656.0 5683.5 5685.3 5716.2 6111.0 6133.9 6152.5 6155.2 6173.1 5539.9 5574.5 5609.6 5621.1 5671.7 5275.4 5279.8 5292.8 5323.1 5334.8 6286.7 6313.1 6322.0 6324.3 6343.8 5909.0 6003.9 6169.8 6180.4 6184.4 5221.9 5659.6 5794.7 6207.3 6288.4 5970.3 5991.8 5992.9 5995.3 6031.4 6043.1 6046.5 6058.9 6068.1 6086.3 5715.3 5728.8 5825.0 5832.1 5839.0 5866.7 5890.3 5895.0 5895.0 5896.2 5755.1 5759.9 5768.1 5769.9 5770.7 5844.0 5872.9 5895.1 5897.6 5898.4 5758.9 5761.7 5764.4 5765.8 5774.5 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:60560.15 Median:34355.16 stddev:130276.78 (379.2%) stddev-sans-first:130563.95 18:24:22 INFO - PROCESS | 1633 | Values: 402.4 447.6 457.3 477.8 510.6 29074.9 38097.6 38327.0 38412.3 38515.8 38609.2 38997.8 39025.4 39032.0 39246.2 7743.7 8721.6 9189.1 9367.8 9396.9 8357.7 10993.8 11214.0 11253.2 11398.0 11132.7 11185.0 11216.6 11216.9 11306.6 8377.5 8593.1 11023.2 11120.6 11120.8 7371.0 8422.5 8484.6 10822.9 11104.8 37283.8 37569.8 37674.8 37714.0 37810.2 3247.3 3393.9 3479.5 3593.9 3630.9 28671.3 28919.0 28930.3 29087.6 29872.6 2564.9 3130.1 3138.8 3149.5 3249.9 356032.0 357687.0 358904.0 359049.0 359362.0 53915.5 54297.5 54361.0 54432.3 54492.5 55899.9 55974.0 56067.0 56184.0 56197.0 14807.3 15174.4 15210.2 15213.8 15214.8 10812.3 11093.6 11101.5 11938.9 12050.3 13328.3 13455.9 13473.7 14488.9 14686.4 5756.7 6901.4 6982.4 6992.7 7021.4 862.3 873.4 884.3 954.2 988.8 26162.6 28398.1 28507.7 28786.9 29023.0 913.8 930.8 1017.3 1056.8 1103.4 14767.3 14863.4 15049.9 15160.7 15217.7 583533.0 589170.0 589651.0 590092.0 590806.0 53969.5 53971.9 54165.7 54282.0 54368.5 1248.3 1286.6 1365.8 1390.0 1416.0 28150.9 29133.4 29367.6 29690.9 30148.5 37651.0 45110.3 45521.8 45548.0 45672.8 484720.0 487350.0 487828.0 491147.0 492903.0 23005.0 23404.5 23670.9 23793.6 24176.6 39558.4 39559.0 39617.0 39950.6 40025.8 23596.9 33461.0 34415.0 34874.8 35953.0 32997.5 33314.5 34243.0 34295.3 34603.0 26650.3 32348.5 32665.5 32895.8 32936.0 28429.6 29918.0 30086.8 30130.7 30522.8 22420.1 22952.1 23058.8 23306.8 23367.8 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:31385.90 Median:26793.84 stddev:89909.74 (335.6%) stddev-sans-first:90131.77 18:24:22 INFO - PROCESS | 1633 | Values: 357.1 374.7 375.0 381.6 406.4 11871.0 14159.4 14761.0 16221.6 19488.5 17610.9 17674.6 18889.6 19318.1 19524.0 5454.6 5796.9 5798.8 5799.2 5807.6 5425.6 5549.5 5581.8 5645.2 5649.3 5586.4 5586.4 5595.2 5596.9 5614.9 5319.5 5574.3 5620.5 5625.0 5630.6 4918.2 4929.8 4935.1 4937.1 4937.6 23115.8 24107.6 24232.0 24241.0 24462.8 2167.8 2212.2 2324.0 2492.5 2584.4 14008.1 14839.8 14990.1 15013.7 15215.4 1779.3 1787.1 1815.5 1853.2 1914.3 93542.0 96264.0 96911.5 97102.0 98542.5 9878.9 9932.8 10097.5 10321.2 10590.7 10740.5 12837.8 12856.1 12863.7 12868.9 7691.3 7929.6 7931.8 8031.6 8063.2 7856.2 7868.6 7872.0 8027.8 8036.3 5326.5 6096.5 6245.7 6263.2 6392.4 1728.3 1810.9 1816.9 1824.6 1852.8 886.7 939.7 953.6 986.4 1003.4 20234.0 20546.6 20627.9 20640.9 20699.1 789.4 805.6 961.8 994.1 1007.4 10528.7 10587.3 11120.1 11169.3 11239.4 485031.6 513324.0 565385.0 567605.0 573649.0 81653.5 83766.6 108478.0 112612.0 123537.0 977.7 992.2 1038.5 1039.4 1044.5 17961.4 18142.5 18444.7 18595.3 18786.9 36187.8 48669.5 51438.5 52083.7 52735.7 70174.0 70653.9 70881.6 71284.0 72738.0 7636.6 7769.1 7938.6 7953.5 8190.8 9606.5 11557.8 11909.5 12339.4 12382.4 8708.0 10486.7 10649.9 10723.9 10860.6 7788.4 9599.1 10294.8 10644.1 10685.6 10620.7 10698.6 10777.8 10792.6 10814.9 7551.9 7593.6 7618.8 7721.8 8033.6 8477.9 9026.7 9084.9 9330.5 10456.5 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5416.99 Median:5215.58 stddev:2969.70 (56.9%) stddev-sans-first:2962.42 18:24:22 INFO - PROCESS | 1633 | Values: 1364.6 1481.5 1524.3 1651.2 1734.5 7463.4 7864.0 8156.0 8416.8 8436.6 8256.4 8318.5 8409.6 8442.0 8450.5 1977.6 2053.1 2325.6 2331.4 2336.2 1948.4 2139.1 2248.5 2338.4 2344.6 2277.4 2300.7 2317.8 2322.9 2333.7 2298.8 2315.5 2320.1 2329.0 2331.1 2293.2 2335.5 2340.3 2342.3 2348.8 8071.1 8170.7 8218.0 8264.3 8268.0 5022.3 5195.2 5198.7 5202.2 5212.4 3322.0 3390.9 3486.4 3523.2 3530.7 1036.6 1055.2 1069.1 1073.4 1081.6 10264.8 10564.7 10572.4 10581.3 10823.3 4529.6 4615.2 4660.8 4663.9 4687.6 9518.1 9524.9 9528.9 9530.0 9532.3 5215.2 5218.0 5224.8 5226.9 5227.6 4260.8 4401.6 4467.7 4783.5 4794.4 3603.9 3728.6 3781.1 3857.2 3862.3 1178.2 1180.6 1182.3 1192.8 1204.5 812.3 840.7 868.8 923.2 923.5 5493.4 5746.7 5752.9 5920.8 5967.0 903.7 905.2 936.0 943.5 1001.4 3438.8 3632.4 3717.4 3804.0 3827.6 9708.4 10022.9 10029.6 10043.8 10063.3 9771.2 9971.6 9983.1 9987.9 9990.8 7634.7 7798.1 7805.3 7818.8 7837.1 5215.9 5430.9 5458.9 5536.9 5559.4 9053.0 9210.0 9331.8 9335.0 9340.5 8933.8 9288.9 9315.5 9385.5 9406.8 7179.6 7633.3 7920.1 7920.8 7923.3 7458.0 7679.5 7905.4 7910.9 7929.0 6949.5 7000.2 7022.4 7166.0 7215.7 6615.7 6934.8 6936.0 7057.6 7123.2 6487.8 6595.6 6609.7 6706.3 6708.3 3834.5 4088.1 4737.2 4739.6 4927.6 4591.5 4815.9 4825.2 4900.1 4978.6 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4330.96 Median:4835.14 stddev:1297.68 (26.8%) stddev-sans-first:1266.11 18:24:22 INFO - PROCESS | 1633 | Values: 330.5 358.3 365.4 376.7 376.8 4589.5 4675.6 4829.8 5028.8 5083.6 3874.7 4890.0 4963.7 4976.6 5012.6 3172.0 3947.9 4004.8 4025.1 4077.6 3978.6 3983.3 3997.1 4015.7 4060.4 3765.5 3964.8 4006.6 4006.9 4043.3 3632.8 3959.5 3990.5 4005.6 4007.4 3019.9 3465.9 3548.1 3570.2 3581.3 4370.5 4644.7 4950.6 4979.6 4987.7 3854.9 4177.7 4595.5 4597.7 4599.0 4654.6 4843.2 5030.4 5061.3 5310.0 3291.4 3468.0 3941.5 3976.2 3989.6 4656.0 5354.0 5533.2 5544.9 5616.8 3570.9 3681.4 3824.2 3969.9 4005.4 4051.9 4054.8 4062.4 4064.6 4065.5 4123.8 4566.3 4584.9 4594.9 4602.0 5153.6 5283.0 5308.2 5327.6 5485.5 1136.6 1173.9 1176.1 1325.2 1331.9 779.2 782.0 829.3 898.2 912.3 4542.4 4934.6 4962.6 4970.3 4993.8 4948.8 5150.0 5453.3 5456.7 5462.6 4626.4 4788.6 4851.2 4937.4 4977.0 2458.7 2496.4 2516.5 2538.4 2566.1 4563.0 4691.3 5376.3 5392.9 5408.7 4785.7 4943.5 5527.6 5656.6 5691.7 5597.8 5637.2 5676.6 5688.9 5703.6 5002.8 5200.9 5445.3 5450.9 5481.3 4798.6 4844.9 5044.4 5409.4 5444.4 5634.9 5644.5 5660.5 5674.6 5716.6 3547.0 3569.8 3703.0 3707.4 3712.2 4840.5 5423.5 5455.8 5463.6 5469.8 4535.8 4754.5 5332.3 5334.8 5394.4 4053.8 4921.7 5352.5 5358.8 5419.8 4657.9 4899.1 4900.5 5231.7 5241.8 5025.0 5051.8 5234.5 5240.9 5352.3 4443.2 4573.4 5181.4 5206.8 5236.0 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:19958.84 Median:4411.28 stddev:28291.10 (641.3%) stddev-sans-first:28333.42 18:24:22 INFO - PROCESS | 1633 | Values: 677.5 699.2 704.2 778.7 791.8 14750.8 15269.8 15649.4 15909.8 15922.6 11817.4 12371.4 14134.0 14136.4 14571.8 839.5 868.6 871.4 872.1 872.8 686.5 706.9 869.0 871.0 878.9 753.5 896.1 917.7 921.7 944.1 926.4 929.1 929.4 931.7 933.2 685.7 685.8 687.6 687.9 688.0 11722.4 12363.8 14630.4 15138.4 15187.8 14131.2 14146.0 14235.4 14315.1 14331.3 11677.4 11720.5 11753.2 11957.6 12072.9 3640.7 3709.1 3811.4 3822.1 3865.9 75318.6 78889.6 99628.5 100021.0 100721.0 9795.2 10925.9 11108.7 11208.4 11361.1 22703.2 22715.8 22739.3 22747.0 22800.4 7516.1 7858.5 7916.2 7917.2 7917.7 4177.5 4282.3 4383.9 4438.6 4518.2 3460.2 3536.9 3561.6 3574.0 3577.0 572.3 591.7 615.2 637.5 648.9 540.9 592.2 641.7 656.5 690.6 7725.4 8669.0 9068.6 9091.2 9440.7 658.6 669.4 670.7 671.1 672.2 4228.8 4533.0 4601.7 4658.8 4928.3 97193.5 101264.5 102203.0 104006.5 104203.0 74626.0 78206.0 83636.0 91247.5 92017.0 66308.0 82709.6 83333.7 84243.6 85148.6 9565.3 9618.0 9682.4 9683.7 10004.1 35955.0 40930.4 51969.0 52725.7 53824.0 52822.7 75707.5 76477.9 76658.0 78477.6 12728.2 12807.4 13017.6 13099.7 13501.7 14359.5 14430.1 14648.0 14739.2 15239.7 12940.9 13048.9 13191.4 13269.5 13467.5 13631.4 13667.2 13827.9 14005.1 14391.9 13401.3 13619.7 13729.3 14062.5 14118.9 11283.5 11348.4 11373.5 11476.4 11560.0 8922.5 10588.8 10645.9 11354.3 11579.5 18:24:22 INFO - PROCESS | 1633 | -------- Summary: end -------- 18:24:22 INFO - PROCESS | 1633 | 18:24:22 INFO - TEST-INFO | 1633: exit 0 18:24:22 INFO - TEST-OK | dromaeo_css | took 1120092ms 18:24:22 INFO - TEST-START | kraken 18:24:22 INFO - operating with platform_type : mac_ 18:24:22 INFO - Initialising browser for kraken test... 18:24:22 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpM9J1xv/profile http://localhost:49240/getInfo.html) 18:24:25 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 18:24:25 INFO - PROCESS | 1639 | colorDepth:24 18:24:25 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 18:24:25 INFO - PROCESS | 1639 | __metrics 18:24:25 INFO - PROCESS | 1639 | 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" 18:24:25 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:24:26 INFO - TEST-INFO | 1639: exit 0 18:24:26 INFO - Browser initialized. 18:24:26 INFO - Running cycle 1/1 for kraken test... 18:24:26 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpM9J1xv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:37 INFO - PROCESS | 1640 | RSS: Main: 237395968 18:24:37 INFO - PROCESS | 1640 | 18:24:40 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 18:24:41 INFO - PROCESS | 1640 | RSS: Main: 290738176 18:24:41 INFO - PROCESS | 1640 | 18:24:44 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 18:24:45 INFO - PROCESS | 1640 | RSS: Main: 292470784 18:24:45 INFO - PROCESS | 1640 | 18:24:48 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 18:24:48 INFO - PROCESS | 1640 | RSS: Main: 381419520 18:24:48 INFO - PROCESS | 1640 | 18:24:50 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 18:24:51 INFO - PROCESS | 1640 | RSS: Main: 283930624 18:24:51 INFO - PROCESS | 1640 | 18:24:53 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:24:54 INFO - PROCESS | 1640 | RSS: Main: 287227904 18:24:54 INFO - PROCESS | 1640 | 18:24:57 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 18:24:57 INFO - PROCESS | 1640 | RSS: Main: 329015296 18:24:57 INFO - PROCESS | 1640 | 18:25:00 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 18:25:01 INFO - PROCESS | 1640 | RSS: Main: 332652544 18:25:01 INFO - PROCESS | 1640 | 18:25:04 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 18:25:04 INFO - PROCESS | 1640 | RSS: Main: 329113600 18:25:04 INFO - PROCESS | 1640 | 18:25:06 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:25:07 INFO - PROCESS | 1640 | RSS: Main: 306913280 18:25:07 INFO - PROCESS | 1640 | 18:25:09 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:25:09 INFO - PROCESS | 1640 | RSS: Main: 311255040 18:25:09 INFO - PROCESS | 1640 | 18:25:11 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:25:12 INFO - PROCESS | 1640 | RSS: Main: 311455744 18:25:12 INFO - PROCESS | 1640 | 18:25:15 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:25:16 INFO - PROCESS | 1640 | RSS: Main: 325906432 18:25:16 INFO - PROCESS | 1640 | 18:25:19 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:25:19 INFO - PROCESS | 1640 | RSS: Main: 320462848 18:25:19 INFO - PROCESS | 1640 | 18:25:21 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 18:25:22 INFO - PROCESS | 1640 | RSS: Main: 364584960 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | __start_tp_report 18:25:22 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 18:25:22 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 18:25:22 INFO - PROCESS | 1640 | |i|pagename|runs| 18:25:22 INFO - PROCESS | 1640 | |0;ai-astar;113;112;113;113;113;113;125;167;147;112 18:25:22 INFO - PROCESS | 1640 | |1;audio-beat-detection;142;110;110;158;113;112;141;125;140;141 18:25:22 INFO - PROCESS | 1640 | |2;audio-dft;185;182;183;186;181;183;188;185;185;185 18:25:22 INFO - PROCESS | 1640 | |3;audio-fft;80;58;60;87;63;60;57;59;74;58 18:25:22 INFO - PROCESS | 1640 | |4;audio-oscillator;82;70;86;71;70;91;117;101;77;84 18:25:22 INFO - PROCESS | 1640 | |5;imaging-gaussian-blur;107;110;107;110;107;109;107;109;106;108 18:25:22 INFO - PROCESS | 1640 | |6;imaging-darkroom;93;93;93;92;108;144;99;92;93;93 18:25:22 INFO - PROCESS | 1640 | |7;imaging-desaturate;87;85;85;88;86;83;87;85;86;85 18:25:22 INFO - PROCESS | 1640 | |8;json-parse-financial;56;57;54;54;55;55;55;55;55;56 18:25:22 INFO - PROCESS | 1640 | |9;json-stringify-tinderbox;70;67;69;79;77;72;71;72;71;75 18:25:22 INFO - PROCESS | 1640 | |10;stanford-crypto-aes;86;88;86;87;85;83;87;74;96;103 18:25:22 INFO - PROCESS | 1640 | |11;stanford-crypto-ccm;141;139;138;141;145;145;152;145;180;182 18:25:22 INFO - PROCESS | 1640 | |12;stanford-crypto-pbkdf2;172;173;176;176;231;182;172;171;176;171 18:25:22 INFO - PROCESS | 1640 | |13;stanford-crypto-sha256-iterative;66;78;85;63;59;80;79;84;83;85 18:25:22 INFO - PROCESS | 1640 | __end_tp_report 18:25:22 INFO - PROCESS | 1640 | __start_cc_report 18:25:22 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2014 18:25:22 INFO - PROCESS | 1640 | __end_cc_report 18:25:22 INFO - PROCESS | 1640 | __startTimestamp1481941522084__endTimestamp 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | ------- Summary: start ------- 18:25:22 INFO - PROCESS | 1640 | Number of tests: 14 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#0] ai-astar Cycles:10 Average:122.80 Median:113.00 stddev:19.03 (16.8%) stddev-sans-first:19.85 18:25:22 INFO - PROCESS | 1640 | Values: 113.0 112.0 113.0 113.0 113.0 113.0 125.0 167.0 147.0 112.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:140.50 stddev:17.33 (12.3%) stddev-sans-first:17.75 18:25:22 INFO - PROCESS | 1640 | Values: 142.0 110.0 110.0 158.0 113.0 112.0 141.0 125.0 140.0 141.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:2.06 (1.1%) stddev-sans-first:2.17 18:25:22 INFO - PROCESS | 1640 | Values: 185.0 182.0 183.0 186.0 181.0 183.0 188.0 185.0 185.0 185.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#3] audio-fft Cycles:10 Average:65.60 Median:61.50 stddev:10.74 (17.5%) stddev-sans-first:10.05 18:25:22 INFO - PROCESS | 1640 | Values: 80.0 58.0 60.0 87.0 63.0 60.0 57.0 59.0 74.0 58.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:79.50 stddev:15.04 (18.9%) stddev-sans-first:15.92 18:25:22 INFO - PROCESS | 1640 | Values: 82.0 70.0 86.0 71.0 70.0 91.0 117.0 101.0 77.0 84.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#5] imaging-gaussian-blur Cycles:10 Average:108.00 Median:108.50 stddev:1.41 (1.3%) stddev-sans-first:1.45 18:25:22 INFO - PROCESS | 1640 | Values: 107.0 110.0 107.0 110.0 107.0 109.0 107.0 109.0 106.0 108.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:93.00 stddev:16.24 (17.5%) stddev-sans-first:17.03 18:25:22 INFO - PROCESS | 1640 | Values: 93.0 93.0 93.0 92.0 108.0 144.0 99.0 92.0 93.0 93.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.42 (1.6%) stddev-sans-first:1.42 18:25:22 INFO - PROCESS | 1640 | Values: 87.0 85.0 85.0 88.0 86.0 83.0 87.0 85.0 86.0 85.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 18:25:22 INFO - PROCESS | 1640 | Values: 56.0 57.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 56.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.00 stddev:3.68 (5.1%) stddev-sans-first:3.81 18:25:22 INFO - PROCESS | 1640 | Values: 70.0 67.0 69.0 79.0 77.0 72.0 71.0 72.0 71.0 75.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.50 stddev:7.65 (8.8%) stddev-sans-first:8.09 18:25:22 INFO - PROCESS | 1640 | Values: 86.0 88.0 86.0 87.0 85.0 83.0 87.0 74.0 96.0 103.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:145.00 stddev:16.41 (11.3%) stddev-sans-first:17.02 18:25:22 INFO - PROCESS | 1640 | Values: 141.0 139.0 138.0 141.0 145.0 145.0 152.0 145.0 180.0 182.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:176.00 stddev:18.23 (10.4%) stddev-sans-first:19.11 18:25:22 INFO - PROCESS | 1640 | Values: 172.0 173.0 176.0 176.0 231.0 182.0 172.0 171.0 176.0 171.0 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - PROCESS | 1640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:81.50 stddev:9.78 (12.0%) stddev-sans-first:9.66 18:25:22 INFO - PROCESS | 1640 | Values: 66.0 78.0 85.0 63.0 59.0 80.0 79.0 84.0 83.0 85.0 18:25:22 INFO - PROCESS | 1640 | -------- Summary: end -------- 18:25:22 INFO - PROCESS | 1640 | 18:25:22 INFO - TEST-INFO | 1640: exit 0 18:25:22 INFO - TEST-OK | kraken | took 60183ms 18:25:22 INFO - SUITE-END | took 1180s 18:25:23 INFO - Completed test suite (00:19:40) 18:25:23 INFO - javascript benchmark 18:25:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3255.6907093826085, 3256.983715081424, 3276.688714572115, 3323.152596087997, 3342.231286804035, 5425.077736784746, 5518.0, 5551.056320425528, 5615.0, 5630.521405680517, 5536.75084621192, 5553.250311207986, 5573.164025396192, 5628.915566266509, 5641.605087643867, 4172.770497622645, 4679.415073115861, 5030.874228144289, 5094.057599344114, 5130.794768209285, 5076.796928122889, 5131.871703207413, 5154.639175257734, 5172.069027575054, 5179.326687530634, 5117.462666420047, 5118.897622047538, 5136.203888397305, 5168.586513078944, 5189.2475591039465, 4969.503049695038, 5021.774020169065, 5033.094043072246, 5045.899082018339, 5095.566876815476, 5091.439941606421, 5096.770645320932, 5110.386753589593, 5119.3088932994315, 5147.433782283946, 4300.161468513641, 5481.945180548183, 5567.66594004361, 5570.442955704438, 5571.275734154575, 5877.471027607493, 5925.259342582177, 5933.792317268918, 5995.400459954013, 6049.455549000611, 6014.51883849291, 6045.183900173464, 6071.878562428727, 6082.9391706082815, 6101.041992444471, 5667.1782591524, 5685.0619647758485, 5687.488126068673, 5724.513416359614, 5729.942700572982, 6127.785527506516, 6250.218722659668, 6263.71813268404, 6271.404216599416, 6369.299377068519, 5819.127130930309, 5867.530597552186, 5878.764849406061, 5965.955957707384, 5979.372165922602, 6078.45293923549, 6113.637041974642, 6138.063987693878, 6138.78514252008, 6141.731496609813, 6016.819495415145, 6060.151578778975, 6090.817275481742, 6100.0, 6106.6336019838955, 5751.798687046017, 5787.102999035156, 6101.0117056025665, 6116.822755456448, 6125.571219981412, 4025.75845449274, 4725.36207611968, 4736.218523943579, 4736.786844592001, 4737.265723812815, 4268.210381079448, 4308.913821723548, 4328.350747387917, 4341.934870976938, 4353.738775673406, 5655.3779084300695, 5656.0, 5683.4884860361935, 5685.346185188673, 5716.171155182558, 6110.969445152746, 6133.938660613426, 6152.538559608047, 6155.199824022938, 6173.104899789505, 5539.889202215933, 5574.498295153456, 5609.635373700697, 5621.100623900156, 5671.688057156814, 5275.393329767126, 5279.762410691528, 5292.761825717852, 5323.0684630190335, 5334.786608535615, 6286.654234017173, 6313.05304204373, 6321.968390157927, 6324.3043265240785, 6343.809685709436, 5908.970455147697, 6003.939960600338, 6169.84575385619, 6180.412860778219, 6184.412480814315, 5221.9216711748595, 5659.603827732184, 5794.681292528951, 6207.255129384503, 6288.371162883858, 5970.253718285215, 5991.7902873399225, 5992.901960197082, 5995.310539287863, 6031.396860313934, 6043.063325184604, 6046.546509011754, 6058.939410605837, 6068.089786532056, 6086.330503644507, 5715.257016587817, 5728.79949201776, 5825.0, 5832.096025116114, 5839.007368747239, 5866.67733274674, 5890.3226128994, 5895.0, 5895.0, 5896.204012458264, 5755.1367294906095, 5759.884802304015, 5768.077107662753, 5769.94230057694, 5770.711464426846, 5843.970780146072, 5872.911906321323, 5895.14520394549, 5897.616654917417, 5898.380670029585, 5758.93459709955, 5761.654300741969, 5764.365919748908, 5765.827025189251, 5774.451427114585], "value": 5535.90019354448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.41247778243763, 447.63025143062214, 457.31174582253726, 477.76828238304427, 510.6323447118074, 29074.854625726868, 38097.619023809755, 38327.0, 38412.277851376035, 38515.80742096293, 38609.22781544367, 38997.805010974975, 39025.41461878074, 39032.0, 39246.21507569847, 7743.690252389898, 8721.60752766127, 9189.127032931878, 9367.76580585484, 9396.906030939672, 8357.707480238192, 10993.780124397506, 11214.0, 11253.156013298994, 11397.974182323589, 11132.666020019413, 11185.049270811991, 11216.551337946514, 11216.887831121707, 11306.604268850591, 8377.45546539473, 8593.097724738938, 11023.17326200534, 11120.61077862279, 11120.833187502194, 7370.96314518424, 8422.452540584842, 8484.575771211415, 10822.891771082268, 11104.777904441866, 37283.81358093219, 37569.812150939346, 37674.81162594197, 37714.0, 37810.24379512422, 3247.301830106515, 3393.915152121192, 3479.5476588043643, 3593.9281214375565, 3630.8910732678064, 28671.28321791951, 28919.0, 28930.27674308138, 29087.56368654472, 29872.55191172134, 2564.871756412172, 3130.0922732407575, 3138.7802853800245, 3149.5275708643658, 3249.8700051997894, 356032.0, 357687.0, 358904.0, 359049.0, 359362.0, 53915.46084539104, 54297.45702543003, 54361.0, 54432.28461011537, 54492.45507544953, 55899.88200235972, 55974.0032495938, 56067.0, 56184.0, 56197.0, 14807.333669984877, 15174.393024278905, 15210.163441010629, 15213.847861521464, 15214.847851521565, 10812.297200681931, 11093.611723589636, 11101.500432480558, 11938.94030529859, 12050.337231452355, 13328.266945317906, 13455.932720336532, 13473.730525389634, 14488.85511144875, 14686.41254349814, 5756.683382414008, 6901.447884169354, 6982.371586557234, 6992.6853291602, 7021.368076873004, 862.3230763850347, 873.4148120759106, 884.3190743127884, 954.2318433660831, 988.8084857746398, 26162.6075608866, 28398.148055558366, 28507.714922850922, 28786.856065719538, 29023.0, 913.7624217703445, 930.7533503621546, 1017.3336464615688, 1056.8467572201987, 1103.3710784852717, 14767.26163691811, 14863.405463781328, 15049.924750376178, 15160.696786064216, 15217.695646087017, 583533.0, 589170.0, 589651.0, 590092.0, 590806.0, 53969.46030539723, 53971.92056158855, 54165.729171353894, 54282.0, 54368.45631543713, 1248.3071895098126, 1286.6397408725572, 1365.7883028130457, 1389.9513517026855, 1416.0105052401393, 28150.85924570364, 29133.417331652825, 29367.55948660729, 29690.851545742134, 30148.54777178388, 37651.0, 45110.32334515051, 45521.772391137834, 45548.0, 45672.77163614161, 484720.0, 487350.0, 487828.0, 491147.0, 492903.0, 23005.0, 23404.531909362056, 23670.88164559166, 23793.643095353236, 24176.63735044011, 39558.40662390124, 39559.0, 39617.009574760865, 39950.60049399469, 40025.799226023264, 23596.882015590498, 33461.0, 34415.0, 34874.82562587171, 35953.022583758146, 32997.50503742398, 33314.500282496265, 34243.0, 34295.31409371849, 34602.96191114271, 26650.333741656614, 32348.514772278904, 32665.510017349283, 32895.83552082224, 32936.0, 28429.573556396255, 29917.952871649388, 30086.849565752033, 30130.72091235022, 30522.84738576293, 22420.103195872634, 22952.081916723146, 23058.769412306334, 23306.766932330458, 23367.76632233656], "value": 18342.98601941921, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.12682491308726, 374.741428414394, 375.036157076314, 381.5916968843337, 406.4391140226489, 11870.999999999989, 14159.433622655095, 14760.966732328741, 16221.594460138502, 19488.512787180327, 17610.911945440253, 17674.64650706985, 18889.62220755584, 19318.130684119213, 19524.0, 5454.645448045884, 5796.884062318751, 5798.768049278045, 5799.246098007253, 5807.564432667546, 5425.593080518957, 5549.500544950954, 5581.776728930838, 5645.237892884449, 5649.265595472582, 5586.35756887957, 5586.35756887957, 5595.18869763884, 5596.916046259309, 5614.887702245973, 5319.468053194688, 5574.331080270394, 5620.494155526002, 5625.043742563774, 5630.605857589971, 4918.163912134945, 4929.8028078876805, 4935.111679897617, 4937.136001199776, 4937.629677774181, 23115.7688423117, 24107.638385424234, 24232.030718771228, 24241.0, 24462.755372446227, 2167.826573874086, 2212.225720997654, 2323.953520929572, 2492.476579918219, 2584.375326529915, 14008.144962474631, 14839.824511605435, 14990.100593964287, 15013.719330337546, 15215.391384344613, 1779.314963738957, 1787.0975157545356, 1815.5188874948149, 1853.1753369750465, 1914.2821441959265, 93542.0, 96264.0, 96911.51544242234, 97102.0, 98542.50728746381, 9878.901210987799, 9932.80134397308, 10097.495125243708, 10321.174306055498, 10590.682279531626, 10740.516676749565, 12837.807432888514, 12856.100072994988, 12863.742725145445, 12868.871311286768, 7691.269329413697, 7929.563873986871, 7931.801704957307, 8031.598420078973, 8063.233992770677, 7856.175101614248, 7868.606569671493, 7871.960640196762, 8027.799305017421, 8036.316913062456, 5326.45532795485, 6096.481799047042, 6245.656488893063, 6263.185785847902, 6392.360763923571, 1728.2654871679485, 1810.9456716298532, 1816.9273229070955, 1824.6168304655905, 1852.8147185281634, 886.6985225023523, 939.6664184214505, 953.5661274120258, 986.4328011393477, 1003.3779056984716, 20234.0, 20546.589068218553, 20627.8968605156, 20640.896795515928, 20699.06854191565, 789.3606178995033, 805.6414895371504, 961.8220629183623, 994.1450352696675, 1007.4408703169664, 10528.684139475828, 10587.311824731369, 11120.110391168688, 11169.329840209613, 11239.381833999045, 485031.5748421306, 513324.0, 565385.0, 567605.0, 573649.0, 81653.5307698428, 83766.58116709377, 108478.0, 112612.0, 123537.0, 977.6920270114891, 992.2310209587628, 1038.5430410619304, 1039.4127318065268, 1044.5247412427327, 17961.371352002618, 18142.45572632823, 18444.668477693835, 18595.34916277924, 18786.906065469586, 36187.81906090453, 48669.5133048665, 51438.48561514487, 52083.69790755262, 52735.736321318145, 70174.0, 70653.94019089821, 70881.64559177378, 71284.0, 72738.0, 7636.618169091635, 7769.057735566108, 7938.610743120046, 7953.483023603448, 8190.7952301192945, 9606.51967401641, 11557.826632600685, 11909.464074116859, 12339.383030848601, 12382.380880955736, 8708.032976223534, 10486.685399438029, 10649.8935010652, 10723.89276107229, 10860.565577377132, 7788.415868809749, 9599.136077753035, 10294.794104118026, 10644.095251903365, 10685.626003089854, 10620.734481638021, 10698.62554810578, 10777.784444311226, 10792.568297268335, 10814.945160419495, 7551.924480755122, 7593.620318984139, 7618.771436856903, 7721.845563088595, 8033.638486268015, 8477.915220847959, 9026.684066057656, 9084.863727044232, 9330.507118860949, 10456.477176141314], "value": 9099.806939155622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.6383708317303, 1481.5481278210148, 1524.3064405695409, 1651.1991684033242, 1734.4623166818287, 7463.365613922816, 7863.960680196598, 8155.959220203898, 8416.83166336673, 8436.620352084155, 8256.422050456455, 8318.500889946592, 8409.57952102394, 8442.029166645838, 8450.49297042178, 1977.5748214133994, 2053.0966374795116, 2325.581395348845, 2331.3821837213154, 2336.2407217654245, 1948.4154753573941, 2139.144342263092, 2248.4940888300166, 2338.356951838241, 2344.6483027545833, 2277.3964899301614, 2300.7469178390365, 2317.8261630377788, 2322.941926451835, 2333.7199536055696, 2298.793108620224, 2315.5253173099472, 2320.0951628864755, 2329.010170677472, 2331.0792237066435, 2293.1515339324555, 2335.521218150275, 2340.32130682102, 2342.3090188394294, 2348.8120950323932, 8071.112177660452, 8170.67317307307, 8217.95891020547, 8264.297534709556, 8268.0, 5022.321986531808, 5195.246689230041, 5198.714070726109, 5202.193659982709, 5212.374515058179, 3321.9501707474406, 3390.8594224265, 3486.3550243205086, 3523.189666376722, 3530.6998905093096, 1036.5542816588863, 1055.2138656700806, 1069.0859315285397, 1073.4471747050275, 1081.588996181454, 10264.846027309597, 10564.735881602945, 10572.36565806054, 10581.312214706097, 10823.29648572848, 4529.6376289896725, 4615.16926953145, 4660.813567457331, 4663.906721865544, 4687.648426368036, 9518.095780900803, 9524.8571271431, 9528.90471095294, 9530.0, 9532.332736708502, 5215.217717342353, 5217.973910130425, 5224.817131400383, 5226.902350506436, 5227.555657769056, 4260.786960651955, 4401.6478681705385, 4467.664925130628, 4783.473817880031, 4794.352762377034, 3603.9099022524647, 3728.5898551159353, 3781.149241420658, 3857.228554289153, 3862.343401621731, 1178.1693905796565, 1180.6162997026001, 1182.2906256246356, 1192.7614477104614, 1204.5302332090491, 812.2689579378489, 840.7141571865473, 868.769776009358, 923.2014307623857, 923.4643906534194, 5493.368262649767, 5746.712664366765, 5752.884942301131, 5920.822375328747, 5966.970165149147, 903.70629545398, 905.2215095018279, 935.9672411465566, 943.4575119306427, 1001.369137443406, 3438.82805859706, 3632.4369722693023, 3717.438675756189, 3803.961960380361, 3827.5981021992848, 9708.368956017835, 10022.899771002343, 10029.598816047423, 10043.799124017625, 10063.345882517613, 9771.21830253578, 9971.551280192409, 9983.051610097174, 9987.9013308536, 9990.800183996425, 7634.732784352632, 7798.103218129988, 7805.297523222824, 7818.804529886798, 7837.1379148293645, 5215.947840521546, 5430.864228394164, 5458.863528411822, 5536.889262214652, 5559.360673522597, 9052.958909725203, 9209.953950230207, 9331.766705832408, 9335.0, 9340.486273254764, 8933.821323573622, 9288.907110929074, 9315.487648179414, 9385.530723463662, 9406.764830879283, 7179.569225846466, 7633.274838890296, 7920.089189743253, 7920.801979950547, 7923.286904178652, 7457.993170922073, 7679.462437629312, 7905.407094467823, 7910.920890791019, 7929.008873890763, 6949.478789090939, 7000.194977577644, 7022.4382049436945, 7166.0, 7215.67529461186, 6615.735370585123, 6934.757283495053, 6936.0, 7057.611831349325, 7123.180834203926, 6487.805365839033, 6595.604263744191, 6609.735610575715, 6706.329367063449, 6708.329167083252, 3834.5015148031694, 4088.141490286954, 4737.24204127338, 4739.644526660445, 4927.556519913225, 4591.540845915515, 4815.879603009953, 4825.227963525819, 4900.1424750667775, 4978.626603004862], "value": 4384.9211952065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4531001193026, 358.34244161962795, 365.4171596303895, 376.7325199108631, 376.76640482900604, 4589.518100599439, 4675.55582219689, 4829.78265978031, 5028.8239911603105, 5083.568591200934, 3874.7332810306007, 4890.0, 4963.702177869331, 4976.601871850253, 5012.624053196007, 3172.0, 3947.8551220146196, 4004.7585248573037, 4025.1144748155357, 4077.633013028827, 3978.622030907059, 3983.2630963271886, 3997.061425208771, 4015.7188996770237, 4060.3706425504092, 3765.548134223897, 3964.8215830287704, 4006.6394024537785, 4006.8998275043214, 4043.2722110020186, 3632.8183590820354, 3959.4852669153115, 3990.501187351581, 4005.615255109428, 4007.438958545806, 3019.9430199430244, 3465.9499640316362, 3548.1307079765625, 3570.232400033979, 3581.265840502717, 4370.531766147412, 4644.651651126179, 4950.603951683856, 4979.551840334388, 4987.700737955734, 3854.8843534694006, 4177.704911477452, 4595.517470665565, 4597.747123908183, 4598.954010459886, 4654.557817007379, 4843.24929635907, 5030.446650868402, 5061.266116413136, 5310.035286943817, 3291.358185153896, 3468.0, 3941.487606611151, 3976.1570477108717, 3989.5810939851476, 4655.976720116411, 5353.973230133864, 5533.197686335499, 5544.944550554524, 5616.775328986795, 3570.8571657133944, 3681.361794001697, 3824.1586850893314, 3969.861054863066, 4005.399190121505, 4051.8784436466954, 4054.7769872657286, 4062.3750499800317, 4064.552899181088, 4065.5121385433936, 4123.793810309532, 4566.315052742115, 4584.931226031612, 4594.908101837945, 4602.0, 5153.561947234527, 5283.045273248922, 5308.203769434615, 5327.627066105335, 5485.533729632946, 1136.5681041204455, 1173.9002184814215, 1176.100283283289, 1325.1514137777747, 1331.9277981225207, 779.2402407652494, 781.9569923654253, 829.344817594106, 898.2275243290765, 912.2792993535165, 4542.409486766699, 4934.629902757308, 4962.627802914796, 4970.304157417964, 4993.825216117491, 4948.752562371939, 5150.0, 5453.318335208099, 5456.74494866183, 5462.596457558661, 4626.398568186114, 4788.61691064714, 4851.223804191312, 4937.407511098691, 4976.954839483677, 2458.6803715516867, 2496.3509487533374, 2516.4589613233243, 2538.390786211333, 2566.0762125634756, 4563.0, 4691.3432119503295, 5376.301080859542, 5392.948375066902, 5408.729563521808, 4785.665003449725, 4943.530364615356, 5527.55779537636, 5656.575756818255, 5691.715414229355, 5597.832065038056, 5637.181409295353, 5676.602637815313, 5688.914666280009, 5703.62926409782, 5002.799888004439, 5200.921986170135, 5445.319335083114, 5450.945490545202, 5481.260029895913, 4798.640101992434, 4844.909895273535, 5044.385796545071, 5409.432009638931, 5444.401115877171, 5634.85912852182, 5644.472204871955, 5660.471672648444, 5674.631148975303, 5716.599433138907, 3547.0136723434957, 3569.8215089245955, 3703.0, 3707.3512135375663, 3712.1833196696684, 4840.491748366371, 5423.538999185113, 5455.809046683506, 5463.617546771847, 5469.784737181448, 4535.754801373341, 4754.4532378776885, 5332.33345831771, 5334.813281535127, 5394.406615272238, 4053.7973101344223, 4921.704697718148, 5352.474544754727, 5358.84784771276, 5419.83740487786, 4657.906841863076, 4899.080735411585, 4900.509949005071, 5231.686098834082, 5241.790328386975, 5024.964889219872, 5051.772670229922, 5234.528892399702, 5240.9036385446125, 5352.270342125622, 4443.222436073739, 4573.393165895408, 5181.404138523967, 5206.765695543634, 5235.984146103854], "value": 3931.122291398319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.5155763629006, 699.1749735312333, 704.2429388407463, 778.7040924448709, 791.7703865878893, 14750.778738318933, 15269.770953435707, 15649.374025038998, 15909.761353579706, 15922.601934951632, 11817.35004574748, 12371.381430928463, 14134.0, 14136.416115634343, 14571.781423278659, 839.5214727605268, 868.6134670071821, 871.4205053639322, 872.1148034744739, 872.8079822439086, 686.4645576450376, 706.8586282743446, 869.0, 870.9520976346298, 878.8593824988003, 753.480098731876, 896.0770406481334, 917.7109210598641, 921.7326975177191, 944.0512285153411, 926.393212445849, 929.1080562659821, 929.3633860805336, 931.6832277025776, 933.1648174883509, 685.7428464325877, 685.8251145957748, 687.556526040706, 687.8658661560997, 687.965601719917, 11722.35527046012, 12363.814542781776, 14630.41478340865, 15138.394464221528, 15187.848121518753, 14131.15213087218, 14146.0, 14235.359408826627, 14315.14109153454, 14331.28343582827, 11677.416129193507, 11720.531178752839, 11753.23603965748, 11957.641270761891, 12072.879271207352, 3640.7451478396524, 3709.0541911812584, 3811.4473401356927, 3822.101806075598, 3865.942010869839, 75318.62340688317, 78889.60555197188, 99628.50928726768, 100021.0, 100720.98558028799, 9795.216382689368, 10925.890741092646, 11108.666739997812, 11208.439578021067, 11361.091112710963, 22703.205387811347, 22715.772842271697, 22739.317820465414, 22746.976386062666, 22800.429989250402, 7516.098068231738, 7858.528488290721, 7916.208379162153, 7917.208279172152, 7917.722879699183, 4177.498700156001, 4282.336237883133, 4383.912321753547, 4438.644908407319, 4518.209313370147, 3460.2214501737412, 3536.876209332661, 3561.6082230954576, 3574.0, 3576.9821150894077, 572.3332317849741, 591.7071049830275, 615.2002396884122, 637.5154882289494, 648.9383508566679, 540.9323834520685, 592.2005292854698, 641.7016087519326, 656.4780999105723, 690.623610132479, 7725.420593455513, 8668.956655216809, 9068.591913363915, 9091.225505551569, 9440.669576564787, 658.614710394415, 669.437672355224, 670.7384120193128, 671.1141293492641, 672.1616379202876, 4228.767417792051, 4532.9546704533195, 4601.654875884322, 4658.836940707059, 4928.310036594879, 97193.51403242939, 101264.49367753114, 102203.0, 104006.47996760119, 104203.0, 74626.0, 78206.0, 83636.0, 91247.54376228077, 92017.0, 66308.0, 82709.58645206735, 83333.74999375014, 84243.5787821057, 85148.57425712832, 9565.282603804604, 9618.0, 9682.419054856731, 9683.709488715349, 10004.149647280063, 35955.0, 40930.38604420877, 51969.0, 52725.68185795386, 53824.0, 52822.73588632032, 75707.48585028379, 76477.85283220868, 76658.0, 78477.60761196158, 12728.23630582168, 12807.359632018548, 13017.609471715863, 13099.672508187372, 13501.662458438617, 14359.497417590333, 14430.134191948517, 14648.0, 14739.189344586151, 15239.732874795076, 12940.870591294342, 13048.869511304765, 13191.40638671243, 13269.535566255136, 13467.528636498067, 13631.38658760378, 13667.17996920188, 13827.861721382658, 14005.089669171472, 14391.85608143947, 13401.262930538524, 13619.659508512366, 13729.313534323444, 14062.507812226522, 14118.929405352908, 11283.492242849255, 11348.432578371214, 11373.54505819758, 11476.368799716096, 11560.0, 8922.509261990393, 10588.84116738265, 10645.946770266099, 11354.318740875575, 11579.478923448634], "value": 7400.498187035982, "unit": "score"}], "name": "dromaeo_css", "value": 7002.384394954751, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 125.0, 167.0, 147.0, 112.0], "value": 122.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 110.0, 158.0, 113.0, 112.0, 141.0, 125.0, 140.0, 141.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 183.0, 186.0, 181.0, 183.0, 188.0, 185.0, 185.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 60.0, 87.0, 63.0, 60.0, 57.0, 59.0, 74.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 86.0, 71.0, 70.0, 91.0, 117.0, 101.0, 77.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 107.0, 110.0, 107.0, 109.0, 107.0, 109.0, 106.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 92.0, 108.0, 144.0, 99.0, 92.0, 93.0, 93.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 88.0, 86.0, 83.0, 87.0, 85.0, 86.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 69.0, 79.0, 77.0, 72.0, 71.0, 72.0, 71.0, 75.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 87.0, 85.0, 83.0, 87.0, 74.0, 96.0, 103.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 138.0, 141.0, 145.0, 145.0, 152.0, 145.0, 180.0, 182.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 176.0, 176.0, 231.0, 182.0, 172.0, 171.0, 176.0, 171.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 85.0, 63.0, 59.0, 80.0, 79.0, 84.0, 83.0, 85.0], "value": 76.2, "unit": "score"}], "name": "kraken", "value": 1502.5, "alertThreshold": 2.0}]} 18:25:23 INFO - Return code: 0 18:25:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:25:23 INFO - # TBPL SUCCESS # 18:25:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:25:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:25:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:25:23 INFO - 2016-12-16 18:25:23.381 screenresolution[1644:9815] starting screenresolution argv=screenresolution get 18:25:23 INFO - 2016-12-16 18:25:23.386 screenresolution[1644:9815] Display 0: 1600x1200x32@60 18:25:23 INFO - 2016-12-16 18:25:23.392 screenresolution[1645:9818] starting screenresolution argv=screenresolution list 18:25:23 INFO - Available Modes on Display 0 18:25:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:25:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:25:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:25:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:25:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:25:23 INFO - Intel Iris: 18:25:23 INFO - Chipset Model: Intel Iris 18:25:23 INFO - Type: GPU 18:25:23 INFO - Bus: Built-In 18:25:23 INFO - VRAM (Dynamic, Max): 1536 MB 18:25:23 INFO - Vendor: Intel (0x8086) 18:25:23 INFO - Device ID: 0x0a2e 18:25:23 INFO - Revision ID: 0x0009 18:25:23 INFO - Displays: 18:25:23 INFO - Display: 18:25:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:25:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:25:23 INFO - Display Serial Number: 1600x1200 60 18:25:23 INFO - Main Display: Yes 18:25:23 INFO - Mirror: Off 18:25:23 INFO - Online: Yes 18:25:23 INFO - Rotation: Supported 18:25:23 INFO - Return code: 0 18:25:23 INFO - Running post-action listener: _resource_record_post_action 18:25:23 INFO - [mozharness: 2016-12-17 02:25:23.632251Z] Finished run-tests step (success) 18:25:23 INFO - Running post-run listener: _resource_record_post_run 18:25:23 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38618112; Write bytes: 548747776; Read time: 465; Write time: 1622 18:25:23 INFO - TinderboxPrint: CPU usage
53.7% 18:25:23 INFO - TinderboxPrint: I/O read bytes / time
38,618,112 / 465 18:25:23 INFO - TinderboxPrint: I/O write bytes / time
548,747,776 / 1,622 18:25:23 INFO - TinderboxPrint: CPU idle
2,228.3 (46.3%) 18:25:23 INFO - TinderboxPrint: CPU system
967.4 (20.1%) 18:25:23 INFO - TinderboxPrint: CPU user
1,613.9 (33.6%) 18:25:23 INFO - TinderboxPrint: Swap in / out
287,936,512 / 0 18:25:23 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 234021376; Write bytes: 221065216; Read time: 16577; Write time: 426 18:25:23 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 32353280; Write bytes: 298461696; Read time: 297; Write time: 1142 18:25:24 INFO - Running post-run listener: _upload_blobber_files 18:25:24 INFO - Blob upload gear active. 18:25:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:25:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:25:24 INFO - (blobuploader) - INFO - Open directory for files ... 18:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:25 INFO - (blobuploader) - INFO - Done attempting. 18:25:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:25:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:27 INFO - (blobuploader) - INFO - Done attempting. 18:25:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:25:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:29 INFO - (blobuploader) - INFO - Done attempting. 18:25:29 INFO - (blobuploader) - INFO - Iteration through files over. 18:25:29 INFO - Return code: 0 18:25:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:25:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:25:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcc8c9d5fa6f61d3357181d4c6795b88c73e546e4d62d71832108f79651c0393174cd0d9fddafabaf6e2780041574877f4511f4ce9bd44514c866947f2ff8dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca3dd08a226a3e5544c00396c5a3ff59a5cdee9bba95edf323cd533dd677609022082335050669ac516125418ab5b62e943e2f87ff31c8e5955c1066ae99d715", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f79beb2d2759d40afdcc05c3195ea31e27edff90cf51670f168f369f495453573fc4d892fa868cad8162fe539e830a4898e7c6d10203a325ff1a4dc93af84ca"} 18:25:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:25:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:25:29 INFO - Contents: 18:25:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcc8c9d5fa6f61d3357181d4c6795b88c73e546e4d62d71832108f79651c0393174cd0d9fddafabaf6e2780041574877f4511f4ce9bd44514c866947f2ff8dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca3dd08a226a3e5544c00396c5a3ff59a5cdee9bba95edf323cd533dd677609022082335050669ac516125418ab5b62e943e2f87ff31c8e5955c1066ae99d715", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f79beb2d2759d40afdcc05c3195ea31e27edff90cf51670f168f369f495453573fc4d892fa868cad8162fe539e830a4898e7c6d10203a325ff1a4dc93af84ca"} 18:25:29 INFO - Running post-run listener: copy_logs_to_upload_dir 18:25:29 INFO - Copying logs to upload dir... 18:25:29 INFO - mkdir: /builds/slave/test/build/upload/logs 18:25:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.946905 ========= master_lag: 1.16 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-16 18:25:30.865911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 18:25:30.869369) ========= 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.SjreX73uBq/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.pk3PdmhtBI/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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/bcc8c9d5fa6f61d3357181d4c6795b88c73e546e4d62d71832108f79651c0393174cd0d9fddafabaf6e2780041574877f4511f4ce9bd44514c866947f2ff8dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca3dd08a226a3e5544c00396c5a3ff59a5cdee9bba95edf323cd533dd677609022082335050669ac516125418ab5b62e943e2f87ff31c8e5955c1066ae99d715", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f79beb2d2759d40afdcc05c3195ea31e27edff90cf51670f168f369f495453573fc4d892fa868cad8162fe539e830a4898e7c6d10203a325ff1a4dc93af84ca"} build_url:https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010886 build_url: 'https://queue.taskcluster.net/v1/task/e-j0FxuvRBqAW98uVAVppQ/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/bcc8c9d5fa6f61d3357181d4c6795b88c73e546e4d62d71832108f79651c0393174cd0d9fddafabaf6e2780041574877f4511f4ce9bd44514c866947f2ff8dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca3dd08a226a3e5544c00396c5a3ff59a5cdee9bba95edf323cd533dd677609022082335050669ac516125418ab5b62e943e2f87ff31c8e5955c1066ae99d715", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f79beb2d2759d40afdcc05c3195ea31e27edff90cf51670f168f369f495453573fc4d892fa868cad8162fe539e830a4898e7c6d10203a325ff1a4dc93af84ca"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 18:25:30.910976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:25:30.911296) ========= 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.SjreX73uBq/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.pk3PdmhtBI/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.004995 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:25:31.053984) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 18:25:31.054316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 18:25:31.280706) ========= ========= Total master_lag: 4.25 =========