builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0317 starttime: 1489449552.07 results: success (0) buildid: 20170313154936 builduid: 25030b5ae505470498822f2cffd7f964 revision: a5ccc32310c9a424ccb4f5106f5155ca20dd360a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.069970) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.070378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.070694) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.095653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.096018) ========= 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.znwGKrWKF5/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.wCUUa3ShcG/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-13 16:59:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 204M=0s 2017-03-13 16:59:12 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139979 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.400524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.400863) ========= 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.znwGKrWKF5/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.wCUUa3ShcG/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.020805 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.443785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:12.444136) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a5ccc32310c9a424ccb4f5106f5155ca20dd360a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a5ccc32310c9a424ccb4f5106f5155ca20dd360a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.znwGKrWKF5/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.wCUUa3ShcG/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-13 16:59:12,536 truncating revision to first 12 chars 2017-03-13 16:59:12,536 Setting DEBUG logging. 2017-03-13 16:59:12,536 attempt 1/10 2017-03-13 16:59:12,536 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a5ccc32310c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 16:59:13,202 unpacking tar archive at: mozilla-beta-a5ccc32310c9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.955206 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:13.424994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:13.425579) ========= script_repo_revision: a5ccc32310c9a424ccb4f5106f5155ca20dd360a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:13.426070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:13.426337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 16:59:13.447263) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-13 16:59:13.447723) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.znwGKrWKF5/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.wCUUa3ShcG/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:13 INFO - MultiFileLogger online at 20170313 16:59:13 in /builds/slave/test 16:59:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:59:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:13 INFO - {'append_to_log': False, 16:59:13 INFO - 'base_work_dir': '/builds/slave/test', 16:59:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:59:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:13 INFO - 'branch': 'Mozilla-Beta', 16:59:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:13 INFO - 'config_files': ('talos/mac_config.py',), 16:59:13 INFO - 'default_actions': ('clobber', 16:59:13 INFO - 'read-buildbot-config', 16:59:13 INFO - 'download-and-extract', 16:59:13 INFO - 'populate-webroot', 16:59:13 INFO - 'create-virtualenv', 16:59:13 INFO - 'install', 16:59:13 INFO - 'run-tests'), 16:59:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:13 INFO - 'download_minidump_stackwalk': True, 16:59:13 INFO - 'download_symbols': 'ondemand', 16:59:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:13 INFO - 'installer_path': 'installer.exe', 16:59:13 INFO - 'log_level': 'info', 16:59:13 INFO - 'log_name': 'talos', 16:59:13 INFO - 'log_to_console': True, 16:59:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:59:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:59:13 INFO - 'opt_config_files': (), 16:59:13 INFO - 'pip_index': False, 16:59:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:59:13 INFO - 'cmd': ('bash', 16:59:13 INFO - '-c', 16:59:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:59:13 INFO - 'enabled': True, 16:59:13 INFO - 'halt_on_failure': False, 16:59:13 INFO - 'name': 'check_screen_resolution'},), 16:59:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:59:13 INFO - 'cmd': ('bash', 16:59:13 INFO - '-c', 16:59:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:59:13 INFO - 'enabled': True, 16:59:13 INFO - 'halt_on_failure': False, 16:59:13 INFO - 'name': 'check_screen_resolution'},), 16:59:13 INFO - 'run_cmd_checks_enabled': True, 16:59:13 INFO - 'sps_profile': False, 16:59:13 INFO - 'sps_profile_interval': 0, 16:59:13 INFO - 'suite': 'dromaeojs', 16:59:13 INFO - 'system_bits': '32', 16:59:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:13 INFO - 'title': 't-yosemite-r7-0317', 16:59:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:13 INFO - 'use_talos_json': True, 16:59:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:13 INFO - 'work_dir': 'build'} 16:59:13 INFO - [mozharness: 2017-03-13 23:59:13.661618Z] Running clobber step. 16:59:13 INFO - Running pre-action listener: _resource_record_pre_action 16:59:13 INFO - Running main action method: clobber 16:59:13 INFO - rmtree: /builds/slave/test/build 16:59:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:15 INFO - Running post-action listener: _resource_record_post_action 16:59:15 INFO - [mozharness: 2017-03-13 23:59:15.485466Z] Finished clobber step (success) 16:59:15 INFO - [mozharness: 2017-03-13 23:59:15.485619Z] Running read-buildbot-config step. 16:59:15 INFO - Running pre-action listener: _resource_record_pre_action 16:59:15 INFO - Running main action method: read_buildbot_config 16:59:15 INFO - Using buildbot properties: 16:59:15 INFO - { 16:59:15 INFO - "project": "", 16:59:15 INFO - "product": "firefox", 16:59:15 INFO - "script_repo_revision": "production", 16:59:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 16:59:15 INFO - "repository": "", 16:59:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 16:59:15 INFO - "buildid": "20170313154936", 16:59:15 INFO - "pgo_build": "False", 16:59:15 INFO - "basedir": "/builds/slave/test", 16:59:15 INFO - "buildnumber": 4, 16:59:15 INFO - "slavename": "t-yosemite-r7-0317", 16:59:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:59:15 INFO - "platform": "yosemite_r7", 16:59:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:59:15 INFO - "branch": "mozilla-beta", 16:59:15 INFO - "repo_path": "releases/mozilla-beta", 16:59:15 INFO - "revision": "a5ccc32310c9a424ccb4f5106f5155ca20dd360a", 16:59:15 INFO - "stage_platform": "macosx64", 16:59:15 INFO - "builduid": "25030b5ae505470498822f2cffd7f964", 16:59:15 INFO - "slavebuilddir": "test" 16:59:15 INFO - } 16:59:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 16:59:15 INFO - Running post-action listener: _resource_record_post_action 16:59:15 INFO - [mozharness: 2017-03-13 23:59:15.489019Z] Finished read-buildbot-config step (success) 16:59:15 INFO - [mozharness: 2017-03-13 23:59:15.489126Z] Running download-and-extract step. 16:59:15 INFO - Running pre-action listener: _resource_record_pre_action 16:59:15 INFO - Running main action method: download_and_extract 16:59:15 INFO - mkdir: /builds/slave/test/build/tests 16:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:15 INFO - trying https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 16:59:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 16:59:16 INFO - Downloaded 1165 bytes. 16:59:16 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:59:16 INFO - Using the following test package requirements: 16:59:16 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:59:16 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:59:16 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 16:59:16 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:59:16 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 16:59:16 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:59:16 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:59:16 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 16:59:16 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:59:16 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:59:16 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 16:59:16 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:59:16 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 16:59:16 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:59:16 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 16:59:16 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:59:16 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 16:59:16 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 16:59:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:59:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:59:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:59:17 INFO - Expected file size: 16104305 16:59:17 INFO - Obtained file size: 16104305 16:59:24 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:59:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:59:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:59:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:59:25 INFO - Expected file size: 16104305 16:59:25 INFO - Obtained file size: 16104305 16:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 16:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 16:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 16:59:32 INFO - Expected file size: 14403650 16:59:32 INFO - Obtained file size: 14403650 16:59:32 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')]} 16:59:32 INFO - trying https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:59:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 16:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 16:59:34 INFO - Downloaded 58692119 bytes. 16:59:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:59:34 INFO - mkdir: /builds/slave/test/properties 16:59:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:34 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:34 INFO - Contents: 16:59:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:59:35 INFO - Running post-action listener: _resource_record_post_action 16:59:35 INFO - Running post-action listener: set_extra_try_arguments 16:59:35 INFO - [mozharness: 2017-03-13 23:59:35.127400Z] Finished download-and-extract step (success) 16:59:35 INFO - [mozharness: 2017-03-13 23:59:35.127552Z] Running populate-webroot step. 16:59:35 INFO - Running pre-action listener: _resource_record_pre_action 16:59:35 INFO - Running main action method: populate_webroot 16:59:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:35 INFO - '--tppagecycles', 16:59:35 INFO - '7'], 16:59:35 INFO - 'tests': ['tsvgm']}}, 16:59:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:59:35 INFO - 'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:59:35 INFO - 'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['damp', 'tps']}, 16:59:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:59:35 INFO - 'tests': ['damp', 'tps']}, 16:59:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['dromaeo_dom']}, 16:59:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['basic_compositor_video']}, 16:59:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:59:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['tsvgx', 16:59:35 INFO - 'tsvgr_opacity', 16:59:35 INFO - 'tart', 16:59:35 INFO - 'tscrollx', 16:59:35 INFO - 'cart', 16:59:35 INFO - 'tsvg_static']}, 16:59:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:35 INFO - 'tsvgr_opacity', 16:59:35 INFO - 'tart', 16:59:35 INFO - 'tscrollx', 16:59:35 INFO - 'cart', 16:59:35 INFO - 'tsvg_static']}, 16:59:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:59:35 INFO - 'talos_options': ['--disable-e10s'], 16:59:35 INFO - 'tests': ['tp5o']}, 16:59:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:59:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:59:35 INFO - 'talos_options': ['--disable-e10s', 16:59:35 INFO - '--xperf_path', 16:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:35 INFO - 'tests': ['tp5n']}, 16:59:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:59:35 INFO - 'talos_options': ['--xperf_path', 16:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:35 INFO - 'tests': ['tp5n']}}, 16:59:35 INFO - 'talos.zip': {'path': '', 16:59:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:35 INFO - Running post-action listener: _resource_record_post_action 16:59:35 INFO - [mozharness: 2017-03-13 23:59:35.145738Z] Finished populate-webroot step (success) 16:59:35 INFO - [mozharness: 2017-03-13 23:59:35.145880Z] Running create-virtualenv step. 16:59:35 INFO - Running pre-action listener: _resource_record_pre_action 16:59:35 INFO - Running main action method: create_virtualenv 16:59:35 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:35 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 16:59:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:59:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:35 INFO - Using real prefix '/tools/python27' 16:59:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:38 INFO - Installing pip.................done. 16:59:38 INFO - Return code: 0 16:59:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:59:39 INFO - Reading from file tmpfile_stdout 16:59:39 INFO - Output received: 16:59:39 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) 16:59:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59:39 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')]} 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:39 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')]} 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:39 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:39 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 16:59:39 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 16:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 16:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:39 INFO - 'HOME': '/Users/cltbld', 16:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:39 INFO - 'LOGNAME': 'cltbld', 16:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:39 INFO - 'MOZ_NO_REMOTE': '1', 16:59:39 INFO - 'NO_EM_RESTART': '1', 16:59:39 INFO - 'PAGER': '/bin/cat', 16:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:39 INFO - 'PWD': '/builds/slave/test', 16:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:39 INFO - 'SHELL': '/bin/bash', 16:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 16:59:39 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 16:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:39 INFO - 'USER': 'cltbld', 16:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:39 INFO - 'XPC_FLAGS': '0x0', 16:59:39 INFO - 'XPC_SERVICE_NAME': '0', 16:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:39 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 16:59:39 INFO - Cleaning up... 16:59:39 INFO - Return code: 0 16:59:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:59:39 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')]} 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:39 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')]} 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:39 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:39 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 16:59:39 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 16:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 16:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:39 INFO - 'HOME': '/Users/cltbld', 16:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:39 INFO - 'LOGNAME': 'cltbld', 16:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:39 INFO - 'MOZ_NO_REMOTE': '1', 16:59:39 INFO - 'NO_EM_RESTART': '1', 16:59:39 INFO - 'PAGER': '/bin/cat', 16:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:39 INFO - 'PWD': '/builds/slave/test', 16:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:39 INFO - 'SHELL': '/bin/bash', 16:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 16:59:39 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 16:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:39 INFO - 'USER': 'cltbld', 16:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:39 INFO - 'XPC_FLAGS': '0x0', 16:59:39 INFO - 'XPC_SERVICE_NAME': '0', 16:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:39 INFO - Downloading/unpacking psutil>=3.1.1 16:59:39 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 16:59:39 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 16:59:39 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 16:59:39 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 16:59:39 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 16:59:39 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 16:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:43 INFO - Installing collected packages: psutil 16:59:43 INFO - Running setup.py install for psutil 16:59:43 INFO - building 'psutil._psutil_osx' extension 16:59:43 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 16:59:43 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 16:59:43 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 16:59:43 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 16:59:43 INFO - building 'psutil._psutil_posix' extension 16:59:43 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 16:59:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:59:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:59:43 INFO - ^ 16:59:43 INFO - 1 warning generated. 16:59:43 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 16:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:43 INFO - Successfully installed psutil 16:59:43 INFO - Cleaning up... 16:59:43 INFO - Return code: 0 16:59:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 16:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:43 INFO - 'HOME': '/Users/cltbld', 16:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:43 INFO - 'LOGNAME': 'cltbld', 16:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:43 INFO - 'MOZ_NO_REMOTE': '1', 16:59:43 INFO - 'NO_EM_RESTART': '1', 16:59:43 INFO - 'PAGER': '/bin/cat', 16:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:43 INFO - 'PWD': '/builds/slave/test', 16:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:43 INFO - 'SHELL': '/bin/bash', 16:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 16:59:43 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 16:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:43 INFO - 'USER': 'cltbld', 16:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:43 INFO - 'XPC_FLAGS': '0x0', 16:59:43 INFO - 'XPC_SERVICE_NAME': '0', 16:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:59:44 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 16:59:44 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 16:59:44 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 16:59:44 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 16:59:44 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 16:59:44 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 16:59:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:59:46 INFO - Installing collected packages: mozsystemmonitor 16:59:46 INFO - Running setup.py install for mozsystemmonitor 16:59:46 INFO - Successfully installed mozsystemmonitor 16:59:46 INFO - Cleaning up... 16:59:47 INFO - Return code: 0 16:59:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:59:47 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')]} 16:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:47 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')]} 16:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:47 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:47 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 16:59:47 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 16:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 16:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:47 INFO - 'HOME': '/Users/cltbld', 16:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:47 INFO - 'LOGNAME': 'cltbld', 16:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:47 INFO - 'MOZ_NO_REMOTE': '1', 16:59:47 INFO - 'NO_EM_RESTART': '1', 16:59:47 INFO - 'PAGER': '/bin/cat', 16:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:47 INFO - 'PWD': '/builds/slave/test', 16:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:47 INFO - 'SHELL': '/bin/bash', 16:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 16:59:47 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 16:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:47 INFO - 'USER': 'cltbld', 16:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:47 INFO - 'XPC_FLAGS': '0x0', 16:59:47 INFO - 'XPC_SERVICE_NAME': '0', 16:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:47 INFO - Downloading/unpacking jsonschema==2.5.1 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:59:49 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 16:59:49 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 16:59:49 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 16:59:49 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 16:59:49 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 16:59:49 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 16:59:50 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:50 INFO - warning: no files found matching '*.txt' 16:59:50 INFO - no previously-included directories found matching 'build' 16:59:50 INFO - no previously-included directories found matching 'dist' 16:59:50 INFO - no previously-included directories found matching '.git*' 16:59:50 INFO - Installing collected packages: jsonschema, functools32 16:59:50 INFO - Running setup.py install for functools32 16:59:50 INFO - warning: no files found matching '*.txt' 16:59:50 INFO - no previously-included directories found matching 'build' 16:59:50 INFO - no previously-included directories found matching 'dist' 16:59:50 INFO - no previously-included directories found matching '.git*' 16:59:50 INFO - Successfully installed jsonschema functools32 16:59:50 INFO - Cleaning up... 16:59:50 INFO - Return code: 0 16:59:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:59:50 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')]} 16:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:50 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')]} 16:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:50 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:50 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 16:59:50 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 16:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 16:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:50 INFO - 'HOME': '/Users/cltbld', 16:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:50 INFO - 'LOGNAME': 'cltbld', 16:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:50 INFO - 'MOZ_NO_REMOTE': '1', 16:59:50 INFO - 'NO_EM_RESTART': '1', 16:59:50 INFO - 'PAGER': '/bin/cat', 16:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:50 INFO - 'PWD': '/builds/slave/test', 16:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:50 INFO - 'SHELL': '/bin/bash', 16:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 16:59:50 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 16:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:50 INFO - 'USER': 'cltbld', 16:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:50 INFO - 'XPC_FLAGS': '0x0', 16:59:50 INFO - 'XPC_SERVICE_NAME': '0', 16:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:59:50 INFO - Cleaning up... 16:59:50 INFO - Return code: 0 16:59:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:59:50 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')]} 16:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:50 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')]} 16:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:50 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:50 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 16:59:50 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 16:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 16:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:50 INFO - 'HOME': '/Users/cltbld', 16:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:50 INFO - 'LOGNAME': 'cltbld', 16:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:50 INFO - 'MOZ_NO_REMOTE': '1', 16:59:50 INFO - 'NO_EM_RESTART': '1', 16:59:50 INFO - 'PAGER': '/bin/cat', 16:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:50 INFO - 'PWD': '/builds/slave/test', 16:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:50 INFO - 'SHELL': '/bin/bash', 16:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 16:59:50 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 16:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:50 INFO - 'USER': 'cltbld', 16:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:50 INFO - 'XPC_FLAGS': '0x0', 16:59:50 INFO - 'XPC_SERVICE_NAME': '0', 16:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:51 INFO - Downloading/unpacking blobuploader==1.2.4 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:53 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:59:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59:54 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 16:59:54 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 16:59:54 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 16:59:54 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 16:59:54 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 16:59:54 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 16:59:55 INFO - Downloading docopt-0.6.1.tar.gz 16:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:55 INFO - Running setup.py install for blobuploader 16:59:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:59:55 INFO - Running setup.py install for requests 16:59:55 INFO - Running setup.py install for docopt 16:59:55 INFO - Successfully installed blobuploader requests docopt 16:59:55 INFO - Cleaning up... 16:59:56 INFO - Return code: 0 16:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:56 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 16:59:56 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 16:59:56 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 16:59:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 16:59:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:56 INFO - 'HOME': '/Users/cltbld', 16:59:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:56 INFO - 'LOGNAME': 'cltbld', 16:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:56 INFO - 'MOZ_NO_REMOTE': '1', 16:59:56 INFO - 'NO_EM_RESTART': '1', 16:59:56 INFO - 'PAGER': '/bin/cat', 16:59:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:56 INFO - 'PWD': '/builds/slave/test', 16:59:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:56 INFO - 'SHELL': '/bin/bash', 16:59:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 16:59:56 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 16:59:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:56 INFO - 'USER': 'cltbld', 16:59:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:56 INFO - 'XPC_FLAGS': '0x0', 16:59:56 INFO - 'XPC_SERVICE_NAME': '0', 16:59:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-8J6OHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-sW5D8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fFmorh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-hFIu5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-2FHcJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9AfolD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-tsEIiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-BpYtPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-rSmSBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-bRlNgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-uSnnAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-_TQOX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-vp8ky7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-zqL6cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-tAeF60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-zVfRMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:57 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wPluoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:58 INFO - Running setup.py install for manifestparser 16:59:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:59:58 INFO - Running setup.py install for mozcrash 16:59:58 INFO - Running setup.py install for mozdebug 16:59:58 INFO - Running setup.py install for mozdevice 16:59:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:59:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:59:58 INFO - Running setup.py install for mozfile 16:59:58 INFO - Running setup.py install for mozhttpd 16:59:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:59:58 INFO - Running setup.py install for mozinfo 16:59:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozInstall 16:59:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozleak 16:59:59 INFO - Running setup.py install for mozlog 16:59:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for moznetwork 16:59:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozprocess 16:59:59 INFO - Running setup.py install for mozprofile 16:59:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozrunner 17:00:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Running setup.py install for mozscreenshot 17:00:00 INFO - Running setup.py install for moztest 17:00:00 INFO - Running setup.py install for mozversion 17:00:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:00 INFO - Cleaning up... 17:00:00 INFO - Return code: 0 17:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:00 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')]} 17:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:00 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')]} 17:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:01 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 17:00:01 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 17:00:01 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 17:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 17:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:01 INFO - 'HOME': '/Users/cltbld', 17:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:01 INFO - 'LOGNAME': 'cltbld', 17:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:01 INFO - 'MOZ_NO_REMOTE': '1', 17:00:01 INFO - 'NO_EM_RESTART': '1', 17:00:01 INFO - 'PAGER': '/bin/cat', 17:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:01 INFO - 'PWD': '/builds/slave/test', 17:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:01 INFO - 'SHELL': '/bin/bash', 17:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 17:00:01 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:01 INFO - 'USER': 'cltbld', 17:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:01 INFO - 'XPC_FLAGS': '0x0', 17:00:01 INFO - 'XPC_SERVICE_NAME': '0', 17:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-X_Po_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-IUFPZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9lipM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wIygRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4AkJyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-m6fC0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-x7v7G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-P1xGGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-bkiolv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-C_GmXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-kCtKSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-avRRcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-pvK_eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-lF_VAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-PTAU24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:03 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)) 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:03 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Vm65Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:03 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Ao3tgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:03 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)) 17:00:03 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)) 17:00:03 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)) 17:00:03 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)) 17:00:03 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)) 17:00:03 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)) 17:00:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:05 INFO - Downloading blessings-1.6.tar.gz 17:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:05 INFO - Installing collected packages: blessings 17:00:05 INFO - Running setup.py install for blessings 17:00:06 INFO - Successfully installed blessings 17:00:06 INFO - Cleaning up... 17:00:06 INFO - Return code: 0 17:00:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:06 INFO - Reading from file tmpfile_stdout 17:00:06 INFO - Current package versions: 17:00:06 INFO - blessings == 1.6 17:00:06 INFO - blobuploader == 1.2.4 17:00:06 INFO - docopt == 0.6.1 17:00:06 INFO - functools32 == 3.2.3-2 17:00:06 INFO - jsonschema == 2.5.1 17:00:06 INFO - manifestparser == 1.1 17:00:06 INFO - mozInstall == 1.12 17:00:06 INFO - mozcrash == 1.0 17:00:06 INFO - mozdebug == 0.1 17:00:06 INFO - mozdevice == 0.49 17:00:06 INFO - mozfile == 1.2 17:00:06 INFO - mozhttpd == 0.7 17:00:06 INFO - mozinfo == 0.9 17:00:06 INFO - mozleak == 0.1 17:00:06 INFO - mozlog == 3.4 17:00:06 INFO - moznetwork == 0.27 17:00:06 INFO - mozprocess == 0.24 17:00:06 INFO - mozprofile == 0.28 17:00:06 INFO - mozrunner == 6.13 17:00:06 INFO - mozscreenshot == 0.1 17:00:06 INFO - mozsystemmonitor == 0.3 17:00:06 INFO - moztest == 0.8 17:00:06 INFO - mozversion == 1.4 17:00:06 INFO - psutil == 3.1.1 17:00:06 INFO - requests == 1.2.3 17:00:06 INFO - wsgiref == 0.1.2 17:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:06 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')]} 17:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:06 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')]} 17:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:06 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 17:00:06 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 17:00:06 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 17:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 17:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:06 INFO - 'HOME': '/Users/cltbld', 17:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:06 INFO - 'LOGNAME': 'cltbld', 17:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:06 INFO - 'MOZ_NO_REMOTE': '1', 17:00:06 INFO - 'NO_EM_RESTART': '1', 17:00:06 INFO - 'PAGER': '/bin/cat', 17:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:06 INFO - 'PWD': '/builds/slave/test', 17:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:06 INFO - 'SHELL': '/bin/bash', 17:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 17:00:06 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:06 INFO - 'USER': 'cltbld', 17:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:06 INFO - 'XPC_FLAGS': '0x0', 17:00:06 INFO - 'XPC_SERVICE_NAME': '0', 17:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 INFO - Cleaning up... 17:00:06 INFO - Return code: 0 17:00:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00:06 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')]} 17:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:06 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')]} 17:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:06 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 0x10ecdfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bcad64450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, '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.znwGKrWKF5/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.wCUUa3ShcG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 17:00:06 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 17:00:06 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 17:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 17:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:06 INFO - 'HOME': '/Users/cltbld', 17:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:06 INFO - 'LOGNAME': 'cltbld', 17:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:06 INFO - 'MOZ_NO_REMOTE': '1', 17:00:06 INFO - 'NO_EM_RESTART': '1', 17:00:06 INFO - 'PAGER': '/bin/cat', 17:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:06 INFO - 'PWD': '/builds/slave/test', 17:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:06 INFO - 'SHELL': '/bin/bash', 17:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 17:00:06 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:06 INFO - 'USER': 'cltbld', 17:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:06 INFO - 'XPC_FLAGS': '0x0', 17:00:06 INFO - 'XPC_SERVICE_NAME': '0', 17:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:00:07 INFO - Cleaning up... 17:00:07 INFO - Return code: 0 17:00:07 INFO - Running post-action listener: _resource_record_post_action 17:00:07 INFO - Running post-action listener: _start_resource_monitoring 17:00:07 INFO - Starting resource monitoring. 17:00:07 INFO - [mozharness: 2017-03-14 00:00:07.072683Z] Finished create-virtualenv step (success) 17:00:07 INFO - [mozharness: 2017-03-14 00:00:07.073725Z] Running install step. 17:00:07 INFO - Running pre-action listener: _resource_record_pre_action 17:00:07 INFO - Running main action method: install 17:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:07 INFO - Reading from file tmpfile_stdout 17:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:07 INFO - Reading from file tmpfile_stdout 17:00:07 INFO - Output received: 17:00:07 INFO - Usage: mozinstall [options] installer 17:00:07 INFO - Options: 17:00:07 INFO - -h, --help show this help message and exit 17:00:07 INFO - -d DEST, --destination=DEST 17:00:07 INFO - Directory to install application into. [default: 17:00:07 INFO - "/builds/slave/test"] 17:00:07 INFO - --app=APP Application being installed. [default: firefox] 17:00:07 INFO - mkdir: /builds/slave/test/build/application 17:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:00:22 INFO - Reading from file tmpfile_stdout 17:00:22 INFO - Output received: 17:00:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:00:22 INFO - Running post-action listener: _resource_record_post_action 17:00:22 INFO - [mozharness: 2017-03-14 00:00:22.140534Z] Finished install step (success) 17:00:22 INFO - [mozharness: 2017-03-14 00:00:22.140687Z] Running run-tests step. 17:00:22 INFO - Running pre-action listener: _resource_record_pre_action 17:00:22 INFO - Running main action method: run_tests 17:00:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:00:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:00:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:00:22 INFO - 2017-03-13 17:00:22.155 screenresolution[2177:25017] starting screenresolution argv=screenresolution get 17:00:22 INFO - 2017-03-13 17:00:22.158 screenresolution[2177:25017] Display 0: 1600x1200x32@60 17:00:22 INFO - 2017-03-13 17:00:22.163 screenresolution[2178:25019] starting screenresolution argv=screenresolution list 17:00:22 INFO - Available Modes on Display 0 17:00:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:00:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:00:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:00:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:00:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:00:22 INFO - Intel Iris: 17:00:22 INFO - Chipset Model: Intel Iris 17:00:22 INFO - Type: GPU 17:00:22 INFO - Bus: Built-In 17:00:22 INFO - VRAM (Dynamic, Max): 1536 MB 17:00:22 INFO - Vendor: Intel (0x8086) 17:00:22 INFO - Device ID: 0x0a2e 17:00:22 INFO - Revision ID: 0x0009 17:00:22 INFO - Displays: 17:00:22 INFO - Display: 17:00:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:00:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:00:22 INFO - Display Serial Number: 1600x1200 60 17:00:22 INFO - Main Display: Yes 17:00:22 INFO - Mirror: Off 17:00:22 INFO - Online: Yes 17:00:22 INFO - Rotation: Supported 17:00:22 INFO - Return code: 0 17:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:22 INFO - Python 2.7.3 17:00:22 INFO - Return code: 0 17:00:22 INFO - grabbing minidump binary from tooltool 17:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:22 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 0x10eabdd30>, '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 0x10e9e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eab2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00:22 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 17:00:22 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 17:00:22 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 17:00:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:22 INFO - Return code: 0 17:00:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:00:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 17:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --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 17:00:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.znwGKrWKF5/Render', 17:00:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:22 INFO - 'HOME': '/Users/cltbld', 17:00:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:22 INFO - 'LOGNAME': 'cltbld', 17:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:22 INFO - 'MOZ_NO_REMOTE': '1', 17:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:22 INFO - 'NO_EM_RESTART': '1', 17:00:22 INFO - 'PAGER': '/bin/cat', 17:00:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:22 INFO - 'PWD': '/builds/slave/test', 17:00:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:22 INFO - 'SHELL': '/bin/bash', 17:00:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wCUUa3ShcG/Listeners', 17:00:22 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:00:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:22 INFO - 'USER': 'cltbld', 17:00:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:22 INFO - 'XPC_FLAGS': '0x0', 17:00:22 INFO - 'XPC_SERVICE_NAME': '0', 17:00:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 17:00:22 INFO - mozversion application_buildid: 20170313154936 17:00:22 INFO - mozversion application_changeset: a5ccc32310c9a424ccb4f5106f5155ca20dd360a 17:00:22 INFO - mozversion application_display_name: Firefox 17:00:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:22 INFO - mozversion application_name: Firefox 17:00:22 INFO - mozversion application_remotingname: firefox 17:00:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:00:22 INFO - mozversion application_vendor: Mozilla 17:00:22 INFO - mozversion application_version: 53.0 17:00:22 INFO - mozversion platform_buildid: 20170313154936 17:00:22 INFO - mozversion platform_changeset: a5ccc32310c9a424ccb4f5106f5155ca20dd360a 17:00:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:00:22 INFO - mozversion platform_version: 53.0 17:00:22 INFO - using testdate: 1489449622 17:00:22 INFO - actual date: 1489449622 17:00:22 INFO - starting webserver on 'localhost:56677' 17:00:22 INFO - SUITE-START | Running 2 tests 17:00:22 INFO - TEST-START | dromaeo_css 17:00:22 INFO - operating with platform_type : mac_ 17:00:22 INFO - Initialising browser for dromaeo_css test... 17:00:22 INFO - TEST-INFO | started process 2188 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmp3n0GIU/profile http://localhost:56677/getInfo.html) 17:00:24 INFO - PROCESS | 2188 | __metrics Screen width/height:1600/1200 17:00:24 INFO - PROCESS | 2188 | colorDepth:24 17:00:24 INFO - PROCESS | 2188 | Browser inner width/height: 1024/689 17:00:24 INFO - PROCESS | 2188 | __metrics 17:00:25 INFO - PROCESS | 2188 | 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" 17:00:25 INFO - PROCESS | 2188 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:25 INFO - TEST-INFO | 2188: exit 0 17:00:25 INFO - Browser initialized. 17:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:25 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmp3n0GIU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:37 INFO - PROCESS | 2191 | RSS: Main: 162816000 17:00:37 INFO - PROCESS | 2191 | 17:03:41 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:56677/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56677/tests/dromaeo/cssquery-ext.html) 17:03:42 INFO - PROCESS | 2191 | RSS: Main: 297254912 17:03:42 INFO - PROCESS | 2191 | 17:06:45 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:56677/tests/dromaeo/cssquery-ext.html (next: http://localhost:56677/tests/dromaeo/cssquery-jquery.html) 17:06:46 INFO - PROCESS | 2191 | RSS: Main: 301735936 17:06:46 INFO - PROCESS | 2191 | 17:09:48 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:56677/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56677/tests/dromaeo/cssquery-mootools.html) 17:09:48 INFO - PROCESS | 2191 | RSS: Main: 270483456 17:09:48 INFO - PROCESS | 2191 | 17:12:51 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:56677/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56677/tests/dromaeo/cssquery-prototype.html) 17:12:51 INFO - PROCESS | 2191 | RSS: Main: 268607488 17:12:51 INFO - PROCESS | 2191 | 17:15:55 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:56677/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56677/tests/dromaeo/cssquery-yui.html) 17:15:55 INFO - PROCESS | 2191 | RSS: Main: 273018880 17:15:55 INFO - PROCESS | 2191 | 17:18:58 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:56677/tests/dromaeo/cssquery-yui.html (next: http://localhost:56677/tests/dromaeo/cssquery-dojo.html) 17:18:59 INFO - PROCESS | 2191 | RSS: Main: 470880256 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | __start_tp_report 17:18:59 INFO - PROCESS | 2191 | _x_x_mozilla_page_load 17:18:59 INFO - PROCESS | 2191 | _x_x_mozilla_page_load_details 17:18:59 INFO - PROCESS | 2191 | |i|pagename|runs| 17:18:59 INFO - PROCESS | 2191 | |0;dojo.html;3456.8098754568496;3464.2551851351955;3499.3876071687464;3512.5784905811274;3531.4879342495337;5880.55895807814;5881.147233651123;5898.115282707596;5906.970465147679;5911.349751527328;5879.617824841383;5942.970285148568;5947.197128387677;5967.4927631151295;5968.40315968403;4328.415663885383;5243.659162154467;5281;5338.546223571001;5362.544183744387;5232.084385232569;5249.606279529032;5269.314989051418;5274.81538146165;5349.277847490578;5311.601629877755;5329.840104796862;5334.066538355792;5366.91949620756;5387.649802762828;5332.760025798849;5334.306540149756;5334.306540149756;5335.093034184198;5385.192221166817;5070.7464626768515;5163.225516172567;5187.273781670569;5273.683578985273;5297.841064768063;5800.216970708984;5832.270966129234;5851.210086638292;5861.472467477947;5897.233359663259;6220.098085777537;6240.937590624127;6261.906071408933;6269.216347956505;6277.843053923689;6145.678679083973;6243.719032643542;6294.685265736741;6295.590786598902;6299.401556852092;5930.614510056833;5975.880482390327;6031.909521357183;6057.182280392179;6089.543284253698;5712.885987232533;6361.777337793155;6392.872142557123;6404.935950640434;6429;4921.409430868247;6255.624662520263;6311.873762524724;6327;6344.111824344595;6170.352113028068;6214.161088253119;6223.751049958041;6250.40621141;6253.906191407133;6265.279492858289;6274.498040156776;6282.371762823773;6286.685665716695;6305.495560355161;6275.090111933744;6280.811575652738;6291;6292.465140463112;6294.181756371734;4942.752862356868;5004.874878128076;5021.899562008739;5022.372203474566;5061.8228362007885;4564.42944631921;4580.24425969718;4590.288505281686;4600.838970636011;4627.629789616823;6090.177825993523;6103.176071230416;6138.232720909887;6143.262808463013;6146.354632763585;6190.3190649028575;6209.782657606962;6288.654124023131;6296.244450665949;6306.716197771111;5977.491913187428;6045.939540604626;6048.213732214872;6049.727762250709;6059.48494377974;5562.554995600342;5570.275864137636;5570.888582228333;5573.108302671634;5573.968815769014;6346.524010699124;6375.330590287953;6386.201724784402;6393.520485963571;6428.742850286123;5156.4070131935305;6278.529110316653;6293.842653933688;6297.653629050446;6305.873882522415;6500.512461565307;6507.739690412331;6508.958566629317;6523.967380163069;6539.313372095861;6207.131001659862;6282.340354262919;6289.150964619901;6290.811275661737;6292.96166132583;6228.314885362697;6242.344553821783;6250.4374606285655;6268.780592679234;6276.184096067482;4527.932081018722;6264.561480696308;6278.309385967448;6283.905741413791;6291.528135389955;6258.186435763321;6277.3408792078;6281;6284.3087260402235;6307.558470906993;6073.848153796013;6106.7640410362355;6114.723190878713;6118.112873633388;6199.690015499117;6183.041628547582;6183.783567575113;6220.284667263141;6235;6235.96882015587;5813.2158502290495;6155.322914479314;6174.629522228681;6186.319504854552;6186.969065154645 17:18:59 INFO - PROCESS | 2191 | |1;ext.html;474.3430348966682;479.21887323662435;524.7717242999295;540.5378401466746;579.4553120067139;31897.68102318976;43040.92397690055;44465.11069778606;44522.88692782674;46235.76882115593;39664.80167599165;44274.55725442745;45473;45791;45905.770471147596;9658.613655453792;9868.654597089067;9882.456464894429;9899.45552994585;9913.553890074927;9260.53697315135;9473.95263023684;12001.399930003508;12254.264744115337;12258.509659613605;11220.438978051106;12291.877081229162;12372.690682732959;12382.876171238308;12396.628101156979;11211.327320360804;12223.2666040037;12231.021518278516;12236.265824050586;12238.32689202098;12024.639260822189;12106.092043096714;12111.576094836639;12120.878791212152;12122.333271670055;43281.350779738015;43534.91162720926;43555.346669799976;43594.78202608998;43605.12789744219;4101.159262351211;4147.875563733093;4149.356849688304;4150.377443383486;4163.437935878648;30975.91584294539;31853.681463185534;32689.34621307584;32792.04871561547;33379;3286.901392958215;3446.138465383654;3449.413599688034;3491.441369380887;3587.3901436755814;493651.5317423426;500004;503046;504327.9567204354;508221;66764.33235667678;67290.66354668293;67307.27888129564;67354;67394;70845.64577177184;71018.2898171022;71233.64383178155;71275.6436217826;71285;17289.56776080608;18078.00570968583;18107.366242181724;18122.365717199835;18141.63716725658;12615;13850.238236896867;13973.371198295898;13977.86022139786;13990.300484975915;15676.294566744524;16103.1143287118;16106.872518923563;16115.838841611669;16135.596610084607;8032.558209298545;8170.75487735357;8463.772752950788;8957.417767845069;8961.266813621778;838.0195171649185;903.6249956268207;904.5703290936752;908.4276905549593;948.9003654616304;31631.683683162875;32127.35745285081;32185.195370115933;32883.67116328854;32935.67064329374;881.828043531518;1098.7143342730947;1156.8785277545906;1207.3118322556234;1225.0995518294046;15172.620684482756;15391.153486558123;15625.921870390803;15710.9214453927;15715.264469621212;445428;447344.76327618153;448487;451803;547892;52300.73849630728;57734;58764.412355876746;59029.40970590325;64656.676716617054;1463.0636392708675;1497.6854860479204;1498.5429444019678;1511.1764088571754;1513.674559969612;29791.55312670268;31294.06117816469;31459.685403145675;31856;32052.67947320497;50178.4946451607;56114;57241.713791430775;60296.39703603083;60648.696756515936;617001;624741;624978;625687;625775;42790.786046069574;42982.570174297856;43050.138997219256;43551.78224108986;43657.781711091244;46013.309800352356;46500.767496162305;46599;46667.53332466632;47138.52861471342;30625;35570.64429355673;37357;38031.04922376962;39194.608053919095;37554;37945;38520;39121.60878391293;39267.80366098265;37017.44473832948;37328.813355933045;37585;37940.241195176495;38586.421203681406;31965.6803431972;34030.48954265738;34192.82903585466;34423.13942151366;34533;25407.6188857171;25572.8721356392;25929.962801488484;26178.08376706806;26353.341166470993 17:18:59 INFO - PROCESS | 2191 | |2;jquery.html;409.66202882621843;411.3254263008665;413.3345314044386;423.1558041706795;439.0713640650026;20379.796202037975;21043.894780526094;21717.67423488647;22163.224287149955;22486.988085536148;22453.989570469326;22647.77352226477;22697.65953510699;22976.195833145845;23140.0743970241;5364.839054828361;5866.442687944638;6209.565330426872;6212.565120441571;6214.5649804513705;5573.219749235111;5968.7612495500125;6219.844503887416;6288.779892703757;6367.4906007519285;6120.26556813183;6312.968435157818;6324;6325.3042165362;6331.620102793824;6146.7233974471255;6251.749930002795;6280.371962803706;6282.4974002079725;6300.716467758962;5981.401859814027;6125.509959203253;6169.105479705462;6173.197484327009;6225.066240063981;13981.440742370292;14174.716505669932;14184.290785460686;18114.547136321566;26870.5969410459;2639.6568446101883;2721.4012917158193;2723.101376545755;2724.5913113033007;2765.3777899972547;10340.689779306633;10388.740281492948;10522.684319470429;10843.024127828454;10878.673639790819;1832.2854086906118;1877.361697023005;1888.225827410755;1897.3454158315496;1911.2832687742098;130481.34759326142;133657;134571.32714336365;134813;136356;11834.585789497498;11853.644390668294;11985.760284794254;12019.819702704466;12189.207701499552;16309.59226019359;16345.918270408572;16348.427805026768;16350;16370.918145409196;8976;9162.450252984709;9168.908310916806;9201.263898888074;9294.72115836526;8143.307818835466;8182.1817818217705;8959.328050396247;8976;9151.908480915106;4804.413738257383;4862.6151527552165;4874.512548745168;4973.825916092919;4980.7509624518625;2016.9294074707316;2061.4331058958905;2072.5336799220054;2078.9792102078786;2080.583883223331;880.6037283222576;893.1961234888522;901.396064636695;910.349100393222;941.1388579449864;20514.974251287374;21433.57132857334;21434.892825536084;21435.78564214369;21438;928.5774972387547;946.2524605561667;946.3848498476045;951.3863558005187;956.6173530587821;9340.57967391469;10500.894991050145;11022.559097636005;11127.332360058423;11130.998210160962;621700;725476;764621;775729;800931;98363.48147520823;106686;107267;139162.30418847842;141459;1001.1340190734962;1016.187050359724;1049.8372752223418;1061.851340812287;1098.0721290509507;19558;20293.188272468935;20649.793502064786;20718.482037948568;20759.169633214504;59351.703241485244;59435.51411214754;60360.69819650874;60501;60516.092258617035;86761;87493;87496.02132569296;88423;89676.55161724411;7860.213978602094;8441.91558084436;8591.140885911358;8607.784805379664;8826.242390095842;10794;12726.68183295425;12822.935885320887;13299.335033248492;13432.126911750705;11148.163887708291;11268.436578171222;11358.829617555579;11624.476898539755;11723.179377443497;9664.71005869825;11115.833262500908;11375.089992800391;11675.007624352025;11732.589359372381;11294.152938529807;11541.82687259675;11614.303141811519;11662.183647144619;11897.702557436134;7481.4014878808475;7813.960930195312;8203.384746143944;8731.738047858575;8761.737147885573;10862.565497380016;11500.929832630207;11508.53965841357;11741.29552226869;11773.234739741889 17:18:59 INFO - PROCESS | 2191 | |3;mootools.html;1355.1462578575497;1368.226951772248;1370.9040367174302;1371.787372957192;1398.328802174956;7272.818179545514;8155.510669359835;8531.317494600433;8539.359548033899;8560.785980350487;7513.135989361225;7730.14476525634;7751.379889608832;7849.0973538043145;8313.334933205344;2180.716506854111;2213.656883183109;2323;2399.0883464283547;2404.8196385271085;2418.504206637635;2426.696662917135;2434.4157402223427;2437.3662847659557;2442.8167887408426;2332.078828862598;2379.298107058422;2383.21353953195;2385.3082606044227;2387.438951846315;2131.8294536437124;2205.0848897707433;2209.602271591113;2213.557288542282;2324.407276144589;2366.479374537599;2406.614941609334;2410.891509882042;2410.92767216982;2414;8458.830823383498;8510.44682095668;8522.062573116953;8527.403081784278;8563.10087440816;4835.202191638376;5254.474552544753;5277.076511610453;5279.52484276417;5291.259223708684;3354.7316214702764;3441.970313753448;3506.2286297014616;3553.1117220694828;3570.250247448039;1218.5004148299154;1227.846519185102;1273.2487832179058;1275.7512285104408;1302.3227921480777;10842.512086956027;10906.945465272702;10994.34033957965;10994.95547922946;10998.945005275002;3970.344893092665;4520.81916723334;4788.281757736298;4808.63935204861;4816.686915350491;9648.903510964801;9654;9658.034196580425;9662.71011869645;9671.90328096724;5383.0579648562125;5390.973045134828;5391.73041347931;5394.919076213781;5397.082495975694;4758.762061896891;4844.95155048452;4884.3161957326;4954.20732682769;4964.801407943714;3280.5407242986003;3735.215604722984;3878.9806050969564;3880.4373365861793;3893.6301051400073;1120.8542889424323;1300.2003767682806;1320.3068389095802;1321.134691413601;1344.1464669934662;914.8993610702818;916.2852974679761;935.2845073518764;936.5691781780321;972.1785091597588;5506.531944784658;5626.606137570413;5866.589338746332;5898.085796701518;5911.201987731687;837.9832403351899;1016.4752870693959;1029.089256008423;1039.9948000259951;1068.188176985481;3605.8016809075752;3719.6466335698065;3872.612738726105;3890.455336252927;3894.162755007687;9734.902650973541;10044.849327260097;10067.69796906094;10077.899221007843;10108;8942.792722982444;9751.90248097524;10026.64906728261;10035.79928401428;10046;7930.563818990011;8050.396220283502;8052.315553177928;8055.798605034804;8080.797980050545;5220;5424.403315635198;5657.12314591239;5694.259746233129;5877.441643044075;9151.130642588943;9367.297452691211;9368.906310936803;9386.906130938876;9405.717828464883;9090.954545227232;9369.765755856159;9411.717648470556;9607.855882161914;9636.42181469114;7156.177039640508;7161.606111663908;7196.424286057208;7252.7461538848;7295.671694773641;7220.855582888418;7849.372050236082;7914.762557123296;7916.445848790529;7920.762377128695;6837.35045170708;7222.025026621339;7257.383122434652;7296.562206267641;7327.230640782855;6961.965190174017;7000.0199972004975;7024.5434046786795;7027.789166325018;7068.540544864773;5500.862478438071;6348.682565871595;6456.903146452901;6475.352464753487;6506;4907.877303067452;4919.803207871788;4933.985378579787;5057;5173.948260517347;4975.477574854588;5059.215821547666;5085.491450855033;5108.28484012246;5131.332926719502 17:18:59 INFO - PROCESS | 2191 | |4;prototype.html;368.5374854557531;373.8654084529569;379.6677906831523;386.4126527677928;387.8616261273165;4396.428464299636;4869.634777391697;4933.679310844793;5223.6343455958095;5235.50262725041;5070;5138.306328645632;5157.432682404942;5261.552768014713;5297.284866543016;4143.212789569972;4155.898686847988;4166.187593419285;4169.457970463835;4170.165966806643;3569.3396721606455;4005.958450802798;4067.3085575452096;4088.5093788745394;4153.646940010103;3576.8926932192076;4087.937136344542;4093.3450647896343;4094.3858421236755;4100.63094321511;3604.711623070148;3756.2299728555718;4062.111118329976;4076.408920706481;4123;3093.2059405544956;3303.884364047247;3492.022233774547;3492.947605785915;3670.8436842394563;4713.293006049086;4833.800620717565;4980.975095124501;4988.900221995576;5047.905119375455;4592.6555508337005;4596.724196548218;4599.470291339783;4605.723656580582;4650.906981860344;4505.6708271060115;5480.438075148563;5516.586256030773;5575;5619.859503512404;3109.6268447786183;3238.4008958342783;3874.496315478998;3880.417937309398;3888.8833334999995;4899.534544218293;5133.4609865964285;5203.739813009334;5853.560982926298;5914.4381283777975;3325.8503367348526;3400.931981360359;3896.4350169225304;3958.950878017328;3967.7024223183375;3393.6606339365867;3458.342914846171;3848.4034974578985;3941.881743547698;3991.6008399160432;3836.8681239034554;4402.449693788277;4582.977085114553;4604.40142781443;4610.893385587502;5230.660007099526;5622.718864056781;5652.236948012048;5658.603897727119;5666.801661941812;1085.7134295859432;1123.4270522033657;1161.6863446869297;1240.4542001519303;1269.1433282534254;759.5290919629755;819.6270696832927;882.6954700628273;884.3544212724747;886.3485338276362;4173.4157217988895;4437.511873693891;4787.688800227974;4949.975250123726;5021.623378246573;4490.685652004328;5286.383240296078;5404;5412.563022480753;5531.3362396511875;4176.77027763476;4668.906621867612;4845.709257444564;4932.374704592122;4987.002599480118;2537.3656585853537;2673.5588627876573;2682.5305571524905;2730.621036376617;2851.657801063844;4842.370491836109;4873.756312184448;5389.946100539023;5598.216249725042;5600.831975040755;5134.71632091977;5381.461853814665;5568.832935011957;5601.775928962796;5662.405447428043;5611.018071837494;5622.887542249132;5631.014572449723;5639.971800140973;5684.289463817023;4718.669693121448;4818.855434336975;5050.696958182374;5272.367315922113;5369.677819330853;5135.026357380692;5250.164910948045;5252.684838909678;5289.413176047094;5311.229871668509;5185;5488.761630637943;5551.611387202857;5617.831465056055;5618.864831364055;3805.961940380561;3911.298585115484;3987.783725963493;4066.7153299268766;4074.5925407459017;4886.144924638245;5032.547070763649;5313.574914006947;5372.367539905496;5392.487713667196;4782.593479554138;5029.5221953914315;5138.820141295037;5301.734913254399;5504.587155963239;4683.250679891201;5455.072637651688;5500.442294333155;5532.474414930736;5546.112621980464;4387.36383224437;4809.48414093301;4941.925871111865;4962.652614316963;5439.646422982493;5296.947834906223;5486.890262194654;5577.2191893135805;5587.770690448095;5593.328800543961;4612.469565999953;4678.625709943264;4997.101101581376;5455.254318618004;5457.263269458731 17:18:59 INFO - PROCESS | 2191 | |5;yui.html;736.7421402509119;757.9886301705471;781.4295564238106;846.2172490446336;865.3812524045306;15097.773533396994;15742.21288935553;15785.526434206979;15794.763078553831;15809.446669366545;14365.640858978531;14382;14386.424543018293;14519.637009074751;14533.636659083502;721.3579913876654;748.120957874498;900.8963969143534;910.4719262827577;912.8767616371771;876.8027193881358;896.3814967672286;904.8642703594447;912.717057712108;914.862770584411;981.7202097402242;983.537737263485;985.8028394321128;985.9942858284545;986.5018165826248;981.3081777346953;981.8674478945358;982.7150126463317;983.5475681186663;984.714432814483;732.4909188114262;733.109272234238;733.2081352139676;734.034744311229;735.845472450786;15207.467738629206;15425.074495530303;15465.613359665986;15906.681866362724;16215.91892040544;13667.863321366758;14703.19132447715;14771.33528991198;15041.247937603077;15348.386064557404;11761.353125578089;11769.234999724991;11803.055755539623;11986.280823150551;12301.138920275584;3801.581825999138;3849.2301539691894;3896.6687831534355;3911.100446897201;4042.1713548722737;103489;109190.45404773005;110674.89325106726;110879;112153;11269.267497612629;11508.482118304697;11621.535138594361;11843.28940263587;12100.878991210151;23793;24029.51940961171;24294.27117186487;24320.148794792098;24349.87825060863;7616.04799400075;7676.424268179909;7682.96158519215;7761.61191940412;7933.642986065641;4386.122775444924;4432.977835110868;4489;4519.18654642161;4611.930821037688;3676.8345424455965;3698.4267438547067;3778.6032466591164;3799.2021675447913;3860.8841734748003;689.3898899474002;691.9827004324932;699.832040310332;701.3897908819359;713.5718568858643;667.1704416648403;711.4237467651219;717.8528401677644;744.3338212299961;769.9461037727306;8207.753767386988;9464.290178236522;10289.691309260734;10752.516136773864;10808.729781755519;703.5743375257997;726.9549327665981;734.2180577684749;739.763275751765;740.9592472414068;5082.008076175298;5115.87210319745;5124.590032797368;5163.974180129076;5230.555402790729;102797.48601256945;102879.45680814794;103768.96231037594;104942.47528762308;105316.47341763396;64483.677581611795;75105.6244718773;79100.20899790929;80867.59566202249;81550;75193;77483.2251677476;83092;83492;85186.57406712927;9830.901690982999;9884.44036404263;10107.3430227035;10110.646127385506;10224.335418197794;45381.50401727937;51650.74174629103;53787.655308616035;54755;56220.71889640689;67515.66242168758;72265.91601125883;72582.63708681423;73474.16314592178;74777.62611186909;11374.374409407232;11407.942960285145;11696.88303116958;12415.689607759878;12582.748345033231;12282.385880706108;12588.370581470706;13625.909927205601;13655.975801814704;13701.588952331445;11753.47109380097;12236.816447753114;12259;12402.5659101931;12528.937355313165;11821.231619944676;12157.635270941886;12670.619881403572;12712.809307860574;13795.655108621962;13005.100820913245;13859.653508662364;13925.022944016568;14264.928675356558;14381.352839122474;11249.943750281524;11477.655670329903;11531.308121512737;11813.822792657946;12328.383580821102;8773.956130219309;10046.598136074768;10252.333598316085;11687.357195354338;12159 17:18:59 INFO - PROCESS | 2191 | __end_tp_report 17:18:59 INFO - PROCESS | 2191 | __start_cc_report 17:18:59 INFO - PROCESS | 2191 | _x_x_mozilla_cycle_collect,1309 17:18:59 INFO - PROCESS | 2191 | __end_cc_report 17:18:59 INFO - PROCESS | 2191 | __startTimestamp1489450739136__endTimestamp 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | ------- Summary: start ------- 17:18:59 INFO - PROCESS | 2191 | Number of tests: 6 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | [#0] dojo.html Cycles:165 Average:5842.40 Median:6143.26 stddev:652.40 (10.6%) stddev-sans-first:626.99 17:18:59 INFO - PROCESS | 2191 | Values: 3456.8 3464.3 3499.4 3512.6 3531.5 5880.6 5881.1 5898.1 5907.0 5911.3 5879.6 5943.0 5947.2 5967.5 5968.4 4328.4 5243.7 5281.0 5338.5 5362.5 5232.1 5249.6 5269.3 5274.8 5349.3 5311.6 5329.8 5334.1 5366.9 5387.6 5332.8 5334.3 5334.3 5335.1 5385.2 5070.7 5163.2 5187.3 5273.7 5297.8 5800.2 5832.3 5851.2 5861.5 5897.2 6220.1 6240.9 6261.9 6269.2 6277.8 6145.7 6243.7 6294.7 6295.6 6299.4 5930.6 5975.9 6031.9 6057.2 6089.5 5712.9 6361.8 6392.9 6404.9 6429.0 4921.4 6255.6 6311.9 6327.0 6344.1 6170.4 6214.2 6223.8 6250.4 6253.9 6265.3 6274.5 6282.4 6286.7 6305.5 6275.1 6280.8 6291.0 6292.5 6294.2 4942.8 5004.9 5021.9 5022.4 5061.8 4564.4 4580.2 4590.3 4600.8 4627.6 6090.2 6103.2 6138.2 6143.3 6146.4 6190.3 6209.8 6288.7 6296.2 6306.7 5977.5 6045.9 6048.2 6049.7 6059.5 5562.6 5570.3 5570.9 5573.1 5574.0 6346.5 6375.3 6386.2 6393.5 6428.7 5156.4 6278.5 6293.8 6297.7 6305.9 6500.5 6507.7 6509.0 6524.0 6539.3 6207.1 6282.3 6289.2 6290.8 6293.0 6228.3 6242.3 6250.4 6268.8 6276.2 4527.9 6264.6 6278.3 6283.9 6291.5 6258.2 6277.3 6281.0 6284.3 6307.6 6073.8 6106.8 6114.7 6118.1 6199.7 6183.0 6183.8 6220.3 6235.0 6236.0 5813.2 6155.3 6174.6 6186.3 6187.0 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | [#1] ext.html Cycles:180 Average:68763.50 Median:39158.11 stddev:142622.69 (364.2%) stddev-sans-first:142930.63 17:18:59 INFO - PROCESS | 2191 | Values: 474.3 479.2 524.8 540.5 579.5 31897.7 43040.9 44465.1 44522.9 46235.8 39664.8 44274.6 45473.0 45791.0 45905.8 9658.6 9868.7 9882.5 9899.5 9913.6 9260.5 9474.0 12001.4 12254.3 12258.5 11220.4 12291.9 12372.7 12382.9 12396.6 11211.3 12223.3 12231.0 12236.3 12238.3 12024.6 12106.1 12111.6 12120.9 12122.3 43281.4 43534.9 43555.3 43594.8 43605.1 4101.2 4147.9 4149.4 4150.4 4163.4 30975.9 31853.7 32689.3 32792.0 33379.0 3286.9 3446.1 3449.4 3491.4 3587.4 493651.5 500004.0 503046.0 504328.0 508221.0 66764.3 67290.7 67307.3 67354.0 67394.0 70845.6 71018.3 71233.6 71275.6 71285.0 17289.6 18078.0 18107.4 18122.4 18141.6 12615.0 13850.2 13973.4 13977.9 13990.3 15676.3 16103.1 16106.9 16115.8 16135.6 8032.6 8170.8 8463.8 8957.4 8961.3 838.0 903.6 904.6 908.4 948.9 31631.7 32127.4 32185.2 32883.7 32935.7 881.8 1098.7 1156.9 1207.3 1225.1 15172.6 15391.2 15625.9 15710.9 15715.3 445428.0 447344.8 448487.0 451803.0 547892.0 52300.7 57734.0 58764.4 59029.4 64656.7 1463.1 1497.7 1498.5 1511.2 1513.7 29791.6 31294.1 31459.7 31856.0 32052.7 50178.5 56114.0 57241.7 60296.4 60648.7 617001.0 624741.0 624978.0 625687.0 625775.0 42790.8 42982.6 43050.1 43551.8 43657.8 46013.3 46500.8 46599.0 46667.5 47138.5 30625.0 35570.6 37357.0 38031.0 39194.6 37554.0 37945.0 38520.0 39121.6 39267.8 37017.4 37328.8 37585.0 37940.2 38586.4 31965.7 34030.5 34192.8 34423.1 34533.0 25407.6 25572.9 25930.0 26178.1 26353.3 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | [#2] jquery.html Cycles:180 Average:39710.88 Median:12889.87 stddev:122712.35 (952.0%) stddev-sans-first:123021.10 17:18:59 INFO - PROCESS | 2191 | Values: 409.7 411.3 413.3 423.2 439.1 20379.8 21043.9 21717.7 22163.2 22487.0 22454.0 22647.8 22697.7 22976.2 23140.1 5364.8 5866.4 6209.6 6212.6 6214.6 5573.2 5968.8 6219.8 6288.8 6367.5 6120.3 6313.0 6324.0 6325.3 6331.6 6146.7 6251.7 6280.4 6282.5 6300.7 5981.4 6125.5 6169.1 6173.2 6225.1 13981.4 14174.7 14184.3 18114.5 26870.6 2639.7 2721.4 2723.1 2724.6 2765.4 10340.7 10388.7 10522.7 10843.0 10878.7 1832.3 1877.4 1888.2 1897.3 1911.3 130481.3 133657.0 134571.3 134813.0 136356.0 11834.6 11853.6 11985.8 12019.8 12189.2 16309.6 16345.9 16348.4 16350.0 16370.9 8976.0 9162.5 9168.9 9201.3 9294.7 8143.3 8182.2 8959.3 8976.0 9151.9 4804.4 4862.6 4874.5 4973.8 4980.8 2016.9 2061.4 2072.5 2079.0 2080.6 880.6 893.2 901.4 910.3 941.1 20515.0 21433.6 21434.9 21435.8 21438.0 928.6 946.3 946.4 951.4 956.6 9340.6 10500.9 11022.6 11127.3 11131.0 621700.0 725476.0 764621.0 775729.0 800931.0 98363.5 106686.0 107267.0 139162.3 141459.0 1001.1 1016.2 1049.8 1061.9 1098.1 19558.0 20293.2 20649.8 20718.5 20759.2 59351.7 59435.5 60360.7 60501.0 60516.1 86761.0 87493.0 87496.0 88423.0 89676.6 7860.2 8441.9 8591.1 8607.8 8826.2 10794.0 12726.7 12822.9 13299.3 13432.1 11148.2 11268.4 11358.8 11624.5 11723.2 9664.7 11115.8 11375.1 11675.0 11732.6 11294.2 11541.8 11614.3 11662.2 11897.7 7481.4 7814.0 8203.4 8731.7 8761.7 10862.6 11500.9 11508.5 11741.3 11773.2 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | [#3] mootools.html Cycles:180 Average:5477.93 Median:5152.64 stddev:2963.47 (57.5%) stddev-sans-first:2955.59 17:18:59 INFO - PROCESS | 2191 | Values: 1355.1 1368.2 1370.9 1371.8 1398.3 7272.8 8155.5 8531.3 8539.4 8560.8 7513.1 7730.1 7751.4 7849.1 8313.3 2180.7 2213.7 2323.0 2399.1 2404.8 2418.5 2426.7 2434.4 2437.4 2442.8 2332.1 2379.3 2383.2 2385.3 2387.4 2131.8 2205.1 2209.6 2213.6 2324.4 2366.5 2406.6 2410.9 2410.9 2414.0 8458.8 8510.4 8522.1 8527.4 8563.1 4835.2 5254.5 5277.1 5279.5 5291.3 3354.7 3442.0 3506.2 3553.1 3570.3 1218.5 1227.8 1273.2 1275.8 1302.3 10842.5 10906.9 10994.3 10995.0 10998.9 3970.3 4520.8 4788.3 4808.6 4816.7 9648.9 9654.0 9658.0 9662.7 9671.9 5383.1 5391.0 5391.7 5394.9 5397.1 4758.8 4845.0 4884.3 4954.2 4964.8 3280.5 3735.2 3879.0 3880.4 3893.6 1120.9 1300.2 1320.3 1321.1 1344.1 914.9 916.3 935.3 936.6 972.2 5506.5 5626.6 5866.6 5898.1 5911.2 838.0 1016.5 1029.1 1040.0 1068.2 3605.8 3719.6 3872.6 3890.5 3894.2 9734.9 10044.8 10067.7 10077.9 10108.0 8942.8 9751.9 10026.6 10035.8 10046.0 7930.6 8050.4 8052.3 8055.8 8080.8 5220.0 5424.4 5657.1 5694.3 5877.4 9151.1 9367.3 9368.9 9386.9 9405.7 9091.0 9369.8 9411.7 9607.9 9636.4 7156.2 7161.6 7196.4 7252.7 7295.7 7220.9 7849.4 7914.8 7916.4 7920.8 6837.4 7222.0 7257.4 7296.6 7327.2 6962.0 7000.0 7024.5 7027.8 7068.5 5500.9 6348.7 6456.9 6475.4 6506.0 4907.9 4919.8 4934.0 5057.0 5173.9 4975.5 5059.2 5085.5 5108.3 5131.3 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | [#4] prototype.html Cycles:180 Average:4384.59 Median:4871.70 stddev:1322.12 (27.1%) stddev-sans-first:1291.01 17:18:59 INFO - PROCESS | 2191 | Values: 368.5 373.9 379.7 386.4 387.9 4396.4 4869.6 4933.7 5223.6 5235.5 5070.0 5138.3 5157.4 5261.6 5297.3 4143.2 4155.9 4166.2 4169.5 4170.2 3569.3 4006.0 4067.3 4088.5 4153.6 3576.9 4087.9 4093.3 4094.4 4100.6 3604.7 3756.2 4062.1 4076.4 4123.0 3093.2 3303.9 3492.0 3492.9 3670.8 4713.3 4833.8 4981.0 4988.9 5047.9 4592.7 4596.7 4599.5 4605.7 4650.9 4505.7 5480.4 5516.6 5575.0 5619.9 3109.6 3238.4 3874.5 3880.4 3888.9 4899.5 5133.5 5203.7 5853.6 5914.4 3325.9 3400.9 3896.4 3959.0 3967.7 3393.7 3458.3 3848.4 3941.9 3991.6 3836.9 4402.4 4583.0 4604.4 4610.9 5230.7 5622.7 5652.2 5658.6 5666.8 1085.7 1123.4 1161.7 1240.5 1269.1 759.5 819.6 882.7 884.4 886.3 4173.4 4437.5 4787.7 4950.0 5021.6 4490.7 5286.4 5404.0 5412.6 5531.3 4176.8 4668.9 4845.7 4932.4 4987.0 2537.4 2673.6 2682.5 2730.6 2851.7 4842.4 4873.8 5389.9 5598.2 5600.8 5134.7 5381.5 5568.8 5601.8 5662.4 5611.0 5622.9 5631.0 5640.0 5684.3 4718.7 4818.9 5050.7 5272.4 5369.7 5135.0 5250.2 5252.7 5289.4 5311.2 5185.0 5488.8 5551.6 5617.8 5618.9 3806.0 3911.3 3987.8 4066.7 4074.6 4886.1 5032.5 5313.6 5372.4 5392.5 4782.6 5029.5 5138.8 5301.7 5504.6 4683.3 5455.1 5500.4 5532.5 5546.1 4387.4 4809.5 4941.9 4962.7 5439.6 5296.9 5486.9 5577.2 5587.8 5593.3 4612.5 4678.6 4997.1 5455.3 5457.3 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - PROCESS | 2191 | [#5] yui.html Cycles:180 Average:20595.41 Median:3855.06 stddev:29447.10 (763.9%) stddev-sans-first:29491.95 17:18:59 INFO - PROCESS | 2191 | Values: 736.7 758.0 781.4 846.2 865.4 15097.8 15742.2 15785.5 15794.8 15809.4 14365.6 14382.0 14386.4 14519.6 14533.6 721.4 748.1 900.9 910.5 912.9 876.8 896.4 904.9 912.7 914.9 981.7 983.5 985.8 986.0 986.5 981.3 981.9 982.7 983.5 984.7 732.5 733.1 733.2 734.0 735.8 15207.5 15425.1 15465.6 15906.7 16215.9 13667.9 14703.2 14771.3 15041.2 15348.4 11761.4 11769.2 11803.1 11986.3 12301.1 3801.6 3849.2 3896.7 3911.1 4042.2 103489.0 109190.5 110674.9 110879.0 112153.0 11269.3 11508.5 11621.5 11843.3 12100.9 23793.0 24029.5 24294.3 24320.1 24349.9 7616.0 7676.4 7683.0 7761.6 7933.6 4386.1 4433.0 4489.0 4519.2 4611.9 3676.8 3698.4 3778.6 3799.2 3860.9 689.4 692.0 699.8 701.4 713.6 667.2 711.4 717.9 744.3 769.9 8207.8 9464.3 10289.7 10752.5 10808.7 703.6 727.0 734.2 739.8 741.0 5082.0 5115.9 5124.6 5164.0 5230.6 102797.5 102879.5 103769.0 104942.5 105316.5 64483.7 75105.6 79100.2 80867.6 81550.0 75193.0 77483.2 83092.0 83492.0 85186.6 9830.9 9884.4 10107.3 10110.6 10224.3 45381.5 51650.7 53787.7 54755.0 56220.7 67515.7 72265.9 72582.6 73474.2 74777.6 11374.4 11407.9 11696.9 12415.7 12582.7 12282.4 12588.4 13625.9 13656.0 13701.6 11753.5 12236.8 12259.0 12402.6 12528.9 11821.2 12157.6 12670.6 12712.8 13795.7 13005.1 13859.7 13925.0 14264.9 14381.4 11249.9 11477.7 11531.3 11813.8 12328.4 8774.0 10046.6 10252.3 11687.4 12159.0 17:18:59 INFO - PROCESS | 2191 | -------- Summary: end -------- 17:18:59 INFO - PROCESS | 2191 | 17:18:59 INFO - TEST-INFO | 2191: exit 0 17:18:59 INFO - TEST-OK | dromaeo_css | took 1117024ms 17:18:59 INFO - TEST-START | kraken 17:18:59 INFO - operating with platform_type : mac_ 17:18:59 INFO - Initialising browser for kraken test... 17:18:59 INFO - TEST-INFO | started process 2195 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpx_gkRA/profile http://localhost:56677/getInfo.html) 17:19:01 INFO - PROCESS | 2195 | __metrics Screen width/height:1600/1200 17:19:01 INFO - PROCESS | 2195 | colorDepth:24 17:19:01 INFO - PROCESS | 2195 | Browser inner width/height: 1024/689 17:19:01 INFO - PROCESS | 2195 | __metrics 17:19:02 INFO - PROCESS | 2195 | 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" 17:19:02 INFO - PROCESS | 2195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:19:02 INFO - TEST-INFO | 2195: exit 0 17:19:02 INFO - Browser initialized. 17:19:02 INFO - Running cycle 1/1 for kraken test... 17:19:02 INFO - TEST-INFO | started process 2197 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpx_gkRA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:14 INFO - PROCESS | 2197 | RSS: Main: 166735872 17:19:14 INFO - PROCESS | 2197 | 17:19:17 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56677/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:18 INFO - PROCESS | 2197 | RSS: Main: 215126016 17:19:18 INFO - PROCESS | 2197 | 17:19:20 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56677/tests/kraken/driver.html?testName=audio-dft) 17:19:21 INFO - PROCESS | 2197 | RSS: Main: 229130240 17:19:21 INFO - PROCESS | 2197 | 17:19:24 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56677/tests/kraken/driver.html?testName=audio-fft) 17:19:24 INFO - PROCESS | 2197 | RSS: Main: 325910528 17:19:24 INFO - PROCESS | 2197 | 17:19:27 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56677/tests/kraken/driver.html?testName=audio-oscillator) 17:19:27 INFO - PROCESS | 2197 | RSS: Main: 229638144 17:19:27 INFO - PROCESS | 2197 | 17:19:29 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56677/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:30 INFO - PROCESS | 2197 | RSS: Main: 230666240 17:19:30 INFO - PROCESS | 2197 | 17:19:32 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56677/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:33 INFO - PROCESS | 2197 | RSS: Main: 271118336 17:19:33 INFO - PROCESS | 2197 | 17:19:36 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56677/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:37 INFO - PROCESS | 2197 | RSS: Main: 271695872 17:19:37 INFO - PROCESS | 2197 | 17:19:39 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56677/tests/kraken/driver.html?testName=json-parse-financial) 17:19:40 INFO - PROCESS | 2197 | RSS: Main: 271237120 17:19:40 INFO - PROCESS | 2197 | 17:19:42 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56677/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:42 INFO - PROCESS | 2197 | RSS: Main: 246054912 17:19:42 INFO - PROCESS | 2197 | 17:19:44 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:45 INFO - PROCESS | 2197 | RSS: Main: 250781696 17:19:45 INFO - PROCESS | 2197 | 17:19:47 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:47 INFO - PROCESS | 2197 | RSS: Main: 257228800 17:19:47 INFO - PROCESS | 2197 | 17:19:50 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:51 INFO - PROCESS | 2197 | RSS: Main: 270012416 17:19:51 INFO - PROCESS | 2197 | 17:19:54 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:54 INFO - PROCESS | 2197 | RSS: Main: 264159232 17:19:54 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:56677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56677/tests/kraken/driver.html?testName=ai-astar) 17:19:56 INFO - PROCESS | 2197 | RSS: Main: 308457472 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | __start_tp_report 17:19:56 INFO - PROCESS | 2197 | _x_x_mozilla_page_load 17:19:56 INFO - PROCESS | 2197 | _x_x_mozilla_page_load_details 17:19:56 INFO - PROCESS | 2197 | |i|pagename|runs| 17:19:56 INFO - PROCESS | 2197 | |0;ai-astar;111;114;113;113;113;114;113;114;112;114 17:19:56 INFO - PROCESS | 2197 | |1;audio-beat-detection;136;106;108;140;110;105;106;107;126;107 17:19:56 INFO - PROCESS | 2197 | |2;audio-dft;184;183;180;184;186;185;181;183;181;184 17:19:56 INFO - PROCESS | 2197 | |3;audio-fft;80;67;59;86;61;58;58;57;83;112 17:19:56 INFO - PROCESS | 2197 | |4;audio-oscillator;86;70;86;69;67;69;79;66;70;80 17:19:56 INFO - PROCESS | 2197 | |5;imaging-gaussian-blur;90;84;88;84;87;85;89;84;88;101 17:19:56 INFO - PROCESS | 2197 | |6;imaging-darkroom;93;107;149;105;93;92;93;92;93;92 17:19:56 INFO - PROCESS | 2197 | |7;imaging-desaturate;87;87;87;86;88;85;86;87;87;84 17:19:56 INFO - PROCESS | 2197 | |8;json-parse-financial;51;49;50;50;55;52;55;55;55;57 17:19:56 INFO - PROCESS | 2197 | |9;json-stringify-tinderbox;71;78;77;74;72;69;71;70;71;71 17:19:56 INFO - PROCESS | 2197 | |10;stanford-crypto-aes;81;80;83;83;81;82;81;78;76;82 17:19:56 INFO - PROCESS | 2197 | |11;stanford-crypto-ccm;135;132;130;130;121;133;139;148;181;132 17:19:56 INFO - PROCESS | 2197 | |12;stanford-crypto-pbkdf2;160;158;162;162;155;159;161;158;161;160 17:19:56 INFO - PROCESS | 2197 | |13;stanford-crypto-sha256-iterative;64;64;64;65;69;77;82;83;82;62 17:19:56 INFO - PROCESS | 2197 | __end_tp_report 17:19:56 INFO - PROCESS | 2197 | __start_cc_report 17:19:56 INFO - PROCESS | 2197 | _x_x_mozilla_cycle_collect,1956 17:19:56 INFO - PROCESS | 2197 | __end_cc_report 17:19:56 INFO - PROCESS | 2197 | __startTimestamp1489450796869__endTimestamp 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | ------- Summary: start ------- 17:19:56 INFO - PROCESS | 2197 | Number of tests: 14 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:0.99 (0.9%) stddev-sans-first:0.71 17:19:56 INFO - PROCESS | 2197 | Values: 111.0 114.0 113.0 113.0 113.0 114.0 113.0 114.0 112.0 114.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:109.00 stddev:13.54 (12.4%) stddev-sans-first:12.07 17:19:56 INFO - PROCESS | 2197 | Values: 136.0 106.0 108.0 140.0 110.0 105.0 106.0 107.0 126.0 107.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:1.91 (1.0%) stddev-sans-first:2.00 17:19:56 INFO - PROCESS | 2197 | Values: 184.0 183.0 180.0 184.0 186.0 185.0 181.0 183.0 181.0 184.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#3] audio-fft Cycles:10 Average:72.10 Median:64.00 stddev:17.99 (28.1%) stddev-sans-first:18.85 17:19:56 INFO - PROCESS | 2197 | Values: 80.0 67.0 59.0 86.0 61.0 58.0 58.0 57.0 83.0 112.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#4] audio-oscillator Cycles:10 Average:74.20 Median:74.50 stddev:7.77 (10.4%) stddev-sans-first:6.97 17:19:56 INFO - PROCESS | 2197 | Values: 86.0 70.0 86.0 69.0 67.0 69.0 79.0 66.0 70.0 80.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:87.50 stddev:5.08 (5.8%) stddev-sans-first:5.33 17:19:56 INFO - PROCESS | 2197 | Values: 90.0 84.0 88.0 84.0 87.0 85.0 89.0 84.0 88.0 101.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:92.50 stddev:17.81 (19.3%) stddev-sans-first:18.66 17:19:56 INFO - PROCESS | 2197 | Values: 93.0 107.0 149.0 105.0 93.0 92.0 93.0 92.0 93.0 92.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.17 (1.3%) stddev-sans-first:1.22 17:19:56 INFO - PROCESS | 2197 | Values: 87.0 87.0 87.0 86.0 88.0 85.0 86.0 87.0 87.0 84.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:55.00 stddev:2.81 (5.1%) stddev-sans-first:2.89 17:19:56 INFO - PROCESS | 2197 | Values: 51.0 49.0 50.0 50.0 55.0 52.0 55.0 55.0 55.0 57.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:71.50 stddev:2.99 (4.2%) stddev-sans-first:3.13 17:19:56 INFO - PROCESS | 2197 | Values: 71.0 78.0 77.0 74.0 72.0 69.0 71.0 70.0 71.0 71.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.50 stddev:2.21 (2.7%) stddev-sans-first:2.35 17:19:56 INFO - PROCESS | 2197 | Values: 81.0 80.0 83.0 83.0 81.0 82.0 81.0 78.0 76.0 82.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:134.00 stddev:16.58 (12.4%) stddev-sans-first:17.54 17:19:56 INFO - PROCESS | 2197 | Values: 135.0 132.0 130.0 130.0 121.0 133.0 139.0 148.0 181.0 132.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.50 stddev:2.17 (1.4%) stddev-sans-first:2.30 17:19:56 INFO - PROCESS | 2197 | Values: 160.0 158.0 162.0 162.0 155.0 159.0 161.0 158.0 161.0 160.0 17:19:56 INFO - PROCESS | 2197 | 17:19:56 INFO - PROCESS | 2197 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:73.00 stddev:8.75 (12.0%) stddev-sans-first:8.89 17:19:56 INFO - PROCESS | 2197 | Values: 64.0 64.0 64.0 65.0 69.0 77.0 82.0 83.0 82.0 62.0 17:19:56 INFO - PROCESS | 2197 | -------- Summary: end -------- 17:19:56 INFO - PROCESS | 2197 | 17:19:57 INFO - TEST-INFO | 2197: exit 0 17:19:57 INFO - TEST-OK | kraken | took 57979ms 17:19:57 INFO - SUITE-END | took 1175s 17:19:58 INFO - Completed test suite (00:19:35) 17:19:58 INFO - javascript benchmark 17:19:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3456.8098754568496, 3464.2551851351955, 3499.3876071687464, 3512.5784905811274, 3531.4879342495337, 5880.55895807814, 5881.147233651123, 5898.115282707596, 5906.970465147679, 5911.349751527328, 5879.617824841383, 5942.970285148568, 5947.197128387677, 5967.4927631151295, 5968.40315968403, 4328.415663885383, 5243.659162154467, 5281.0, 5338.546223571001, 5362.544183744387, 5232.084385232569, 5249.606279529032, 5269.314989051418, 5274.81538146165, 5349.277847490578, 5311.601629877755, 5329.840104796862, 5334.066538355792, 5366.91949620756, 5387.649802762828, 5332.760025798849, 5334.306540149756, 5334.306540149756, 5335.093034184198, 5385.192221166817, 5070.7464626768515, 5163.225516172567, 5187.273781670569, 5273.683578985273, 5297.841064768063, 5800.216970708984, 5832.270966129234, 5851.210086638292, 5861.472467477947, 5897.233359663259, 6220.098085777537, 6240.937590624127, 6261.906071408933, 6269.216347956505, 6277.843053923689, 6145.678679083973, 6243.719032643542, 6294.685265736741, 6295.590786598902, 6299.401556852092, 5930.614510056833, 5975.880482390327, 6031.909521357183, 6057.182280392179, 6089.543284253698, 5712.885987232533, 6361.777337793155, 6392.872142557123, 6404.935950640434, 6429.0, 4921.409430868247, 6255.624662520263, 6311.873762524724, 6327.0, 6344.111824344595, 6170.352113028068, 6214.161088253119, 6223.751049958041, 6250.40621141, 6253.906191407133, 6265.279492858289, 6274.498040156776, 6282.371762823773, 6286.685665716695, 6305.495560355161, 6275.090111933744, 6280.811575652738, 6291.0, 6292.465140463112, 6294.181756371734, 4942.752862356868, 5004.874878128076, 5021.899562008739, 5022.372203474566, 5061.8228362007885, 4564.42944631921, 4580.24425969718, 4590.288505281686, 4600.838970636011, 4627.629789616823, 6090.177825993523, 6103.176071230416, 6138.232720909887, 6143.262808463013, 6146.354632763585, 6190.3190649028575, 6209.782657606962, 6288.654124023131, 6296.244450665949, 6306.716197771111, 5977.491913187428, 6045.939540604626, 6048.213732214872, 6049.727762250709, 6059.48494377974, 5562.554995600342, 5570.275864137636, 5570.888582228333, 5573.108302671634, 5573.968815769014, 6346.524010699124, 6375.330590287953, 6386.201724784402, 6393.520485963571, 6428.742850286123, 5156.4070131935305, 6278.529110316653, 6293.842653933688, 6297.653629050446, 6305.873882522415, 6500.512461565307, 6507.739690412331, 6508.958566629317, 6523.967380163069, 6539.313372095861, 6207.131001659862, 6282.340354262919, 6289.150964619901, 6290.811275661737, 6292.96166132583, 6228.314885362697, 6242.344553821783, 6250.4374606285655, 6268.780592679234, 6276.184096067482, 4527.932081018722, 6264.561480696308, 6278.309385967448, 6283.905741413791, 6291.528135389955, 6258.186435763321, 6277.3408792078, 6281.0, 6284.3087260402235, 6307.558470906993, 6073.848153796013, 6106.7640410362355, 6114.723190878713, 6118.112873633388, 6199.690015499117, 6183.041628547582, 6183.783567575113, 6220.284667263141, 6235.0, 6235.96882015587, 5813.2158502290495, 6155.322914479314, 6174.629522228681, 6186.319504854552, 6186.969065154645], "value": 5803.26497195179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.3430348966682, 479.21887323662435, 524.7717242999295, 540.5378401466746, 579.4553120067139, 31897.68102318976, 43040.92397690055, 44465.11069778606, 44522.88692782674, 46235.76882115593, 39664.80167599165, 44274.55725442745, 45473.0, 45791.0, 45905.770471147596, 9658.613655453792, 9868.654597089067, 9882.456464894429, 9899.45552994585, 9913.553890074927, 9260.53697315135, 9473.95263023684, 12001.399930003508, 12254.264744115337, 12258.509659613605, 11220.438978051106, 12291.877081229162, 12372.690682732959, 12382.876171238308, 12396.628101156979, 11211.327320360804, 12223.2666040037, 12231.021518278516, 12236.265824050586, 12238.32689202098, 12024.639260822189, 12106.092043096714, 12111.576094836639, 12120.878791212152, 12122.333271670055, 43281.350779738015, 43534.91162720926, 43555.346669799976, 43594.78202608998, 43605.12789744219, 4101.159262351211, 4147.875563733093, 4149.356849688304, 4150.377443383486, 4163.437935878648, 30975.91584294539, 31853.681463185534, 32689.34621307584, 32792.04871561547, 33379.0, 3286.901392958215, 3446.138465383654, 3449.413599688034, 3491.441369380887, 3587.3901436755814, 493651.5317423426, 500004.0, 503046.0, 504327.9567204354, 508221.0, 66764.33235667678, 67290.66354668293, 67307.27888129564, 67354.0, 67394.0, 70845.64577177184, 71018.2898171022, 71233.64383178155, 71275.6436217826, 71285.0, 17289.56776080608, 18078.00570968583, 18107.366242181724, 18122.365717199835, 18141.63716725658, 12615.0, 13850.238236896867, 13973.371198295898, 13977.86022139786, 13990.300484975915, 15676.294566744524, 16103.1143287118, 16106.872518923563, 16115.838841611669, 16135.596610084607, 8032.558209298545, 8170.75487735357, 8463.772752950788, 8957.417767845069, 8961.266813621778, 838.0195171649185, 903.6249956268207, 904.5703290936752, 908.4276905549593, 948.9003654616304, 31631.683683162875, 32127.35745285081, 32185.195370115933, 32883.67116328854, 32935.67064329374, 881.828043531518, 1098.7143342730947, 1156.8785277545906, 1207.3118322556234, 1225.0995518294046, 15172.620684482756, 15391.153486558123, 15625.921870390803, 15710.9214453927, 15715.264469621212, 445428.0, 447344.76327618153, 448487.0, 451803.0, 547892.0, 52300.73849630728, 57734.0, 58764.412355876746, 59029.40970590325, 64656.676716617054, 1463.0636392708675, 1497.6854860479204, 1498.5429444019678, 1511.1764088571754, 1513.674559969612, 29791.55312670268, 31294.06117816469, 31459.685403145675, 31856.0, 32052.67947320497, 50178.4946451607, 56114.0, 57241.713791430775, 60296.39703603083, 60648.696756515936, 617001.0, 624741.0, 624978.0, 625687.0, 625775.0, 42790.786046069574, 42982.570174297856, 43050.138997219256, 43551.78224108986, 43657.781711091244, 46013.309800352356, 46500.767496162305, 46599.0, 46667.53332466632, 47138.52861471342, 30625.0, 35570.64429355673, 37357.0, 38031.04922376962, 39194.608053919095, 37554.0, 37945.0, 38520.0, 39121.60878391293, 39267.80366098265, 37017.44473832948, 37328.813355933045, 37585.0, 37940.241195176495, 38586.421203681406, 31965.6803431972, 34030.48954265738, 34192.82903585466, 34423.13942151366, 34533.0, 25407.6188857171, 25572.8721356392, 25929.962801488484, 26178.08376706806, 26353.341166470993], "value": 21278.50375925504, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.66202882621843, 411.3254263008665, 413.3345314044386, 423.1558041706795, 439.0713640650026, 20379.796202037975, 21043.894780526094, 21717.67423488647, 22163.224287149955, 22486.988085536148, 22453.989570469326, 22647.77352226477, 22697.65953510699, 22976.195833145845, 23140.0743970241, 5364.839054828361, 5866.442687944638, 6209.565330426872, 6212.565120441571, 6214.5649804513705, 5573.219749235111, 5968.7612495500125, 6219.844503887416, 6288.779892703757, 6367.4906007519285, 6120.26556813183, 6312.968435157818, 6324.0, 6325.3042165362, 6331.620102793824, 6146.7233974471255, 6251.749930002795, 6280.371962803706, 6282.4974002079725, 6300.716467758962, 5981.401859814027, 6125.509959203253, 6169.105479705462, 6173.197484327009, 6225.066240063981, 13981.440742370292, 14174.716505669932, 14184.290785460686, 18114.547136321566, 26870.5969410459, 2639.6568446101883, 2721.4012917158193, 2723.101376545755, 2724.5913113033007, 2765.3777899972547, 10340.689779306633, 10388.740281492948, 10522.684319470429, 10843.024127828454, 10878.673639790819, 1832.2854086906118, 1877.361697023005, 1888.225827410755, 1897.3454158315496, 1911.2832687742098, 130481.34759326142, 133657.0, 134571.32714336365, 134813.0, 136356.0, 11834.585789497498, 11853.644390668294, 11985.760284794254, 12019.819702704466, 12189.207701499552, 16309.59226019359, 16345.918270408572, 16348.427805026768, 16350.0, 16370.918145409196, 8976.0, 9162.450252984709, 9168.908310916806, 9201.263898888074, 9294.72115836526, 8143.307818835466, 8182.1817818217705, 8959.328050396247, 8976.0, 9151.908480915106, 4804.413738257383, 4862.6151527552165, 4874.512548745168, 4973.825916092919, 4980.7509624518625, 2016.9294074707316, 2061.4331058958905, 2072.5336799220054, 2078.9792102078786, 2080.583883223331, 880.6037283222576, 893.1961234888522, 901.396064636695, 910.349100393222, 941.1388579449864, 20514.974251287374, 21433.57132857334, 21434.892825536084, 21435.78564214369, 21438.0, 928.5774972387547, 946.2524605561667, 946.3848498476045, 951.3863558005187, 956.6173530587821, 9340.57967391469, 10500.894991050145, 11022.559097636005, 11127.332360058423, 11130.998210160962, 621700.0, 725476.0, 764621.0, 775729.0, 800931.0, 98363.48147520823, 106686.0, 107267.0, 139162.30418847842, 141459.0, 1001.1340190734962, 1016.187050359724, 1049.8372752223418, 1061.851340812287, 1098.0721290509507, 19558.0, 20293.188272468935, 20649.793502064786, 20718.482037948568, 20759.169633214504, 59351.703241485244, 59435.51411214754, 60360.69819650874, 60501.0, 60516.092258617035, 86761.0, 87493.0, 87496.02132569296, 88423.0, 89676.55161724411, 7860.213978602094, 8441.91558084436, 8591.140885911358, 8607.784805379664, 8826.242390095842, 10794.0, 12726.68183295425, 12822.935885320887, 13299.335033248492, 13432.126911750705, 11148.163887708291, 11268.436578171222, 11358.829617555579, 11624.476898539755, 11723.179377443497, 9664.71005869825, 11115.833262500908, 11375.089992800391, 11675.007624352025, 11732.589359372381, 11294.152938529807, 11541.82687259675, 11614.303141811519, 11662.183647144619, 11897.702557436134, 7481.4014878808475, 7813.960930195312, 8203.384746143944, 8731.738047858575, 8761.737147885573, 10862.565497380016, 11500.929832630207, 11508.53965841357, 11741.29552226869, 11773.234739741889], "value": 10005.123100913353, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.1462578575497, 1368.226951772248, 1370.9040367174302, 1371.787372957192, 1398.328802174956, 7272.818179545514, 8155.510669359835, 8531.317494600433, 8539.359548033899, 8560.785980350487, 7513.135989361225, 7730.14476525634, 7751.379889608832, 7849.0973538043145, 8313.334933205344, 2180.716506854111, 2213.656883183109, 2323.0, 2399.0883464283547, 2404.8196385271085, 2418.504206637635, 2426.696662917135, 2434.4157402223427, 2437.3662847659557, 2442.8167887408426, 2332.078828862598, 2379.298107058422, 2383.21353953195, 2385.3082606044227, 2387.438951846315, 2131.8294536437124, 2205.0848897707433, 2209.602271591113, 2213.557288542282, 2324.407276144589, 2366.479374537599, 2406.614941609334, 2410.891509882042, 2410.92767216982, 2414.0, 8458.830823383498, 8510.44682095668, 8522.062573116953, 8527.403081784278, 8563.10087440816, 4835.202191638376, 5254.474552544753, 5277.076511610453, 5279.52484276417, 5291.259223708684, 3354.7316214702764, 3441.970313753448, 3506.2286297014616, 3553.1117220694828, 3570.250247448039, 1218.5004148299154, 1227.846519185102, 1273.2487832179058, 1275.7512285104408, 1302.3227921480777, 10842.512086956027, 10906.945465272702, 10994.34033957965, 10994.95547922946, 10998.945005275002, 3970.344893092665, 4520.81916723334, 4788.281757736298, 4808.63935204861, 4816.686915350491, 9648.903510964801, 9654.0, 9658.034196580425, 9662.71011869645, 9671.90328096724, 5383.0579648562125, 5390.973045134828, 5391.73041347931, 5394.919076213781, 5397.082495975694, 4758.762061896891, 4844.95155048452, 4884.3161957326, 4954.20732682769, 4964.801407943714, 3280.5407242986003, 3735.215604722984, 3878.9806050969564, 3880.4373365861793, 3893.6301051400073, 1120.8542889424323, 1300.2003767682806, 1320.3068389095802, 1321.134691413601, 1344.1464669934662, 914.8993610702818, 916.2852974679761, 935.2845073518764, 936.5691781780321, 972.1785091597588, 5506.531944784658, 5626.606137570413, 5866.589338746332, 5898.085796701518, 5911.201987731687, 837.9832403351899, 1016.4752870693959, 1029.089256008423, 1039.9948000259951, 1068.188176985481, 3605.8016809075752, 3719.6466335698065, 3872.612738726105, 3890.455336252927, 3894.162755007687, 9734.902650973541, 10044.849327260097, 10067.69796906094, 10077.899221007843, 10108.0, 8942.792722982444, 9751.90248097524, 10026.64906728261, 10035.79928401428, 10046.0, 7930.563818990011, 8050.396220283502, 8052.315553177928, 8055.798605034804, 8080.797980050545, 5220.0, 5424.403315635198, 5657.12314591239, 5694.259746233129, 5877.441643044075, 9151.130642588943, 9367.297452691211, 9368.906310936803, 9386.906130938876, 9405.717828464883, 9090.954545227232, 9369.765755856159, 9411.717648470556, 9607.855882161914, 9636.42181469114, 7156.177039640508, 7161.606111663908, 7196.424286057208, 7252.7461538848, 7295.671694773641, 7220.855582888418, 7849.372050236082, 7914.762557123296, 7916.445848790529, 7920.762377128695, 6837.35045170708, 7222.025026621339, 7257.383122434652, 7296.562206267641, 7327.230640782855, 6961.965190174017, 7000.0199972004975, 7024.5434046786795, 7027.789166325018, 7068.540544864773, 5500.862478438071, 6348.682565871595, 6456.903146452901, 6475.352464753487, 6506.0, 4907.877303067452, 4919.803207871788, 4933.985378579787, 5057.0, 5173.948260517347, 4975.477574854588, 5059.215821547666, 5085.491450855033, 5108.28484012246, 5131.332926719502], "value": 4471.651524530164, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5374854557531, 373.8654084529569, 379.6677906831523, 386.4126527677928, 387.8616261273165, 4396.428464299636, 4869.634777391697, 4933.679310844793, 5223.6343455958095, 5235.50262725041, 5070.0, 5138.306328645632, 5157.432682404942, 5261.552768014713, 5297.284866543016, 4143.212789569972, 4155.898686847988, 4166.187593419285, 4169.457970463835, 4170.165966806643, 3569.3396721606455, 4005.958450802798, 4067.3085575452096, 4088.5093788745394, 4153.646940010103, 3576.8926932192076, 4087.937136344542, 4093.3450647896343, 4094.3858421236755, 4100.63094321511, 3604.711623070148, 3756.2299728555718, 4062.111118329976, 4076.408920706481, 4123.0, 3093.2059405544956, 3303.884364047247, 3492.022233774547, 3492.947605785915, 3670.8436842394563, 4713.293006049086, 4833.800620717565, 4980.975095124501, 4988.900221995576, 5047.905119375455, 4592.6555508337005, 4596.724196548218, 4599.470291339783, 4605.723656580582, 4650.906981860344, 4505.6708271060115, 5480.438075148563, 5516.586256030773, 5575.0, 5619.859503512404, 3109.6268447786183, 3238.4008958342783, 3874.496315478998, 3880.417937309398, 3888.8833334999995, 4899.534544218293, 5133.4609865964285, 5203.739813009334, 5853.560982926298, 5914.4381283777975, 3325.8503367348526, 3400.931981360359, 3896.4350169225304, 3958.950878017328, 3967.7024223183375, 3393.6606339365867, 3458.342914846171, 3848.4034974578985, 3941.881743547698, 3991.6008399160432, 3836.8681239034554, 4402.449693788277, 4582.977085114553, 4604.40142781443, 4610.893385587502, 5230.660007099526, 5622.718864056781, 5652.236948012048, 5658.603897727119, 5666.801661941812, 1085.7134295859432, 1123.4270522033657, 1161.6863446869297, 1240.4542001519303, 1269.1433282534254, 759.5290919629755, 819.6270696832927, 882.6954700628273, 884.3544212724747, 886.3485338276362, 4173.4157217988895, 4437.511873693891, 4787.688800227974, 4949.975250123726, 5021.623378246573, 4490.685652004328, 5286.383240296078, 5404.0, 5412.563022480753, 5531.3362396511875, 4176.77027763476, 4668.906621867612, 4845.709257444564, 4932.374704592122, 4987.002599480118, 2537.3656585853537, 2673.5588627876573, 2682.5305571524905, 2730.621036376617, 2851.657801063844, 4842.370491836109, 4873.756312184448, 5389.946100539023, 5598.216249725042, 5600.831975040755, 5134.71632091977, 5381.461853814665, 5568.832935011957, 5601.775928962796, 5662.405447428043, 5611.018071837494, 5622.887542249132, 5631.014572449723, 5639.971800140973, 5684.289463817023, 4718.669693121448, 4818.855434336975, 5050.696958182374, 5272.367315922113, 5369.677819330853, 5135.026357380692, 5250.164910948045, 5252.684838909678, 5289.413176047094, 5311.229871668509, 5185.0, 5488.761630637943, 5551.611387202857, 5617.831465056055, 5618.864831364055, 3805.961940380561, 3911.298585115484, 3987.783725963493, 4066.7153299268766, 4074.5925407459017, 4886.144924638245, 5032.547070763649, 5313.574914006947, 5372.367539905496, 5392.487713667196, 4782.593479554138, 5029.5221953914315, 5138.820141295037, 5301.734913254399, 5504.587155963239, 4683.250679891201, 5455.072637651688, 5500.442294333155, 5532.474414930736, 5546.112621980464, 4387.36383224437, 4809.48414093301, 4941.925871111865, 4962.652614316963, 5439.646422982493, 5296.947834906223, 5486.890262194654, 5577.2191893135805, 5587.770690448095, 5593.328800543961, 4612.469565999953, 4678.625709943264, 4997.101101581376, 5455.254318618004, 5457.263269458731], "value": 3978.02888207704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.7421402509119, 757.9886301705471, 781.4295564238106, 846.2172490446336, 865.3812524045306, 15097.773533396994, 15742.21288935553, 15785.526434206979, 15794.763078553831, 15809.446669366545, 14365.640858978531, 14382.0, 14386.424543018293, 14519.637009074751, 14533.636659083502, 721.3579913876654, 748.120957874498, 900.8963969143534, 910.4719262827577, 912.8767616371771, 876.8027193881358, 896.3814967672286, 904.8642703594447, 912.717057712108, 914.862770584411, 981.7202097402242, 983.537737263485, 985.8028394321128, 985.9942858284545, 986.5018165826248, 981.3081777346953, 981.8674478945358, 982.7150126463317, 983.5475681186663, 984.714432814483, 732.4909188114262, 733.109272234238, 733.2081352139676, 734.034744311229, 735.845472450786, 15207.467738629206, 15425.074495530303, 15465.613359665986, 15906.681866362724, 16215.91892040544, 13667.863321366758, 14703.19132447715, 14771.33528991198, 15041.247937603077, 15348.386064557404, 11761.353125578089, 11769.234999724991, 11803.055755539623, 11986.280823150551, 12301.138920275584, 3801.581825999138, 3849.2301539691894, 3896.6687831534355, 3911.100446897201, 4042.1713548722737, 103489.0, 109190.45404773005, 110674.89325106726, 110879.0, 112153.0, 11269.267497612629, 11508.482118304697, 11621.535138594361, 11843.28940263587, 12100.878991210151, 23793.0, 24029.51940961171, 24294.27117186487, 24320.148794792098, 24349.87825060863, 7616.04799400075, 7676.424268179909, 7682.96158519215, 7761.61191940412, 7933.642986065641, 4386.122775444924, 4432.977835110868, 4489.0, 4519.18654642161, 4611.930821037688, 3676.8345424455965, 3698.4267438547067, 3778.6032466591164, 3799.2021675447913, 3860.8841734748003, 689.3898899474002, 691.9827004324932, 699.832040310332, 701.3897908819359, 713.5718568858643, 667.1704416648403, 711.4237467651219, 717.8528401677644, 744.3338212299961, 769.9461037727306, 8207.753767386988, 9464.290178236522, 10289.691309260734, 10752.516136773864, 10808.729781755519, 703.5743375257997, 726.9549327665981, 734.2180577684749, 739.763275751765, 740.9592472414068, 5082.008076175298, 5115.87210319745, 5124.590032797368, 5163.974180129076, 5230.555402790729, 102797.48601256945, 102879.45680814794, 103768.96231037594, 104942.47528762308, 105316.47341763396, 64483.677581611795, 75105.6244718773, 79100.20899790929, 80867.59566202249, 81550.0, 75193.0, 77483.2251677476, 83092.0, 83492.0, 85186.57406712927, 9830.901690982999, 9884.44036404263, 10107.3430227035, 10110.646127385506, 10224.335418197794, 45381.50401727937, 51650.74174629103, 53787.655308616035, 54755.0, 56220.71889640689, 67515.66242168758, 72265.91601125883, 72582.63708681423, 73474.16314592178, 74777.62611186909, 11374.374409407232, 11407.942960285145, 11696.88303116958, 12415.689607759878, 12582.748345033231, 12282.385880706108, 12588.370581470706, 13625.909927205601, 13655.975801814704, 13701.588952331445, 11753.47109380097, 12236.816447753114, 12259.0, 12402.5659101931, 12528.937355313165, 11821.231619944676, 12157.635270941886, 12670.619881403572, 12712.809307860574, 13795.655108621962, 13005.100820913245, 13859.653508662364, 13925.022944016568, 14264.928675356558, 14381.352839122474, 11249.943750281524, 11477.655670329903, 11531.308121512737, 11813.822792657946, 12328.383580821102, 8773.956130219309, 10046.598136074768, 10252.333598316085, 11687.357195354338, 12159.0], "value": 7693.41316455582, "unit": "score"}], "name": "dromaeo_css", "value": 7436.301210550358, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 112.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 106.0, 108.0, 140.0, 110.0, 105.0, 106.0, 107.0, 126.0, 107.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 180.0, 184.0, 186.0, 185.0, 181.0, 183.0, 181.0, 184.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 67.0, 59.0, 86.0, 61.0, 58.0, 58.0, 57.0, 83.0, 112.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 86.0, 69.0, 67.0, 69.0, 79.0, 66.0, 70.0, 80.0], "value": 74.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 88.0, 84.0, 87.0, 85.0, 89.0, 84.0, 88.0, 101.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 107.0, 149.0, 105.0, 93.0, 92.0, 93.0, 92.0, 93.0, 92.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 88.0, 85.0, 86.0, 87.0, 87.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 50.0, 55.0, 52.0, 55.0, 55.0, 55.0, 57.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 78.0, 77.0, 74.0, 72.0, 69.0, 71.0, 70.0, 71.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 83.0, 83.0, 81.0, 82.0, 81.0, 78.0, 76.0, 82.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 130.0, 130.0, 121.0, 133.0, 139.0, 148.0, 181.0, 132.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 162.0, 162.0, 155.0, 159.0, 161.0, 158.0, 161.0, 160.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 69.0, 77.0, 82.0, 83.0, 82.0, 62.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1407.7999999999997, "alertThreshold": 2.0}]} 17:19:58 INFO - Return code: 0 17:19:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:19:58 INFO - # TBPL SUCCESS # 17:19:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:19:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:19:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:19:58 INFO - 2017-03-13 17:19:58.189 screenresolution[2201:27120] starting screenresolution argv=screenresolution get 17:19:58 INFO - 2017-03-13 17:19:58.191 screenresolution[2201:27120] Display 0: 1600x1200x32@60 17:19:58 INFO - 2017-03-13 17:19:58.197 screenresolution[2202:27123] starting screenresolution argv=screenresolution list 17:19:58 INFO - Available Modes on Display 0 17:19:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:19:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:19:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:19:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:19:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:19:58 INFO - Intel Iris: 17:19:58 INFO - Chipset Model: Intel Iris 17:19:58 INFO - Type: GPU 17:19:58 INFO - Bus: Built-In 17:19:58 INFO - VRAM (Dynamic, Max): 1536 MB 17:19:58 INFO - Vendor: Intel (0x8086) 17:19:58 INFO - Device ID: 0x0a2e 17:19:58 INFO - Revision ID: 0x0009 17:19:58 INFO - Displays: 17:19:58 INFO - Display: 17:19:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:19:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:19:58 INFO - Display Serial Number: 1600x1200 60 17:19:58 INFO - Main Display: Yes 17:19:58 INFO - Mirror: Off 17:19:58 INFO - Online: Yes 17:19:58 INFO - Rotation: Supported 17:19:58 INFO - Return code: 0 17:19:58 INFO - Running post-action listener: _resource_record_post_action 17:19:58 INFO - [mozharness: 2017-03-14 00:19:58.432357Z] Finished run-tests step (success) 17:19:58 INFO - Running post-run listener: _resource_record_post_run 17:19:58 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 393216; Write bytes: 422119424; Read time: 5; Write time: 1453 17:19:58 INFO - TinderboxPrint: CPU usage
53.8% 17:19:58 INFO - TinderboxPrint: I/O read bytes / time
393,216 / 5 17:19:58 INFO - TinderboxPrint: I/O write bytes / time
422,119,424 / 1,453 17:19:58 INFO - TinderboxPrint: CPU idle
2,200.6 (46.2%) 17:19:58 INFO - TinderboxPrint: CPU system
956.3 (20.1%) 17:19:58 INFO - TinderboxPrint: CPU user
1,604.8 (33.7%) 17:19:58 INFO - TinderboxPrint: Swap in / out
121,835,520 / 0 17:19:58 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122724864; Write bytes: 122810368; Read time: 11175; Write time: 285 17:19:58 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 229376; Write bytes: 297932800; Read time: 3; Write time: 1157 17:19:58 INFO - Running post-run listener: _upload_blobber_files 17:19:58 INFO - Blob upload gear active. 17:19:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:19:58 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 17:19:58 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:19:58 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:19:59 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:00 INFO - (blobuploader) - INFO - Done attempting. 17:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:01 INFO - (blobuploader) - INFO - Done attempting. 17:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:02 INFO - (blobuploader) - INFO - Done attempting. 17:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:04 INFO - (blobuploader) - INFO - Done attempting. 17:20:04 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:04 INFO - Return code: 0 17:20:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/abd53fc9ee97a1933a47b9f4a1b43e1b5f88649d566ee11c8bf2304381cf8254a0ae36e6d7ca6926befefd36cb0b61fd477ad37eaec1020798d267b37b487303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8603d72e0f4014f1b5403e7c5b93f347a210d9d55ce9578e961546df6ea94af1cd36ca845370142be9355b910cf19b23a401cf39aad8f47b8b9536c27c079e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b7c052a0a13013128c40d49b60d7f6646e8a7d3a01f0041fc40cfcd95cf271d383a68154c0feabbddd332dd035186c6aa3d302a9472496da65cb437f7939a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f7f381cc3d5818957ba51e76bc105bde56a3a117d85be51dd3f16101fa094346c29b9b5f0a2fd67943bf089d6688da95d33dc8347df3ea45802d8ffbaa93b5d"} 17:20:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:04 INFO - Contents: 17:20:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/abd53fc9ee97a1933a47b9f4a1b43e1b5f88649d566ee11c8bf2304381cf8254a0ae36e6d7ca6926befefd36cb0b61fd477ad37eaec1020798d267b37b487303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8603d72e0f4014f1b5403e7c5b93f347a210d9d55ce9578e961546df6ea94af1cd36ca845370142be9355b910cf19b23a401cf39aad8f47b8b9536c27c079e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b7c052a0a13013128c40d49b60d7f6646e8a7d3a01f0041fc40cfcd95cf271d383a68154c0feabbddd332dd035186c6aa3d302a9472496da65cb437f7939a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f7f381cc3d5818957ba51e76bc105bde56a3a117d85be51dd3f16101fa094346c29b9b5f0a2fd67943bf089d6688da95d33dc8347df3ea45802d8ffbaa93b5d"} 17:20:04 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:04 INFO - Copying logs to upload dir... 17:20:04 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.933429 ========= master_lag: 2.42 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-13 17:20:06.802535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 17:20:06.805829) ========= 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.znwGKrWKF5/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.wCUUa3ShcG/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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/Mozilla-Beta/sha512/abd53fc9ee97a1933a47b9f4a1b43e1b5f88649d566ee11c8bf2304381cf8254a0ae36e6d7ca6926befefd36cb0b61fd477ad37eaec1020798d267b37b487303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8603d72e0f4014f1b5403e7c5b93f347a210d9d55ce9578e961546df6ea94af1cd36ca845370142be9355b910cf19b23a401cf39aad8f47b8b9536c27c079e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b7c052a0a13013128c40d49b60d7f6646e8a7d3a01f0041fc40cfcd95cf271d383a68154c0feabbddd332dd035186c6aa3d302a9472496da65cb437f7939a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f7f381cc3d5818957ba51e76bc105bde56a3a117d85be51dd3f16101fa094346c29b9b5f0a2fd67943bf089d6688da95d33dc8347df3ea45802d8ffbaa93b5d"} build_url:https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/Kz_bgvNdSdiHVYUjdl963w/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/abd53fc9ee97a1933a47b9f4a1b43e1b5f88649d566ee11c8bf2304381cf8254a0ae36e6d7ca6926befefd36cb0b61fd477ad37eaec1020798d267b37b487303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8603d72e0f4014f1b5403e7c5b93f347a210d9d55ce9578e961546df6ea94af1cd36ca845370142be9355b910cf19b23a401cf39aad8f47b8b9536c27c079e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b7c052a0a13013128c40d49b60d7f6646e8a7d3a01f0041fc40cfcd95cf271d383a68154c0feabbddd332dd035186c6aa3d302a9472496da65cb437f7939a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f7f381cc3d5818957ba51e76bc105bde56a3a117d85be51dd3f16101fa094346c29b9b5f0a2fd67943bf089d6688da95d33dc8347df3ea45802d8ffbaa93b5d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 17:20:06.847065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 17:20:06.847387) ========= 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.znwGKrWKF5/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.wCUUa3ShcG/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.005310 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 17:20:06.896172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 17:20:06.896491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 17:20:07.030994) ========= ========= Total master_lag: 2.71 =========