builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0207 starttime: 1480251244.26 results: success (0) buildid: 20161127030520 builduid: 752c4ce1ba534c68af234ceac90eefee revision: ae1f3e147014021a9224196f5224dd07b1a90f72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.257540) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.258008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.258300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.284043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.284635) ========= 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.KQcngwvI94/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.TisqDbPzFL/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-27 04:54:04-- 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% 7.64M=0.002s 2016-11-27 04:54:04 (7.64 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.501809 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.810081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.810436) ========= 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.KQcngwvI94/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.TisqDbPzFL/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.018607 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:04.859704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 04:54:04.860065) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ae1f3e147014021a9224196f5224dd07b1a90f72 --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 ae1f3e147014021a9224196f5224dd07b1a90f72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KQcngwvI94/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.TisqDbPzFL/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-27 04:54:04,939 truncating revision to first 12 chars 2016-11-27 04:54:04,939 Setting DEBUG logging. 2016-11-27 04:54:04,939 attempt 1/10 2016-11-27 04:54:04,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ae1f3e147014?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 04:54:06,480 unpacking tar archive at: mozilla-beta-ae1f3e147014/testing/mozharness/ program finished with exit code 0 elapsedTime=1.826028 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 04:54:06.709985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:06.710363) ========= script_repo_revision: ae1f3e147014021a9224196f5224dd07b1a90f72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:06.710863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:06.711151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 04:54:06.730871) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-27 04:54:06.731306) ========= /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.KQcngwvI94/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.TisqDbPzFL/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:06 INFO - MultiFileLogger online at 20161127 04:54:06 in /builds/slave/test 04:54:06 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 04:54:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:06 INFO - {'append_to_log': False, 04:54:06 INFO - 'base_work_dir': '/builds/slave/test', 04:54:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:54:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:06 INFO - 'branch': 'Mozilla-Beta', 04:54:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:06 INFO - 'config_files': ('talos/mac_config.py',), 04:54:06 INFO - 'default_actions': ('clobber', 04:54:06 INFO - 'read-buildbot-config', 04:54:06 INFO - 'download-and-extract', 04:54:06 INFO - 'populate-webroot', 04:54:06 INFO - 'create-virtualenv', 04:54:06 INFO - 'install', 04:54:06 INFO - 'run-tests'), 04:54:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:06 INFO - 'download_minidump_stackwalk': True, 04:54:06 INFO - 'download_symbols': 'ondemand', 04:54:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:06 INFO - 'installer_path': 'installer.exe', 04:54:06 INFO - 'log_level': 'info', 04:54:06 INFO - 'log_name': 'talos', 04:54:06 INFO - 'log_to_console': True, 04:54:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:54:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:54:06 INFO - 'opt_config_files': (), 04:54:06 INFO - 'pip_index': False, 04:54:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:06 INFO - 'cmd': ('bash', 04:54:06 INFO - '-c', 04:54:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:06 INFO - 'enabled': True, 04:54:06 INFO - 'halt_on_failure': False, 04:54:06 INFO - 'name': 'check_screen_resolution'},), 04:54:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:06 INFO - 'cmd': ('bash', 04:54:06 INFO - '-c', 04:54:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:06 INFO - 'enabled': True, 04:54:06 INFO - 'halt_on_failure': False, 04:54:06 INFO - 'name': 'check_screen_resolution'},), 04:54:06 INFO - 'run_cmd_checks_enabled': True, 04:54:06 INFO - 'sps_profile': False, 04:54:06 INFO - 'sps_profile_interval': 0, 04:54:06 INFO - 'suite': 'dromaeojs', 04:54:06 INFO - 'system_bits': '32', 04:54:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:06 INFO - 'title': 't-yosemite-r7-0207', 04:54:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:06 INFO - 'use_talos_json': True, 04:54:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:06 INFO - 'work_dir': 'build'} 04:54:06 INFO - [mozharness: 2016-11-27 12:54:06.935141Z] Running clobber step. 04:54:06 INFO - Running pre-action listener: _resource_record_pre_action 04:54:06 INFO - Running main action method: clobber 04:54:06 INFO - rmtree: /builds/slave/test/build 04:54:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:08 INFO - Running post-action listener: _resource_record_post_action 04:54:08 INFO - [mozharness: 2016-11-27 12:54:08.494897Z] Finished clobber step (success) 04:54:08 INFO - [mozharness: 2016-11-27 12:54:08.495025Z] Running read-buildbot-config step. 04:54:08 INFO - Running pre-action listener: _resource_record_pre_action 04:54:08 INFO - Running main action method: read_buildbot_config 04:54:08 INFO - Using buildbot properties: 04:54:08 INFO - { 04:54:08 INFO - "project": "", 04:54:08 INFO - "product": "firefox", 04:54:08 INFO - "script_repo_revision": "production", 04:54:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:54:08 INFO - "repository": "", 04:54:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:54:08 INFO - "buildid": "20161127030520", 04:54:08 INFO - "pgo_build": "False", 04:54:08 INFO - "basedir": "/builds/slave/test", 04:54:08 INFO - "buildnumber": 28, 04:54:08 INFO - "slavename": "t-yosemite-r7-0207", 04:54:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:54:08 INFO - "platform": "yosemite_r7", 04:54:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:54:08 INFO - "branch": "mozilla-beta", 04:54:08 INFO - "repo_path": "releases/mozilla-beta", 04:54:08 INFO - "revision": "ae1f3e147014021a9224196f5224dd07b1a90f72", 04:54:08 INFO - "stage_platform": "macosx64", 04:54:08 INFO - "builduid": "752c4ce1ba534c68af234ceac90eefee", 04:54:08 INFO - "slavebuilddir": "test" 04:54:08 INFO - } 04:54:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 04:54:08 INFO - Running post-action listener: _resource_record_post_action 04:54:08 INFO - [mozharness: 2016-11-27 12:54:08.498374Z] Finished read-buildbot-config step (success) 04:54:08 INFO - [mozharness: 2016-11-27 12:54:08.498516Z] Running download-and-extract step. 04:54:08 INFO - Running pre-action listener: _resource_record_pre_action 04:54:08 INFO - Running main action method: download_and_extract 04:54:08 INFO - mkdir: /builds/slave/test/build/tests 04:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:08 INFO - trying https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 04:54:08 INFO - Downloading https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 04:54:09 INFO - Downloaded 1165 bytes. 04:54:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:54:09 INFO - Using the following test package requirements: 04:54:09 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:54:09 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:54:09 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 04:54:09 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:54:09 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 04:54:09 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:54:09 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:54:09 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 04:54:09 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:54:09 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:54:09 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 04:54:09 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:54:09 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 04:54:09 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:54:09 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 04:54:09 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:54:09 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 04:54:09 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 04:54:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:54:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:54:09 INFO - Fetch https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:54:09 INFO - Expected file size: 16232546 04:54:16 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:54:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:54:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:54:16 INFO - Fetch https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:54:17 INFO - Expected file size: 16232546 04:54:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 04:54:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 04:54:23 INFO - Fetch https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 04:54:24 INFO - Expected file size: 14414089 04:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:24 INFO - trying https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:54:24 INFO - Downloading https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 04:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 04:54:27 INFO - Downloaded 86050125 bytes. 04:54:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:54:27 INFO - mkdir: /builds/slave/test/properties 04:54:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:27 INFO - Contents: 04:54:27 INFO - build_url:https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - Running post-action listener: set_extra_try_arguments 04:54:27 INFO - [mozharness: 2016-11-27 12:54:27.757136Z] Finished download-and-extract step (success) 04:54:27 INFO - [mozharness: 2016-11-27 12:54:27.757262Z] Running populate-webroot step. 04:54:27 INFO - Running pre-action listener: _resource_record_pre_action 04:54:27 INFO - Running main action method: populate_webroot 04:54:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:27 INFO - '--tppagecycles', 04:54:27 INFO - '7'], 04:54:27 INFO - 'tests': ['tsvgm']}}, 04:54:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['damp', 'tps']}, 04:54:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'tests': ['damp', 'tps']}, 04:54:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['dromaeo_dom']}, 04:54:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['basic_compositor_video']}, 04:54:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:54:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['a11yr', 04:54:27 INFO - 'ts_paint', 04:54:27 INFO - 'tpaint', 04:54:27 INFO - 'sessionrestore', 04:54:27 INFO - 'sessionrestore_no_auto_restore', 04:54:27 INFO - 'tabpaint']}, 04:54:27 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:27 INFO - 'ts_paint', 04:54:27 INFO - 'tpaint', 04:54:27 INFO - 'sessionrestore', 04:54:27 INFO - 'sessionrestore_no_auto_restore', 04:54:27 INFO - 'tabpaint']}, 04:54:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:27 INFO - 'ts_paint', 04:54:27 INFO - 'tpaint', 04:54:27 INFO - 'sessionrestore', 04:54:27 INFO - 'sessionrestore_no_auto_restore', 04:54:27 INFO - 'tabpaint']}, 04:54:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:27 INFO - 'ts_paint', 04:54:27 INFO - 'tpaint', 04:54:27 INFO - 'sessionrestore', 04:54:27 INFO - 'sessionrestore_no_auto_restore', 04:54:27 INFO - 'tabpaint']}, 04:54:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['a11yr', 04:54:27 INFO - 'ts_paint', 04:54:27 INFO - 'tpaint', 04:54:27 INFO - 'sessionrestore', 04:54:27 INFO - 'sessionrestore_no_auto_restore', 04:54:27 INFO - 'tabpaint']}, 04:54:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['a11yr', 04:54:27 INFO - 'ts_paint', 04:54:27 INFO - 'tpaint', 04:54:27 INFO - 'sessionrestore', 04:54:27 INFO - 'sessionrestore_no_auto_restore', 04:54:27 INFO - 'tabpaint']}, 04:54:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['tsvgx', 04:54:27 INFO - 'tsvgr_opacity', 04:54:27 INFO - 'tart', 04:54:27 INFO - 'tscrollx', 04:54:27 INFO - 'cart']}, 04:54:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:27 INFO - 'tsvgr_opacity', 04:54:27 INFO - 'tart', 04:54:27 INFO - 'tscrollx', 04:54:27 INFO - 'cart']}, 04:54:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'talos_options': ['--disable-e10s'], 04:54:27 INFO - 'tests': ['tp5o']}, 04:54:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'tests': ['tp5o']}, 04:54:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'talos_options': ['--disable-e10s', 04:54:27 INFO - '--xperf_path', 04:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:27 INFO - 'tests': ['tp5n']}, 04:54:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:27 INFO - 'talos_options': ['--xperf_path', 04:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:27 INFO - 'tests': ['tp5n']}}, 04:54:27 INFO - 'talos.zip': {'path': '', 04:54:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - [mozharness: 2016-11-27 12:54:27.775914Z] Finished populate-webroot step (success) 04:54:27 INFO - [mozharness: 2016-11-27 12:54:27.776046Z] Running create-virtualenv step. 04:54:27 INFO - Running pre-action listener: _resource_record_pre_action 04:54:27 INFO - Running main action method: create_virtualenv 04:54:27 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:27 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 04:54:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:27 INFO - Using real prefix '/tools/python27' 04:54:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:31 INFO - Installing pip.................done. 04:54:31 INFO - Return code: 0 04:54:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54:31 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')]} 04:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:31 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')]} 04:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:31 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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:31 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 04:54:31 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 04:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:31 INFO - 'HOME': '/Users/cltbld', 04:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:31 INFO - 'LOGNAME': 'cltbld', 04:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:31 INFO - 'MOZ_NO_REMOTE': '1', 04:54:31 INFO - 'NO_EM_RESTART': '1', 04:54:31 INFO - 'PAGER': '/bin/cat', 04:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:31 INFO - 'PWD': '/builds/slave/test', 04:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:31 INFO - 'SHELL': '/bin/bash', 04:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:31 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:31 INFO - 'USER': 'cltbld', 04:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:31 INFO - 'XPC_FLAGS': '0x0', 04:54:31 INFO - 'XPC_SERVICE_NAME': '0', 04:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:31 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 04:54:31 INFO - Cleaning up... 04:54:31 INFO - Return code: 0 04:54:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:54:31 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')]} 04:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:31 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')]} 04:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:31 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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:31 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 04:54:31 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 04:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:31 INFO - 'HOME': '/Users/cltbld', 04:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:31 INFO - 'LOGNAME': 'cltbld', 04:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:31 INFO - 'MOZ_NO_REMOTE': '1', 04:54:31 INFO - 'NO_EM_RESTART': '1', 04:54:31 INFO - 'PAGER': '/bin/cat', 04:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:31 INFO - 'PWD': '/builds/slave/test', 04:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:31 INFO - 'SHELL': '/bin/bash', 04:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:31 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:31 INFO - 'USER': 'cltbld', 04:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:31 INFO - 'XPC_FLAGS': '0x0', 04:54:31 INFO - 'XPC_SERVICE_NAME': '0', 04:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:31 INFO - Downloading/unpacking psutil>=3.1.1 04:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:36 INFO - Installing collected packages: psutil 04:54:36 INFO - Running setup.py install for psutil 04:54:36 INFO - building 'psutil._psutil_osx' extension 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 INFO - building 'psutil._psutil_posix' extension 04:54:36 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 04:54:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:54:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:54:36 INFO - ^ 04:54:36 INFO - 1 warning generated. 04:54:36 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 04:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:36 INFO - Successfully installed psutil 04:54:36 INFO - Cleaning up... 04:54:36 INFO - Return code: 0 04:54:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:36 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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:36 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 04:54:36 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 04:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:36 INFO - 'HOME': '/Users/cltbld', 04:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:36 INFO - 'LOGNAME': 'cltbld', 04:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:36 INFO - 'MOZ_NO_REMOTE': '1', 04:54:36 INFO - 'NO_EM_RESTART': '1', 04:54:36 INFO - 'PAGER': '/bin/cat', 04:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:36 INFO - 'PWD': '/builds/slave/test', 04:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:36 INFO - 'SHELL': '/bin/bash', 04:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:36 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:36 INFO - 'USER': 'cltbld', 04:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:36 INFO - 'XPC_FLAGS': '0x0', 04:54:36 INFO - 'XPC_SERVICE_NAME': '0', 04:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:54:37 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 04:54:37 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 04:54:37 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 04:54:37 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 04:54:37 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 04:54:37 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 04:54:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:54:39 INFO - Installing collected packages: mozsystemmonitor 04:54:39 INFO - Running setup.py install for mozsystemmonitor 04:54:39 INFO - Successfully installed mozsystemmonitor 04:54:39 INFO - Cleaning up... 04:54:39 INFO - Return code: 0 04:54:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:54: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 jsonschema==2.5.1 04:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:39 INFO - 'HOME': '/Users/cltbld', 04:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:39 INFO - 'LOGNAME': 'cltbld', 04:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:39 INFO - 'MOZ_NO_REMOTE': '1', 04:54:39 INFO - 'NO_EM_RESTART': '1', 04:54:39 INFO - 'PAGER': '/bin/cat', 04:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:39 INFO - 'PWD': '/builds/slave/test', 04:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:39 INFO - 'SHELL': '/bin/bash', 04:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:39 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:40 INFO - 'USER': 'cltbld', 04:54:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:40 INFO - 'XPC_FLAGS': '0x0', 04:54:40 INFO - 'XPC_SERVICE_NAME': '0', 04:54:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:54:42 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 04:54:42 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 04:54:42 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 04:54:42 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 04:54:42 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 04:54:42 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 04:54:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:43 INFO - warning: no files found matching '*.txt' 04:54:43 INFO - no previously-included directories found matching 'build' 04:54:43 INFO - no previously-included directories found matching 'dist' 04:54:43 INFO - no previously-included directories found matching '.git*' 04:54:43 INFO - Installing collected packages: jsonschema, functools32 04:54:43 INFO - Running setup.py install for functools32 04:54:43 INFO - warning: no files found matching '*.txt' 04:54:43 INFO - no previously-included directories found matching 'build' 04:54:43 INFO - no previously-included directories found matching 'dist' 04:54:43 INFO - no previously-included directories found matching '.git*' 04:54:43 INFO - Successfully installed jsonschema functools32 04:54:43 INFO - Cleaning up... 04:54:43 INFO - Return code: 0 04:54:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:54: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 functools32==3.2.3-2 04:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:43 INFO - 'HOME': '/Users/cltbld', 04:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:43 INFO - 'LOGNAME': 'cltbld', 04:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:43 INFO - 'MOZ_NO_REMOTE': '1', 04:54:43 INFO - 'NO_EM_RESTART': '1', 04:54:43 INFO - 'PAGER': '/bin/cat', 04:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:43 INFO - 'PWD': '/builds/slave/test', 04:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:43 INFO - 'SHELL': '/bin/bash', 04:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:43 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:43 INFO - 'USER': 'cltbld', 04:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:43 INFO - 'XPC_FLAGS': '0x0', 04:54:43 INFO - 'XPC_SERVICE_NAME': '0', 04:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:54:43 INFO - Cleaning up... 04:54:43 INFO - Return code: 0 04:54:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:54: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 blobuploader==1.2.4 04:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:43 INFO - 'HOME': '/Users/cltbld', 04:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:43 INFO - 'LOGNAME': 'cltbld', 04:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:43 INFO - 'MOZ_NO_REMOTE': '1', 04:54:43 INFO - 'NO_EM_RESTART': '1', 04:54:43 INFO - 'PAGER': '/bin/cat', 04:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:43 INFO - 'PWD': '/builds/slave/test', 04:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:43 INFO - 'SHELL': '/bin/bash', 04:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:43 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:43 INFO - 'USER': 'cltbld', 04:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:43 INFO - 'XPC_FLAGS': '0x0', 04:54:43 INFO - 'XPC_SERVICE_NAME': '0', 04:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:46 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 04:54:46 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 04:54:46 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 04:54:46 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 04:54:46 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 04:54:46 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 04:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:48 INFO - Downloading docopt-0.6.1.tar.gz 04:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:48 INFO - Running setup.py install for blobuploader 04:54:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:48 INFO - Running setup.py install for requests 04:54:48 INFO - Running setup.py install for docopt 04:54:48 INFO - Successfully installed blobuploader requests docopt 04:54:48 INFO - Cleaning up... 04:54:48 INFO - Return code: 0 04:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:48 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')]} 04:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 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')]} 04:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:48 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 04:54:48 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 04:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:48 INFO - 'HOME': '/Users/cltbld', 04:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:48 INFO - 'LOGNAME': 'cltbld', 04:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:48 INFO - 'MOZ_NO_REMOTE': '1', 04:54:48 INFO - 'NO_EM_RESTART': '1', 04:54:48 INFO - 'PAGER': '/bin/cat', 04:54:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:48 INFO - 'PWD': '/builds/slave/test', 04:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:48 INFO - 'SHELL': '/bin/bash', 04:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:48 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:48 INFO - 'USER': 'cltbld', 04:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:48 INFO - 'XPC_FLAGS': '0x0', 04:54:48 INFO - 'XPC_SERVICE_NAME': '0', 04:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-XU9UvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-TP2y1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-IAu__h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-djJD3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-WV7vtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-84gMyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-57Ofrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Tn90iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-mYuOja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-HIV8gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-TY8j8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-eYlEmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-eWxd53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-dTnzXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-KyZR1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-DfqPM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-HoTm5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:50 INFO - Running setup.py install for manifestparser 04:54:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Running setup.py install for mozcrash 04:54:51 INFO - Running setup.py install for mozdebug 04:54:51 INFO - Running setup.py install for mozdevice 04:54:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Running setup.py install for mozfile 04:54:51 INFO - Running setup.py install for mozhttpd 04:54:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Running setup.py install for mozinfo 04:54:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Running setup.py install for mozInstall 04:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Running setup.py install for mozleak 04:54:52 INFO - Running setup.py install for mozlog 04:54:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Running setup.py install for moznetwork 04:54:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Running setup.py install for mozprocess 04:54:52 INFO - Running setup.py install for mozprofile 04:54:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Running setup.py install for mozrunner 04:54:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:53 INFO - Running setup.py install for mozscreenshot 04:54:53 INFO - Running setup.py install for moztest 04:54:53 INFO - Running setup.py install for mozversion 04:54:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:53 INFO - Cleaning up... 04:54:53 INFO - Return code: 0 04:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:53 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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:53 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 04:54:53 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 04:54:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:53 INFO - 'HOME': '/Users/cltbld', 04:54:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:53 INFO - 'LOGNAME': 'cltbld', 04:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:53 INFO - 'MOZ_NO_REMOTE': '1', 04:54:53 INFO - 'NO_EM_RESTART': '1', 04:54:53 INFO - 'PAGER': '/bin/cat', 04:54:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:53 INFO - 'PWD': '/builds/slave/test', 04:54:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:53 INFO - 'SHELL': '/bin/bash', 04:54:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:53 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:53 INFO - 'USER': 'cltbld', 04:54:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:53 INFO - 'XPC_FLAGS': '0x0', 04:54:53 INFO - 'XPC_SERVICE_NAME': '0', 04:54:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-_IUJgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:53 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)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-9mn2C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-u933Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-MZ7J4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-7CBsnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-06xN6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-whfnJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-64Rmgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-LEgSdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-g2JzaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Z571Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Eri7_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-JGaHYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-eDT7op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-MQYjni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-EOuCaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-7DlgMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:55 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)) 04:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:55 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)) 04:54:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:58 INFO - Downloading blessings-1.6.tar.gz 04:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:58 INFO - Installing collected packages: blessings 04:54:58 INFO - Running setup.py install for blessings 04:54:58 INFO - Successfully installed blessings 04:54:58 INFO - Cleaning up... 04:54:58 INFO - Return code: 0 04:54:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:58 INFO - Reading from file tmpfile_stdout 04:54:58 INFO - Current package versions: 04:54:58 INFO - blessings == 1.6 04:54:58 INFO - blobuploader == 1.2.4 04:54:58 INFO - docopt == 0.6.1 04:54:58 INFO - functools32 == 3.2.3-2 04:54:58 INFO - jsonschema == 2.5.1 04:54:58 INFO - manifestparser == 1.1 04:54:58 INFO - mozInstall == 1.12 04:54:58 INFO - mozcrash == 0.17 04:54:58 INFO - mozdebug == 0.1 04:54:58 INFO - mozdevice == 0.48 04:54:58 INFO - mozfile == 1.2 04:54:58 INFO - mozhttpd == 0.7 04:54:58 INFO - mozinfo == 0.9 04:54:58 INFO - mozleak == 0.1 04:54:58 INFO - mozlog == 3.4 04:54:58 INFO - moznetwork == 0.27 04:54:58 INFO - mozprocess == 0.23 04:54:58 INFO - mozprofile == 0.28 04:54:58 INFO - mozrunner == 6.12 04:54:58 INFO - mozscreenshot == 0.1 04:54:58 INFO - mozsystemmonitor == 0.3 04:54:58 INFO - moztest == 0.7 04:54:58 INFO - mozversion == 1.4 04:54:58 INFO - psutil == 3.1.1 04:54:58 INFO - requests == 1.2.3 04:54:58 INFO - wsgiref == 0.1.2 04:54:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:58 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 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:58 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 04:54:58 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 04:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:58 INFO - 'HOME': '/Users/cltbld', 04:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:58 INFO - 'LOGNAME': 'cltbld', 04:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:58 INFO - 'MOZ_NO_REMOTE': '1', 04:54:58 INFO - 'NO_EM_RESTART': '1', 04:54:58 INFO - 'PAGER': '/bin/cat', 04:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:58 INFO - 'PWD': '/builds/slave/test', 04:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:58 INFO - 'SHELL': '/bin/bash', 04:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:58 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:58 INFO - 'USER': 'cltbld', 04:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:58 INFO - 'XPC_FLAGS': '0x0', 04:54:58 INFO - 'XPC_SERVICE_NAME': '0', 04:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 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)) 04:54:59 INFO - Cleaning up... 04:54:59 INFO - Return code: 0 04:54:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c88e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c804570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c9595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, '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.KQcngwvI94/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.TisqDbPzFL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 04:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:59 INFO - 'HOME': '/Users/cltbld', 04:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:59 INFO - 'LOGNAME': 'cltbld', 04:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:59 INFO - 'MOZ_NO_REMOTE': '1', 04:54:59 INFO - 'NO_EM_RESTART': '1', 04:54:59 INFO - 'PAGER': '/bin/cat', 04:54:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:59 INFO - 'PWD': '/builds/slave/test', 04:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:59 INFO - 'SHELL': '/bin/bash', 04:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:54:59 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:59 INFO - 'USER': 'cltbld', 04:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:59 INFO - 'XPC_FLAGS': '0x0', 04:54:59 INFO - 'XPC_SERVICE_NAME': '0', 04:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:54:59 INFO - Cleaning up... 04:54:59 INFO - Return code: 0 04:54:59 INFO - Running post-action listener: _resource_record_post_action 04:54:59 INFO - Running post-action listener: _start_resource_monitoring 04:54:59 INFO - Starting resource monitoring. 04:54:59 INFO - [mozharness: 2016-11-27 12:54:59.416139Z] Finished create-virtualenv step (success) 04:54:59 INFO - [mozharness: 2016-11-27 12:54:59.417131Z] Running install step. 04:54:59 INFO - Running pre-action listener: _resource_record_pre_action 04:54:59 INFO - Running main action method: install 04:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:59 INFO - Reading from file tmpfile_stdout 04:54:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:59 INFO - Reading from file tmpfile_stdout 04:54:59 INFO - Output received: 04:54:59 INFO - Usage: mozinstall [options] installer 04:54:59 INFO - Options: 04:54:59 INFO - -h, --help show this help message and exit 04:54:59 INFO - -d DEST, --destination=DEST 04:54:59 INFO - Directory to install application into. [default: 04:54:59 INFO - "/builds/slave/test"] 04:54:59 INFO - --app=APP Application being installed. [default: firefox] 04:54:59 INFO - mkdir: /builds/slave/test/build/application 04:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:55:21 INFO - Reading from file tmpfile_stdout 04:55:21 INFO - Output received: 04:55:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:55:21 INFO - Running post-action listener: _resource_record_post_action 04:55:21 INFO - [mozharness: 2016-11-27 12:55:21.342783Z] Finished install step (success) 04:55:21 INFO - [mozharness: 2016-11-27 12:55:21.342914Z] Running run-tests step. 04:55:21 INFO - Running pre-action listener: _resource_record_pre_action 04:55:21 INFO - Running main action method: run_tests 04:55:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:21 INFO - 2016-11-27 04:55:21.357 screenresolution[1945:25399] starting screenresolution argv=screenresolution get 04:55:21 INFO - 2016-11-27 04:55:21.360 screenresolution[1945:25399] Display 0: 1600x1200x32@60 04:55:21 INFO - 2016-11-27 04:55:21.365 screenresolution[1946:25402] starting screenresolution argv=screenresolution list 04:55:21 INFO - Available Modes on Display 0 04:55:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:21 INFO - Intel Iris: 04:55:21 INFO - Chipset Model: Intel Iris 04:55:21 INFO - Type: GPU 04:55:21 INFO - Bus: Built-In 04:55:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:21 INFO - Vendor: Intel (0x8086) 04:55:21 INFO - Device ID: 0x0a2e 04:55:21 INFO - Revision ID: 0x0009 04:55:21 INFO - Displays: 04:55:21 INFO - Display: 04:55:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:21 INFO - Display Serial Number: 1600x1200 60 04:55:21 INFO - Main Display: Yes 04:55:21 INFO - Mirror: Off 04:55:21 INFO - Online: Yes 04:55:21 INFO - Rotation: Supported 04:55:21 INFO - Return code: 0 04:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:55:21 INFO - Python 2.7.3 04:55:21 INFO - Return code: 0 04:55:21 INFO - grabbing minidump binary from tooltool 04:55:21 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')]} 04:55:21 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 0x10c6a2d30>, '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 0x10c508db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c69ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:55:21 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 04:55:21 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 04:55:21 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 04:55:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:21 INFO - Return code: 0 04:55:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:55:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:55:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:55:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:55:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:55:21 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/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 04:55:21 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/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0207 --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 04:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KQcngwvI94/Render', 04:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:21 INFO - 'HOME': '/Users/cltbld', 04:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:21 INFO - 'LOGNAME': 'cltbld', 04:55:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:55:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:21 INFO - 'MOZ_NO_REMOTE': '1', 04:55:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:55:21 INFO - 'NO_EM_RESTART': '1', 04:55:21 INFO - 'PAGER': '/bin/cat', 04:55:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:21 INFO - 'PWD': '/builds/slave/test', 04:55:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:21 INFO - 'SHELL': '/bin/bash', 04:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TisqDbPzFL/Listeners', 04:55:21 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 04:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:21 INFO - 'USER': 'cltbld', 04:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:21 INFO - 'XPC_FLAGS': '0x0', 04:55:21 INFO - 'XPC_SERVICE_NAME': '0', 04:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:21 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/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 04:55:21 INFO - mozversion application_buildid: 20161127030520 04:55:21 INFO - mozversion application_changeset: ae1f3e147014021a9224196f5224dd07b1a90f72 04:55:21 INFO - mozversion application_display_name: Firefox 04:55:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:21 INFO - mozversion application_name: Firefox 04:55:21 INFO - mozversion application_remotingname: firefox 04:55:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:55:21 INFO - mozversion application_vendor: Mozilla 04:55:21 INFO - mozversion application_version: 51.0 04:55:21 INFO - mozversion platform_buildid: 20161127030520 04:55:21 INFO - mozversion platform_changeset: ae1f3e147014021a9224196f5224dd07b1a90f72 04:55:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:55:21 INFO - mozversion platform_version: 51.0 04:55:21 INFO - using testdate: 1480251321 04:55:21 INFO - actual date: 1480251321 04:55:21 INFO - starting webserver on 'localhost:56112' 04:55:21 INFO - SUITE-START | Running 2 tests 04:55:21 INFO - TEST-START | dromaeo_css 04:55:21 INFO - operating with platform_type : mac_ 04:55:21 INFO - Initialising browser for dromaeo_css test... 04:55:21 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpYRZ0MK/profile http://localhost:56112/getInfo.html) 04:55:24 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 04:55:24 INFO - PROCESS | 1956 | colorDepth:24 04:55:24 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 04:55:24 INFO - PROCESS | 1956 | __metrics 04:55:24 INFO - PROCESS | 1956 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:55:24 INFO - PROCESS | 1956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:24 INFO - TEST-INFO | 1956: exit 0 04:55:24 INFO - Browser initialized. 04:55:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:24 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpYRZ0MK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:36 INFO - PROCESS | 1959 | RSS: Main: 167923712 04:55:36 INFO - PROCESS | 1959 | 04:56:28 INFO - PROCESS | 1959 | 1480251388493 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:58:38 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:56112/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56112/tests/dromaeo/cssquery-ext.html) 04:58:40 INFO - PROCESS | 1959 | RSS: Main: 269803520 04:58:40 INFO - PROCESS | 1959 | 05:01:42 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:56112/tests/dromaeo/cssquery-ext.html (next: http://localhost:56112/tests/dromaeo/cssquery-jquery.html) 05:01:43 INFO - PROCESS | 1959 | RSS: Main: 299782144 05:01:43 INFO - PROCESS | 1959 | 05:04:45 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:56112/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56112/tests/dromaeo/cssquery-mootools.html) 05:04:46 INFO - PROCESS | 1959 | RSS: Main: 272400384 05:04:46 INFO - PROCESS | 1959 | 05:07:48 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:56112/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56112/tests/dromaeo/cssquery-prototype.html) 05:07:49 INFO - PROCESS | 1959 | RSS: Main: 293863424 05:07:49 INFO - PROCESS | 1959 | 05:10:52 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:56112/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56112/tests/dromaeo/cssquery-yui.html) 05:10:52 INFO - PROCESS | 1959 | RSS: Main: 261197824 05:10:52 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:56112/tests/dromaeo/cssquery-yui.html (next: http://localhost:56112/tests/dromaeo/cssquery-dojo.html) 05:13:55 INFO - PROCESS | 1959 | RSS: Main: 410947584 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | __start_tp_report 05:13:55 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 05:13:55 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 05:13:55 INFO - PROCESS | 1959 | |i|pagename|runs| 05:13:55 INFO - PROCESS | 1959 | |0;dojo.html;3419.4016047191735;3436.6906978371944;3457.032031031309;3461.1866211440324;3505.754597178197;4773.976130119348;5741.511971482424;5799.56503262256;5804.419558044194;5835.183074369592;5750.166225897253;5796.478316951474;5815.156802263669;5823.592348535604;5827.679477628729;5279.102552566053;5294.7617357219015;5309.0709125903;5342.893142137155;5358.732063396834;5258.237555554442;5268.236105764662;5268.288781014571;5397.055515284829;5413.079776438015;5286.180642000496;5302.628815982883;5304.071787437202;5315.946840531584;5318.973405132988;5322.2814919985885;5331.813386531472;5385.7307134643115;5386.569074474072;5390.353157621072;5183.585313174937;5249.658772179796;5302.522772950414;5318.521333080042;5336.439673834269;4694.671373003857;5689.146628005791;5732.770689172428;5740.253767010304;5742.770289188427;6187.628742275433;6241.662044878811;6269.279032911228;6280.842978925518;6298.842528936768;6240.344763799781;6257.8748425031245;6293.307736149066;6298.6535740534255;6305.3379395163765;5713.0287851065;5761.539076873882;5763.510101641324;5817.185594016841;5824.88350232993;6309.3690630936535;6348.984162533972;6354.91966365719;6356.745730170742;6365.52258580599;6229.0967809667345;6233.407826256498;6239.937600624026;6250.218722659668;6255.343188965184;4846.660733748604;5798.275215598051;5866.384029676908;6250.968745156245;6310.873782524323;6201.317855035943;6296.401841825111;6310.7791227306825;6317.747290108436;6319.494440444753;6160.815175544741;6281.780137695158;6295.748170073146;6301.747930082837;6321.399467050623;4937.086638971802;4993.550580447704;5013.824516141917;5063.417706963673;5066.214736715815;4485.753283569435;4511.300748384006;4525.954740452619;4538.795754191069;4618.960733834861;5967.283925928917;5979.342272350038;5992.550558708114;6023.216981792339;6027.60820546663;6295.276043255084;6298.118263443122;6307.779227727007;6312.053192021233;6324.588901721373;5747.224124743189;5848.385919478478;5881.206037185011;5921.73352199152;5938.881222375615;4879;5383.353997520323;5501.532369748536;5504.201890725903;5507.366652834975;6444.420002199825;6451.580647258007;6456.612603243821;6470;6496.382843629847;5212.452692467388;6121.696863452088;6246.937530624636;6247.625142491465;6308.653024083719;6339.302676705466;6422.871542569216;6434.935650643433;6440.67796610177;6446.871062578628;6217.0052791553135;6278.4035516625845;6301.243850737941;6309.2744334400295;6313.526485513697;6206.286277078194;6264.655443950626;6307.684615769102;6334.809955701337;6359.9188138015725;5334.973325133349;5967;6105.511559075175;6114.327423983269;6218.5647004709235;6082.330943596289;6164.561256460958;6182.319944805978;6188.535859810622;6202.689865506616;5910.970445147746;6015.338312785502;6084.3915608440575;6090.330063693079;6113.663748493876;6068.423499767515;6108;6112.868254062901;6127.662978536223;6220.066989951362;6094.39056094387;6102.228778756885;6122.39815511198;6123.8162855114415;6131.63210207389 05:13:55 INFO - PROCESS | 1959 | |1;ext.html;466.1934852704821;479.8536446383854;529.1190168369665;533.9614449894956;558.1739026241161;31909.36181276376;35522.28955420893;42150.36774448382;43262;43552.56447435525;44285.7785711071;44773.552264477345;44798.328025079565;44887.10225795482;44941.7752911235;7595;7605.923940760577;7708.922910770904;7825.765227043198;7895.921040789576;9348.626054957793;9561.760955976086;12180.756384872297;12459.190152640094;12493.937530312336;12410.193337433038;12499.312537810416;12504.937475312656;12512.061595380337;12515.311657858814;12400.069994750429;12480.50077996879;12483;12493.437795299233;12504.124711270215;12305.323207223688;12349.876501234963;12353.567625133077;12379.442925068393;12390.62828115158;42216.366754498704;42519.787401063106;42564.78717606423;42617.78691106556;42682;3710.9072273193115;3737.177820879402;3751.1934933989323;4085.836566537335;4263.914721705549;25655.871720641466;28167.73245203971;31169.22076948072;32658.346833063442;32715.6728432715;3297.225152089257;3404.676555727202;3454.481827725836;3503.7897726136257;3543.663351981583;510627;516069;516130;516625;516817;51286.743566281926;61676.383236167065;61818.69090654608;61976.38023619706;62174;36304.45543316852;36824.26351473009;37017.25965480675;38149.23701525954;38182.42726359107;17830;17963.012034337975;18013.7297940531;18019.459416217534;18061.825981311173;12552.87447125517;12803.935980320224;13648.976326775532;13758.174509529461;13761.38073786682;17657.735133973;17689.93860368382;17746.29014839392;19466.61630368878;20010.799892001185;6793.490488213404;7830.686772529149;7931.365490760841;8072.466231416012;8199.549024803693;762.5005621318046;863.4301361101643;933.5239028095584;943.7687766497252;1084.8915108489246;24454.388640284134;25379;26837;31448.213794655316;31732;912.748994026648;1067.6903697927514;1075.2526993739275;1123.1576317761678;1154.5785788187252;15678.451254206047;15938.760918586231;16017.919910400373;16025.839741602667;16355.83644163543;727425;734571;735591;736391;737224;60217.69891150516;60812.39187608067;60935.08597371043;60986.39013609896;61029.694851525455;1247.5820600098887;1274.1335891593806;1307.0458565247422;1387.6669599295894;1428.0432110486;30017.849910750305;30992.070237891996;31815.6818431822;31877.043688689377;32364.83817580897;50177.745556361384;50725.49274507208;50730.73173170553;50754.74622626863;50967;585103;588822;588862;590659;883553;24017.759822401553;24395.780210989735;24406.02375904944;24423.877880610482;26722.19833405001;40435.39346909858;47695.04609907852;49134.262986055954;49230.50769492259;49735.502644974535;38729.6127038726;40230.59192928234;40775.59224407718;41397;41409.79295103505;36075.917722468366;40462.895848433865;40522.797386012884;40594.59405405908;41971.58028419677;38663.61336386712;39183.41224881572;39531.60468395279;39894.60105398909;40032.79983600063;33616.663833362334;35099.473507897914;35226.647733523365;35481.406392785146;35560.110997225274;24184.51630967406;24258.757437195556;25924.35189120287;26417.33956651099;26855.86572067127 05:13:55 INFO - PROCESS | 1959 | |2;jquery.html;383.51485371005685;392.1275162762853;394.5324790123705;400.4633790720435;417.1739954889319;15678.529644110695;20493.795062049394;21416.25043123491;22218;22250.666240006412;16713.582160445963;19567.315143969965;21186.364409067715;21411.785882141176;21515;5832.066869300913;6158.692065396713;6162.22972128484;6167.0749387591995;6173.59871608344;5000.549950504454;6047.727852246638;6068.908966365508;6099.634021958675;6126.877462450749;6164.506839452855;6179.536534759911;6181.350958149397;6181.90727139091;6194.659293738842;5933.5549833762425;6111.969440152815;6201.007838745779;6204.9689751551405;6207.006878899377;5091.414487333967;5137.332146820927;5960.254968128984;5988.550858685616;5998.640081595118;24168;24964.00143994238;25200.49599008028;25485;25532.87233563839;2154.407537927067;2167.2739632223224;2234.6871437998693;2486.5275597636573;2723.3872378714827;8991.325650576167;9377.484238366887;9388.202002829768;9725.805483890283;10250.33372830771;1841.235887106849;1873.100911562444;1895.9336423225259;1906.323255244396;1942.223110755695;124265;124835.9999999991;131161;139995;140223.89664155047;9900.653477128266;10967;11184.832227516594;11263.26788758728;11618.186726929203;14944.178070206026;14958;14962.17708026069;14969.401223951138;14980.925095374454;7811.49225300365;8168.550729709923;8186.713465028695;8476.406651534457;8512.616932238065;8789.912100879037;8890.244329231959;8932.821343573092;8961.23829474489;9017;3927.509061367329;4137.668986481134;4561.657875659339;4604.1252162089095;4608.695652173913;1797.6764182447023;1824.9746393844384;1826.032202932448;1910.3218357483172;1940.379078694804;841.9200175983271;903.0337538833517;918.8300164469595;971.562796741455;989.851522271665;18171.182296796676;18473.1687074082;20600.484987875123;21213.257535986166;22151.667724984138;914.6661468563926;936.3585943628636;971.9562619682131;982.557848967953;1013.5793645637126;9174.32101210671;10693.41186234749;11378.431078446045;11383.487743051583;11469;591000;625087;629259;639649;649644;105337.47331263295;106027;135518;136859;143523;947.2185447006248;958.4009993754044;973.9951300243454;974.7904200596905;975.2782940623887;15496.767548487007;18474.983875886417;18847.057647117865;18945.52636184051;19118.94845783495;39286;50701.74649126731;51318.40771145984;56629.31909425874;57524.84950300887;77207.61396192983;82263;82392;82487;83344;5829.979753543028;7977.880331794911;8308.418410711192;8396.832063358821;8423.241908228289;12871.420786064462;12880.291583962597;12945.611631651065;12973.221606703628;13321.733565328444;9296.674616388394;10856.565737370416;11098.834622364535;11589.594364197214;11630.185886987829;8606.956965215133;10939.50772215268;11070.280431772231;11158.163137764537;11623.709407264885;11419.001674706727;11530.76938461243;11793.587224447447;11894.345810980132;11909.404529773303;8170.673173073011;8208.343332533264;8221.630026648934;8351.665933362598;8357.080721120794;8244.422890397855;10748.408837514013;11108.333499990027;11248.862716083919;11408.315501069963 05:13:55 INFO - PROCESS | 1959 | |3;mootools.html;1547.3578464937052;1565.4442672851137;1789.3737191982807;1896.4689886831693;1969.615924894646;8826.691065812698;9396.953015234914;9420.90579094208;9424.90575094249;9426.481543515112;8330.66677332906;8564.272036876857;8871.068537803534;9069.591868365922;9176.678816241432;2091.759447663523;2435.5737745894485;2464.544059349017;2465.543874383236;2469.814763892706;2441.7192022917325;2450.375154335642;2482.2429159106464;2485.6644353012384;2487.129504673368;2452.154006867637;2463.1009681466226;2475.059477398586;2475.282168171228;2477.467344520928;2122.3632910127053;2410.20463247128;2436.3421876093535;2441.4506735984437;2461.6676748638884;2442.7801497865275;2447.6206188040883;2448.4001419652122;2453.6319552067334;2458.6434966929696;8336.374771892133;9094.863577046284;9147.359684822066;9362.90637093627;9372.015938326515;5494.313210848644;5655.802046928337;5671.602987790856;5671.631343962629;5677.40387259336;3574.608702534784;3689.2252626948375;3792.810359482015;3793.791341476218;3804.6005169457085;1082.5128692088513;1102.200904344352;1107.3023994883254;1130.1862658885589;1131.134681968295;12395.194312369757;12465.252084874846;12483.625491235187;12490.000799935984;12501.24992500453;4789.425268967677;4855.344528488679;4863.781129849165;4941.802327906916;4978.303037574742;10424.843627345595;10436.686899393031;10451.059404653617;10464.476776161162;10465.9476702616;5539.030669632798;5541.639793413496;5542.11326187808;5546.528545073633;5571.749271282802;3821.2548553031893;4722.740249286254;4942.5304596063315;5043.571296439771;5060.746962651852;3392.270661807723;4063.817128229237;4146.398772178018;4174.123434078878;4183.518895327015;1148.4085695866636;1319.4392383237087;1319.5975227555496;1334.5462542735515;1348.6358683155493;921.8110287391203;925.3990596268493;932.8927173375013;943.5848226780195;979.2117345536769;5726.79956201531;5791.710414479344;6052.303985041688;6086.208792856989;6202.34875338092;418.9371594260885;435.56443556443554;446.92178868697846;449.8133274691032;457.2113104894031;3894.3184942634925;3908.9218215636097;3942;3984.183242435294;4054.918901621951;10745.677629671123;11271.436428178558;11283.66149015531;11297.265677731086;11310.434478276218;11199.048080913051;11208.991190792867;11209;11222.382768947786;11231.606893758679;8031.718889838828;8314.085450600429;8421.19998600132;8461.40770146084;8563.914360856312;5745.454181852718;5805.3614102447855;5886.58793884424;6058.394160583906;6068.757249710139;10372.844407333745;10394.376337419779;10424;10612.097971672494;10620.52207650642;10120.392776433437;10826.621068262573;10847;10855.728606784893;10864.837027444437;7208;7414.8887766682465;7800;7861.960690196513;8007.519548827089;8725.083866193958;8806.60370283326;8935.463872167691;8955.41789783662;8956.507392093237;7755;7886.44794864354;7906.723264685708;7911.802204944923;8015.679372825021;6738.6967586459705;7751.689932402641;7757.495762775401;7769.067711874612;7801.804954876174;7110;7234.059572255573;7239.457040721862;7240.565566066053;7257.745978890925;4621.399218101626;4877.731724755031;4912.533309335608;5043.193089105725;5202.063628546898;4188.7905604719035;4970.378702662168;5088.262201980618;5134.10153223177;5166 05:13:55 INFO - PROCESS | 1959 | |4;prototype.html;305.93269480714235;312.5546096812043;320.63607805141163;320.93420848726015;326.92441866260003;4856.247281671338;5182.067227898977;5473.726313684319;5508.669479831213;5518.1998610201545;4694.225452800284;4737.981334013187;4935.358403407561;5114.156164232897;5399.892002159954;4040.0505881117915;4215.515215750197;4215.59951804578;4231.915361692764;4268.701190916637;4113.239050775601;4242.809073591696;4254.404598275647;4259.318509038554;4288.898439764508;3880.72834901557;4029.194161167778;4112.527059388164;4151.58484151584;4193.790310484479;4120.484939382577;4155.563665815092;4166.791660416998;4179.3939878717565;4197.937030944508;3335.8832440864453;3376.8818091366684;3667.651573100551;3670.4310831821113;3671.5777685566236;5239.397469291004;5299.920501192485;5349.518543331119;5372.973135134338;5412.269343638598;3775.377062784637;4818.301346304801;4858.368412106403;4883.5604795568215;4973.353464049686;5574.414686457944;5747.166660834156;5796.652200867919;5826.766929322822;5853.32686741026;3652.8356223969986;3687.8893633191046;3900.726949113563;3932.58707835676;3956.643902048829;4709.905801883943;5154.974225128888;5171.7672704728;5538.280023596906;6046.551146785559;3891.9416208756893;3893;3897.668698160688;3904.590018048064;3909.338531124261;3844.0774214188955;3864.787436691009;4044.2518134145275;4044.2518134145275;4048.2510735514024;4686.859394218179;4703.45910220329;4714.764261786897;4718.834840780625;4771.355866957916;4531.614812740954;4551.613112885442;5065.316182315414;5596.8806238751595;5881.32364778056;1169.7660467906453;1364.583801940398;1380.475419340644;1386.8058471813954;1393.4217299820461;739.8372358081214;801.410962942237;836.2640876029055;841.6911702302978;857.3398483167925;3971.3447281198855;4463.933041004388;4571.9085618287445;4588.040713739686;4589.403377560896;4003.479547658844;4340.023494713727;4915.281329923314;5047.646664733434;5085.8728531787;4357.346398040256;4536.818527258873;4570.794314255866;4572.702774319659;4601.907961840811;2156.654935210359;2304.896279667419;2380.797632201248;2514.57252267115;2636.299586766563;4340.502526628308;5168.916555920856;5176.818811341585;5220.686758794409;5301.628885978022;3987.4816273884207;4388.385626012361;4450.933236001462;4721.905561888743;5063.746632748465;4120.848938826467;4588.174128656874;4907.779149938261;5173.456787037307;5201.011807756514;4203.07532342884;4995.377426850787;4996.250562415521;5014.7994080236385;5047.678068088573;4237.91524169521;4414.955850441583;4424.623906967944;4908.558229759339;4985.750712464434;4863.756812159449;5146.974265128651;5186.429492755869;5944.464998150187;6132.78535251264;3359.765755772384;3676.1544844685336;3712.702983761347;3985.5815139409942;3993.3610622300293;5985.610935289193;6039.577229593886;6040;6043.214382130295;6059.212762129469;5169.431362550041;5400.352892367866;5648.587853036741;5739.71301434935;5766.826995189983;4502;5457.536109430743;5749.626274292157;5812.447817457335;5833.67914764692;4953.702777833341;5085.618578606545;5085.821996230115;5376.919346209888;5687.9431205687415;5146.382434107931;5534.972325138509;5803.535717142534;5819.214406055297;5838.854028649318;5686.346070201815;5729.939961107209;5731.713414329351;5754.19441278213;5759.2512973313205 05:13:55 INFO - PROCESS | 1959 | |5;yui.html;708.8015355700405;763.6258233465602;809.4617079642038;828.9295409890159;851.9318454523639;16072.196390180488;17266;17275;17296.135193240352;17344.56638584036;16848.74726879098;17333.7399939001;17556.209970551325;17591.73612395815;17658.82341176588;742.5730205132044;899.3389858454032;920.3143657974819;920.8434566123775;924.3021518753366;752.3304259209308;901.5717534171249;923.201430762389;931.417863835103;935.3078721745927;977.8924318325014;983.8327484327646;985.2069084387066;985.4579981010452;987.6395115782759;975.6341371985505;978.0757184460688;979.6277414582413;979.8726165598498;981.0287815063108;655.3151956205777;685.3763075601179;723.6960476599788;726.1213931143322;728.6283995162453;16046.5988350291;16177.948433351912;16213.756793648105;16230;16253.83746162547;14416.92791536046;14806.925965370105;14810.407583696639;14847.554573362708;14887.553373398816;11842;12135.332556709378;12240.510379584806;12287.69280767988;12435.813462798065;3939.980300098481;3967.583403742623;3989.4614227079264;3994.520657521116;4105.97947010266;121359;125156;125446;126136;131353;11143;11264;11509.76980460386;11531.192816502931;11614.883851161549;22706.091756329894;22734.772652273597;22908.9690963907;23024.079036838673;23089.53820923572;7963.601819908981;8182.18178182189;8416.537090460084;8452.535110568977;8553.700620478254;4652.302154676826;4741.122892264942;4776.357032688207;4816.975915120472;4836.443808961944;3492.930141397158;3635.5455568053994;3649.5802982657333;3652.945205821915;3654.561452625702;590.2238556298454;683.3200965039817;691.2948792231996;702.5679207287482;707.9539829911039;606.6087373643975;658.9703463344161;672.9562578432386;684.698732557673;715.1882613234017;9763.658271960447;9880.654177103766;9894.55474503649;10162.593496260066;10194.133498652698;656.0323522803922;668.7602633367522;716.5449939288485;716.9211386747454;724.463896716426;4593.425821772278;4609.95390046102;4760.143174228672;4994.325766021613;5025.271335656309;103354;104975;145955;158598;158955;88499.55750221208;126944;129833.70166298405;139166;141048.29475852556;118598.4070079644;121684;124157;125373.37313313558;126463;9598.760030999281;10317.74205644865;10375.533101010624;10386;10439.217058720778;64302;66413.66793166003;66977;67931;68357;93369.95369285559;98301.52547711648;98328.50835745776;103189;104010.47994759977;11712.355820429959;12687.302198379179;13232.809047185414;13350.532731354357;13840.723185536031;14790.334434950239;14918.925405372904;15064.62338441504;15710.607234819221;16714.58213544671;13049.608511744664;13189.472421103048;13876.437341648623;14045.227512486912;14478.927605361905;13577.52478663242;14809.33357998871;14975.850241497446;15285.388584456497;15468.303926323568;14349.713005740035;14510;14703.970722049355;14815.777763333343;15127.54617361481;10566.413544130462;11465.770684586429;11592.768144637228;12004.87873153004;12314.199577027823;11559.595414160463;11612;11814.113941454598;11865.5847045353;11872 05:13:55 INFO - PROCESS | 1959 | __end_tp_report 05:13:55 INFO - PROCESS | 1959 | __start_cc_report 05:13:55 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,1376 05:13:55 INFO - PROCESS | 1959 | __end_cc_report 05:13:55 INFO - PROCESS | 1959 | __startTimestamp1480252435911__endTimestamp 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | ------- Summary: start ------- 05:13:55 INFO - PROCESS | 1959 | Number of tests: 6 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | [#0] dojo.html Cycles:165 Average:5793.74 Median:6027.61 stddev:645.20 (10.7%) stddev-sans-first:619.71 05:13:55 INFO - PROCESS | 1959 | Values: 3419.4 3436.7 3457.0 3461.2 3505.8 4774.0 5741.5 5799.6 5804.4 5835.2 5750.2 5796.5 5815.2 5823.6 5827.7 5279.1 5294.8 5309.1 5342.9 5358.7 5258.2 5268.2 5268.3 5397.1 5413.1 5286.2 5302.6 5304.1 5315.9 5319.0 5322.3 5331.8 5385.7 5386.6 5390.4 5183.6 5249.7 5302.5 5318.5 5336.4 4694.7 5689.1 5732.8 5740.3 5742.8 6187.6 6241.7 6269.3 6280.8 6298.8 6240.3 6257.9 6293.3 6298.7 6305.3 5713.0 5761.5 5763.5 5817.2 5824.9 6309.4 6349.0 6354.9 6356.7 6365.5 6229.1 6233.4 6239.9 6250.2 6255.3 4846.7 5798.3 5866.4 6251.0 6310.9 6201.3 6296.4 6310.8 6317.7 6319.5 6160.8 6281.8 6295.7 6301.7 6321.4 4937.1 4993.6 5013.8 5063.4 5066.2 4485.8 4511.3 4526.0 4538.8 4619.0 5967.3 5979.3 5992.6 6023.2 6027.6 6295.3 6298.1 6307.8 6312.1 6324.6 5747.2 5848.4 5881.2 5921.7 5938.9 4879.0 5383.4 5501.5 5504.2 5507.4 6444.4 6451.6 6456.6 6470.0 6496.4 5212.5 6121.7 6246.9 6247.6 6308.7 6339.3 6422.9 6434.9 6440.7 6446.9 6217.0 6278.4 6301.2 6309.3 6313.5 6206.3 6264.7 6307.7 6334.8 6359.9 5335.0 5967.0 6105.5 6114.3 6218.6 6082.3 6164.6 6182.3 6188.5 6202.7 5911.0 6015.3 6084.4 6090.3 6113.7 6068.4 6108.0 6112.9 6127.7 6220.1 6094.4 6102.2 6122.4 6123.8 6131.6 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | [#1] ext.html Cycles:180 Average:75413.64 Median:3744.19 stddev:172367.51 (4603.6%) stddev-sans-first:172759.19 05:13:55 INFO - PROCESS | 1959 | Values: 466.2 479.9 529.1 534.0 558.2 31909.4 35522.3 42150.4 43262.0 43552.6 44285.8 44773.6 44798.3 44887.1 44941.8 7595.0 7605.9 7708.9 7825.8 7895.9 9348.6 9561.8 12180.8 12459.2 12493.9 12410.2 12499.3 12504.9 12512.1 12515.3 12400.1 12480.5 12483.0 12493.4 12504.1 12305.3 12349.9 12353.6 12379.4 12390.6 42216.4 42519.8 42564.8 42617.8 42682.0 3710.9 3737.2 3751.2 4085.8 4263.9 25655.9 28167.7 31169.2 32658.3 32715.7 3297.2 3404.7 3454.5 3503.8 3543.7 510627.0 516069.0 516130.0 516625.0 516817.0 51286.7 61676.4 61818.7 61976.4 62174.0 36304.5 36824.3 37017.3 38149.2 38182.4 17830.0 17963.0 18013.7 18019.5 18061.8 12552.9 12803.9 13649.0 13758.2 13761.4 17657.7 17689.9 17746.3 19466.6 20010.8 6793.5 7830.7 7931.4 8072.5 8199.5 762.5 863.4 933.5 943.8 1084.9 24454.4 25379.0 26837.0 31448.2 31732.0 912.7 1067.7 1075.3 1123.2 1154.6 15678.5 15938.8 16017.9 16025.8 16355.8 727425.0 734571.0 735591.0 736391.0 737224.0 60217.7 60812.4 60935.1 60986.4 61029.7 1247.6 1274.1 1307.0 1387.7 1428.0 30017.8 30992.1 31815.7 31877.0 32364.8 50177.7 50725.5 50730.7 50754.7 50967.0 585103.0 588822.0 588862.0 590659.0 883553.0 24017.8 24395.8 24406.0 24423.9 26722.2 40435.4 47695.0 49134.3 49230.5 49735.5 38729.6 40230.6 40775.6 41397.0 41409.8 36075.9 40462.9 40522.8 40594.6 41971.6 38663.6 39183.4 39531.6 39894.6 40032.8 33616.7 35099.5 35226.6 35481.4 35560.1 24184.5 24258.8 25924.4 26417.3 26855.9 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | [#2] jquery.html Cycles:180 Average:36137.64 Median:19840.27 stddev:104791.30 (528.2%) stddev-sans-first:105050.88 05:13:55 INFO - PROCESS | 1959 | Values: 383.5 392.1 394.5 400.5 417.2 15678.5 20493.8 21416.3 22218.0 22250.7 16713.6 19567.3 21186.4 21411.8 21515.0 5832.1 6158.7 6162.2 6167.1 6173.6 5000.5 6047.7 6068.9 6099.6 6126.9 6164.5 6179.5 6181.4 6181.9 6194.7 5933.6 6112.0 6201.0 6205.0 6207.0 5091.4 5137.3 5960.3 5988.6 5998.6 24168.0 24964.0 25200.5 25485.0 25532.9 2154.4 2167.3 2234.7 2486.5 2723.4 8991.3 9377.5 9388.2 9725.8 10250.3 1841.2 1873.1 1895.9 1906.3 1942.2 124265.0 124836.0 131161.0 139995.0 140223.9 9900.7 10967.0 11184.8 11263.3 11618.2 14944.2 14958.0 14962.2 14969.4 14980.9 7811.5 8168.6 8186.7 8476.4 8512.6 8789.9 8890.2 8932.8 8961.2 9017.0 3927.5 4137.7 4561.7 4604.1 4608.7 1797.7 1825.0 1826.0 1910.3 1940.4 841.9 903.0 918.8 971.6 989.9 18171.2 18473.2 20600.5 21213.3 22151.7 914.7 936.4 972.0 982.6 1013.6 9174.3 10693.4 11378.4 11383.5 11469.0 591000.0 625087.0 629259.0 639649.0 649644.0 105337.5 106027.0 135518.0 136859.0 143523.0 947.2 958.4 974.0 974.8 975.3 15496.8 18475.0 18847.1 18945.5 19118.9 39286.0 50701.7 51318.4 56629.3 57524.8 77207.6 82263.0 82392.0 82487.0 83344.0 5830.0 7977.9 8308.4 8396.8 8423.2 12871.4 12880.3 12945.6 12973.2 13321.7 9296.7 10856.6 11098.8 11589.6 11630.2 8607.0 10939.5 11070.3 11158.2 11623.7 11419.0 11530.8 11793.6 11894.3 11909.4 8170.7 8208.3 8221.6 8351.7 8357.1 8244.4 10748.4 11108.3 11248.9 11408.3 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | [#3] mootools.html Cycles:180 Average:5919.79 Median:453.51 stddev:3402.62 (750.3%) stddev-sans-first:3396.30 05:13:55 INFO - PROCESS | 1959 | Values: 1547.4 1565.4 1789.4 1896.5 1969.6 8826.7 9397.0 9420.9 9424.9 9426.5 8330.7 8564.3 8871.1 9069.6 9176.7 2091.8 2435.6 2464.5 2465.5 2469.8 2441.7 2450.4 2482.2 2485.7 2487.1 2452.2 2463.1 2475.1 2475.3 2477.5 2122.4 2410.2 2436.3 2441.5 2461.7 2442.8 2447.6 2448.4 2453.6 2458.6 8336.4 9094.9 9147.4 9362.9 9372.0 5494.3 5655.8 5671.6 5671.6 5677.4 3574.6 3689.2 3792.8 3793.8 3804.6 1082.5 1102.2 1107.3 1130.2 1131.1 12395.2 12465.3 12483.6 12490.0 12501.2 4789.4 4855.3 4863.8 4941.8 4978.3 10424.8 10436.7 10451.1 10464.5 10465.9 5539.0 5541.6 5542.1 5546.5 5571.7 3821.3 4722.7 4942.5 5043.6 5060.7 3392.3 4063.8 4146.4 4174.1 4183.5 1148.4 1319.4 1319.6 1334.5 1348.6 921.8 925.4 932.9 943.6 979.2 5726.8 5791.7 6052.3 6086.2 6202.3 418.9 435.6 446.9 449.8 457.2 3894.3 3908.9 3942.0 3984.2 4054.9 10745.7 11271.4 11283.7 11297.3 11310.4 11199.0 11209.0 11209.0 11222.4 11231.6 8031.7 8314.1 8421.2 8461.4 8563.9 5745.5 5805.4 5886.6 6058.4 6068.8 10372.8 10394.4 10424.0 10612.1 10620.5 10120.4 10826.6 10847.0 10855.7 10864.8 7208.0 7414.9 7800.0 7862.0 8007.5 8725.1 8806.6 8935.5 8955.4 8956.5 7755.0 7886.4 7906.7 7911.8 8015.7 6738.7 7751.7 7757.5 7769.1 7801.8 7110.0 7234.1 7239.5 7240.6 7257.7 4621.4 4877.7 4912.5 5043.2 5202.1 4188.8 4970.4 5088.3 5134.1 5166.0 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | [#4] prototype.html Cycles:180 Average:4396.74 Median:4716.80 stddev:1338.98 (28.4%) stddev-sans-first:1307.06 05:13:55 INFO - PROCESS | 1959 | Values: 305.9 312.6 320.6 320.9 326.9 4856.2 5182.1 5473.7 5508.7 5518.2 4694.2 4738.0 4935.4 5114.2 5399.9 4040.1 4215.5 4215.6 4231.9 4268.7 4113.2 4242.8 4254.4 4259.3 4288.9 3880.7 4029.2 4112.5 4151.6 4193.8 4120.5 4155.6 4166.8 4179.4 4197.9 3335.9 3376.9 3667.7 3670.4 3671.6 5239.4 5299.9 5349.5 5373.0 5412.3 3775.4 4818.3 4858.4 4883.6 4973.4 5574.4 5747.2 5796.7 5826.8 5853.3 3652.8 3687.9 3900.7 3932.6 3956.6 4709.9 5155.0 5171.8 5538.3 6046.6 3891.9 3893.0 3897.7 3904.6 3909.3 3844.1 3864.8 4044.3 4044.3 4048.3 4686.9 4703.5 4714.8 4718.8 4771.4 4531.6 4551.6 5065.3 5596.9 5881.3 1169.8 1364.6 1380.5 1386.8 1393.4 739.8 801.4 836.3 841.7 857.3 3971.3 4463.9 4571.9 4588.0 4589.4 4003.5 4340.0 4915.3 5047.6 5085.9 4357.3 4536.8 4570.8 4572.7 4601.9 2156.7 2304.9 2380.8 2514.6 2636.3 4340.5 5168.9 5176.8 5220.7 5301.6 3987.5 4388.4 4450.9 4721.9 5063.7 4120.8 4588.2 4907.8 5173.5 5201.0 4203.1 4995.4 4996.3 5014.8 5047.7 4237.9 4415.0 4424.6 4908.6 4985.8 4863.8 5147.0 5186.4 5944.5 6132.8 3359.8 3676.2 3712.7 3985.6 3993.4 5985.6 6039.6 6040.0 6043.2 6059.2 5169.4 5400.4 5648.6 5739.7 5766.8 4502.0 5457.5 5749.6 5812.4 5833.7 4953.7 5085.6 5085.8 5376.9 5687.9 5146.4 5535.0 5803.5 5819.2 5838.9 5686.3 5729.9 5731.7 5754.2 5759.3 05:13:55 INFO - PROCESS | 1959 | 05:13:55 INFO - PROCESS | 1959 | [#5] yui.html Cycles:180 Average:25963.36 Median:17625.28 stddev:40730.63 (231.1%) stddev-sans-first:40800.75 05:13:55 INFO - PROCESS | 1959 | Values: 708.8 763.6 809.5 828.9 851.9 16072.2 17266.0 17275.0 17296.1 17344.6 16848.7 17333.7 17556.2 17591.7 17658.8 742.6 899.3 920.3 920.8 924.3 752.3 901.6 923.2 931.4 935.3 977.9 983.8 985.2 985.5 987.6 975.6 978.1 979.6 979.9 981.0 655.3 685.4 723.7 726.1 728.6 16046.6 16177.9 16213.8 16230.0 16253.8 14416.9 14806.9 14810.4 14847.6 14887.6 11842.0 12135.3 12240.5 12287.7 12435.8 3940.0 3967.6 3989.5 3994.5 4106.0 121359.0 125156.0 125446.0 126136.0 131353.0 11143.0 11264.0 11509.8 11531.2 11614.9 22706.1 22734.8 22909.0 23024.1 23089.5 7963.6 8182.2 8416.5 8452.5 8553.7 4652.3 4741.1 4776.4 4817.0 4836.4 3492.9 3635.5 3649.6 3652.9 3654.6 590.2 683.3 691.3 702.6 708.0 606.6 659.0 673.0 684.7 715.2 9763.7 9880.7 9894.6 10162.6 10194.1 656.0 668.8 716.5 716.9 724.5 4593.4 4610.0 4760.1 4994.3 5025.3 103354.0 104975.0 145955.0 158598.0 158955.0 88499.6 126944.0 129833.7 139166.0 141048.3 118598.4 121684.0 124157.0 125373.4 126463.0 9598.8 10317.7 10375.5 10386.0 10439.2 64302.0 66413.7 66977.0 67931.0 68357.0 93370.0 98301.5 98328.5 103189.0 104010.5 11712.4 12687.3 13232.8 13350.5 13840.7 14790.3 14918.9 15064.6 15710.6 16714.6 13049.6 13189.5 13876.4 14045.2 14478.9 13577.5 14809.3 14975.9 15285.4 15468.3 14349.7 14510.0 14704.0 14815.8 15127.5 10566.4 11465.8 11592.8 12004.9 12314.2 11559.6 11612.0 11814.1 11865.6 11872.0 05:13:55 INFO - PROCESS | 1959 | -------- Summary: end -------- 05:13:55 INFO - PROCESS | 1959 | 05:13:56 INFO - TEST-INFO | 1959: exit 0 05:13:56 INFO - TEST-OK | dromaeo_css | took 1114551ms 05:13:56 INFO - TEST-START | kraken 05:13:56 INFO - operating with platform_type : mac_ 05:13:56 INFO - Initialising browser for kraken test... 05:13:56 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmp8P74Ok/profile http://localhost:56112/getInfo.html) 05:13:58 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 05:13:58 INFO - PROCESS | 1962 | colorDepth:24 05:13:58 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 05:13:58 INFO - PROCESS | 1962 | __metrics 05:13:58 INFO - PROCESS | 1962 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:13:58 INFO - PROCESS | 1962 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:59 INFO - TEST-INFO | 1962: exit 0 05:13:59 INFO - Browser initialized. 05:13:59 INFO - Running cycle 1/1 for kraken test... 05:13:59 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmp8P74Ok/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:11 INFO - PROCESS | 1964 | RSS: Main: 168595456 05:14:11 INFO - PROCESS | 1964 | 05:14:13 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56112/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:14 INFO - PROCESS | 1964 | RSS: Main: 218537984 05:14:14 INFO - PROCESS | 1964 | 05:14:17 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56112/tests/kraken/driver.html?testName=audio-dft) 05:14:17 INFO - PROCESS | 1964 | RSS: Main: 229310464 05:14:17 INFO - PROCESS | 1964 | 05:14:21 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56112/tests/kraken/driver.html?testName=audio-fft) 05:14:21 INFO - PROCESS | 1964 | RSS: Main: 325349376 05:14:21 INFO - PROCESS | 1964 | 05:14:23 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56112/tests/kraken/driver.html?testName=audio-oscillator) 05:14:24 INFO - PROCESS | 1964 | RSS: Main: 227946496 05:14:24 INFO - PROCESS | 1964 | 05:14:26 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56112/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:26 INFO - PROCESS | 1964 | RSS: Main: 229863424 05:14:26 INFO - PROCESS | 1964 | 05:14:29 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56112/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:30 INFO - PROCESS | 1964 | RSS: Main: 267489280 05:14:30 INFO - PROCESS | 1964 | 05:14:33 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56112/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:33 INFO - PROCESS | 1964 | RSS: Main: 266641408 05:14:33 INFO - PROCESS | 1964 | 05:14:36 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56112/tests/kraken/driver.html?testName=json-parse-financial) 05:14:36 INFO - PROCESS | 1964 | RSS: Main: 266756096 05:14:36 INFO - PROCESS | 1964 | 05:14:38 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56112/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:39 INFO - PROCESS | 1964 | RSS: Main: 240779264 05:14:39 INFO - PROCESS | 1964 | 05:14:40 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:41 INFO - PROCESS | 1964 | RSS: Main: 244465664 05:14:41 INFO - PROCESS | 1964 | 05:14:43 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:44 INFO - PROCESS | 1964 | RSS: Main: 251904000 05:14:44 INFO - PROCESS | 1964 | 05:14:47 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:47 INFO - PROCESS | 1964 | RSS: Main: 266489856 05:14:47 INFO - PROCESS | 1964 | 05:14:50 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:51 INFO - PROCESS | 1964 | RSS: Main: 259878912 05:14:51 INFO - PROCESS | 1964 | 05:14:52 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56112/tests/kraken/driver.html?testName=ai-astar) 05:14:53 INFO - PROCESS | 1964 | RSS: Main: 303771648 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | __start_tp_report 05:14:53 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 05:14:53 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 05:14:53 INFO - PROCESS | 1964 | |i|pagename|runs| 05:14:53 INFO - PROCESS | 1964 | |0;ai-astar;114;113;114;113;114;115;112;113;114;113 05:14:53 INFO - PROCESS | 1964 | |1;audio-beat-detection;146;127;135;137;105;106;107;106;136;106 05:14:53 INFO - PROCESS | 1964 | |2;audio-dft;184;191;184;184;181;182;181;182;182;183 05:14:53 INFO - PROCESS | 1964 | |3;audio-fft;81;58;59;89;61;58;58;60;103;81 05:14:53 INFO - PROCESS | 1964 | |4;audio-oscillator;87;70;93;70;67;67;91;69;67;89 05:14:53 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;86;83;87;83;86;89;134;127;86;83 05:14:53 INFO - PROCESS | 1964 | |6;imaging-darkroom;96;94;96;95;93;95;94;93;95;94 05:14:53 INFO - PROCESS | 1964 | |7;imaging-desaturate;85;85;84;86;84;86;83;85;84;84 05:14:53 INFO - PROCESS | 1964 | |8;json-parse-financial;55;50;53;52;55;54;55;55;56;54 05:14:53 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;64;74;63;75;70;67;68;69;68;70 05:14:53 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;92;89;99;80;82;78;83;84;83;88 05:14:53 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;132;140;147;143;150;137;139;139;192;121 05:14:53 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;159;161;162;161;161;160;159;158;158;160 05:14:53 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;65;64;67;66;66;67;64;64;64;68 05:14:53 INFO - PROCESS | 1964 | __end_tp_report 05:14:53 INFO - PROCESS | 1964 | __start_cc_report 05:14:53 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,1833 05:14:53 INFO - PROCESS | 1964 | __end_cc_report 05:14:53 INFO - PROCESS | 1964 | __startTimestamp1480252493174__endTimestamp 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | ------- Summary: start ------- 05:14:53 INFO - PROCESS | 1964 | Number of tests: 14 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 05:14:53 INFO - PROCESS | 1964 | Values: 114.0 113.0 114.0 113.0 114.0 115.0 112.0 113.0 114.0 113.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:131.00 stddev:16.55 (12.6%) stddev-sans-first:14.90 05:14:53 INFO - PROCESS | 1964 | Values: 146.0 127.0 135.0 137.0 105.0 106.0 107.0 106.0 136.0 106.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:2.91 (1.6%) stddev-sans-first:3.08 05:14:53 INFO - PROCESS | 1964 | Values: 184.0 191.0 184.0 184.0 181.0 182.0 181.0 182.0 182.0 183.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:70.80 Median:60.50 stddev:16.40 (27.1%) stddev-sans-first:16.97 05:14:53 INFO - PROCESS | 1964 | Values: 81.0 58.0 59.0 89.0 61.0 58.0 58.0 60.0 103.0 81.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.50 stddev:11.34 (14.4%) stddev-sans-first:11.44 05:14:53 INFO - PROCESS | 1964 | Values: 87.0 70.0 93.0 70.0 67.0 67.0 91.0 69.0 67.0 89.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:94.40 Median:86.00 stddev:19.20 (22.3%) stddev-sans-first:20.12 05:14:53 INFO - PROCESS | 1964 | Values: 86.0 83.0 87.0 83.0 86.0 89.0 134.0 127.0 86.0 83.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:1.08 (1.1%) stddev-sans-first:1.00 05:14:53 INFO - PROCESS | 1964 | Values: 96.0 94.0 96.0 95.0 93.0 95.0 94.0 93.0 95.0 94.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 05:14:53 INFO - PROCESS | 1964 | Values: 85.0 85.0 84.0 86.0 84.0 86.0 83.0 85.0 84.0 84.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:55.00 stddev:1.79 (3.3%) stddev-sans-first:1.86 05:14:53 INFO - PROCESS | 1964 | Values: 55.0 50.0 53.0 52.0 55.0 54.0 55.0 55.0 56.0 54.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.50 stddev:3.79 (5.5%) stddev-sans-first:3.61 05:14:53 INFO - PROCESS | 1964 | Values: 64.0 74.0 63.0 75.0 70.0 67.0 68.0 69.0 68.0 70.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:6.29 (7.3%) stddev-sans-first:6.25 05:14:53 INFO - PROCESS | 1964 | Values: 92.0 89.0 99.0 80.0 82.0 78.0 83.0 84.0 83.0 88.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:141.50 stddev:18.67 (13.2%) stddev-sans-first:19.29 05:14:53 INFO - PROCESS | 1964 | Values: 132.0 140.0 147.0 143.0 150.0 137.0 139.0 139.0 192.0 121.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.50 stddev:1.37 (0.9%) stddev-sans-first:1.41 05:14:53 INFO - PROCESS | 1964 | Values: 159.0 161.0 162.0 161.0 161.0 160.0 159.0 158.0 158.0 160.0 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 05:14:53 INFO - PROCESS | 1964 | Values: 65.0 64.0 67.0 66.0 66.0 67.0 64.0 64.0 64.0 68.0 05:14:53 INFO - PROCESS | 1964 | -------- Summary: end -------- 05:14:53 INFO - PROCESS | 1964 | 05:14:53 INFO - TEST-INFO | 1964: exit 0 05:14:53 INFO - TEST-OK | kraken | took 57468ms 05:14:53 INFO - SUITE-END | took 1172s 05:14:54 INFO - Completed test suite (00:19:32) 05:14:54 INFO - javascript benchmark 05:14:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.4016047191735, 3436.6906978371944, 3457.032031031309, 3461.1866211440324, 3505.754597178197, 4773.976130119348, 5741.511971482424, 5799.56503262256, 5804.419558044194, 5835.183074369592, 5750.166225897253, 5796.478316951474, 5815.156802263669, 5823.592348535604, 5827.679477628729, 5279.102552566053, 5294.7617357219015, 5309.0709125903, 5342.893142137155, 5358.732063396834, 5258.237555554442, 5268.236105764662, 5268.288781014571, 5397.055515284829, 5413.079776438015, 5286.180642000496, 5302.628815982883, 5304.071787437202, 5315.946840531584, 5318.973405132988, 5322.2814919985885, 5331.813386531472, 5385.7307134643115, 5386.569074474072, 5390.353157621072, 5183.585313174937, 5249.658772179796, 5302.522772950414, 5318.521333080042, 5336.439673834269, 4694.671373003857, 5689.146628005791, 5732.770689172428, 5740.253767010304, 5742.770289188427, 6187.628742275433, 6241.662044878811, 6269.279032911228, 6280.842978925518, 6298.842528936768, 6240.344763799781, 6257.8748425031245, 6293.307736149066, 6298.6535740534255, 6305.3379395163765, 5713.0287851065, 5761.539076873882, 5763.510101641324, 5817.185594016841, 5824.88350232993, 6309.3690630936535, 6348.984162533972, 6354.91966365719, 6356.745730170742, 6365.52258580599, 6229.0967809667345, 6233.407826256498, 6239.937600624026, 6250.218722659668, 6255.343188965184, 4846.660733748604, 5798.275215598051, 5866.384029676908, 6250.968745156245, 6310.873782524323, 6201.317855035943, 6296.401841825111, 6310.7791227306825, 6317.747290108436, 6319.494440444753, 6160.815175544741, 6281.780137695158, 6295.748170073146, 6301.747930082837, 6321.399467050623, 4937.086638971802, 4993.550580447704, 5013.824516141917, 5063.417706963673, 5066.214736715815, 4485.753283569435, 4511.300748384006, 4525.954740452619, 4538.795754191069, 4618.960733834861, 5967.283925928917, 5979.342272350038, 5992.550558708114, 6023.216981792339, 6027.60820546663, 6295.276043255084, 6298.118263443122, 6307.779227727007, 6312.053192021233, 6324.588901721373, 5747.224124743189, 5848.385919478478, 5881.206037185011, 5921.73352199152, 5938.881222375615, 4879.0, 5383.353997520323, 5501.532369748536, 5504.201890725903, 5507.366652834975, 6444.420002199825, 6451.580647258007, 6456.612603243821, 6470.0, 6496.382843629847, 5212.452692467388, 6121.696863452088, 6246.937530624636, 6247.625142491465, 6308.653024083719, 6339.302676705466, 6422.871542569216, 6434.935650643433, 6440.67796610177, 6446.871062578628, 6217.0052791553135, 6278.4035516625845, 6301.243850737941, 6309.2744334400295, 6313.526485513697, 6206.286277078194, 6264.655443950626, 6307.684615769102, 6334.809955701337, 6359.9188138015725, 5334.973325133349, 5967.0, 6105.511559075175, 6114.327423983269, 6218.5647004709235, 6082.330943596289, 6164.561256460958, 6182.319944805978, 6188.535859810622, 6202.689865506616, 5910.970445147746, 6015.338312785502, 6084.3915608440575, 6090.330063693079, 6113.663748493876, 6068.423499767515, 6108.0, 6112.868254062901, 6127.662978536223, 6220.066989951362, 6094.39056094387, 6102.228778756885, 6122.39815511198, 6123.8162855114415, 6131.63210207389], "value": 5754.596076592089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.1934852704821, 479.8536446383854, 529.1190168369665, 533.9614449894956, 558.1739026241161, 31909.36181276376, 35522.28955420893, 42150.36774448382, 43262.0, 43552.56447435525, 44285.7785711071, 44773.552264477345, 44798.328025079565, 44887.10225795482, 44941.7752911235, 7595.0, 7605.923940760577, 7708.922910770904, 7825.765227043198, 7895.921040789576, 9348.626054957793, 9561.760955976086, 12180.756384872297, 12459.190152640094, 12493.937530312336, 12410.193337433038, 12499.312537810416, 12504.937475312656, 12512.061595380337, 12515.311657858814, 12400.069994750429, 12480.50077996879, 12483.0, 12493.437795299233, 12504.124711270215, 12305.323207223688, 12349.876501234963, 12353.567625133077, 12379.442925068393, 12390.62828115158, 42216.366754498704, 42519.787401063106, 42564.78717606423, 42617.78691106556, 42682.0, 3710.9072273193115, 3737.177820879402, 3751.1934933989323, 4085.836566537335, 4263.914721705549, 25655.871720641466, 28167.73245203971, 31169.22076948072, 32658.346833063442, 32715.6728432715, 3297.225152089257, 3404.676555727202, 3454.481827725836, 3503.7897726136257, 3543.663351981583, 510627.0, 516069.0, 516130.0, 516625.0, 516817.0, 51286.743566281926, 61676.383236167065, 61818.69090654608, 61976.38023619706, 62174.0, 36304.45543316852, 36824.26351473009, 37017.25965480675, 38149.23701525954, 38182.42726359107, 17830.0, 17963.012034337975, 18013.7297940531, 18019.459416217534, 18061.825981311173, 12552.87447125517, 12803.935980320224, 13648.976326775532, 13758.174509529461, 13761.38073786682, 17657.735133973, 17689.93860368382, 17746.29014839392, 19466.61630368878, 20010.799892001185, 6793.490488213404, 7830.686772529149, 7931.365490760841, 8072.466231416012, 8199.549024803693, 762.5005621318046, 863.4301361101643, 933.5239028095584, 943.7687766497252, 1084.8915108489246, 24454.388640284134, 25379.0, 26837.0, 31448.213794655316, 31732.0, 912.748994026648, 1067.6903697927514, 1075.2526993739275, 1123.1576317761678, 1154.5785788187252, 15678.451254206047, 15938.760918586231, 16017.919910400373, 16025.839741602667, 16355.83644163543, 727425.0, 734571.0, 735591.0, 736391.0, 737224.0, 60217.69891150516, 60812.39187608067, 60935.08597371043, 60986.39013609896, 61029.694851525455, 1247.5820600098887, 1274.1335891593806, 1307.0458565247422, 1387.6669599295894, 1428.0432110486, 30017.849910750305, 30992.070237891996, 31815.6818431822, 31877.043688689377, 32364.83817580897, 50177.745556361384, 50725.49274507208, 50730.73173170553, 50754.74622626863, 50967.0, 585103.0, 588822.0, 588862.0, 590659.0, 883553.0, 24017.759822401553, 24395.780210989735, 24406.02375904944, 24423.877880610482, 26722.19833405001, 40435.39346909858, 47695.04609907852, 49134.262986055954, 49230.50769492259, 49735.502644974535, 38729.6127038726, 40230.59192928234, 40775.59224407718, 41397.0, 41409.79295103505, 36075.917722468366, 40462.895848433865, 40522.797386012884, 40594.59405405908, 41971.58028419677, 38663.61336386712, 39183.41224881572, 39531.60468395279, 39894.60105398909, 40032.79983600063, 33616.663833362334, 35099.473507897914, 35226.647733523365, 35481.406392785146, 35560.110997225274, 24184.51630967406, 24258.757437195556, 25924.35189120287, 26417.33956651099, 26855.86572067127], "value": 20553.848724944753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.51485371005685, 392.1275162762853, 394.5324790123705, 400.4633790720435, 417.1739954889319, 15678.529644110695, 20493.795062049394, 21416.25043123491, 22218.0, 22250.666240006412, 16713.582160445963, 19567.315143969965, 21186.364409067715, 21411.785882141176, 21515.0, 5832.066869300913, 6158.692065396713, 6162.22972128484, 6167.0749387591995, 6173.59871608344, 5000.549950504454, 6047.727852246638, 6068.908966365508, 6099.634021958675, 6126.877462450749, 6164.506839452855, 6179.536534759911, 6181.350958149397, 6181.90727139091, 6194.659293738842, 5933.5549833762425, 6111.969440152815, 6201.007838745779, 6204.9689751551405, 6207.006878899377, 5091.414487333967, 5137.332146820927, 5960.254968128984, 5988.550858685616, 5998.640081595118, 24168.0, 24964.00143994238, 25200.49599008028, 25485.0, 25532.87233563839, 2154.407537927067, 2167.2739632223224, 2234.6871437998693, 2486.5275597636573, 2723.3872378714827, 8991.325650576167, 9377.484238366887, 9388.202002829768, 9725.805483890283, 10250.33372830771, 1841.235887106849, 1873.100911562444, 1895.9336423225259, 1906.323255244396, 1942.223110755695, 124265.0, 124835.9999999991, 131161.0, 139995.0, 140223.89664155047, 9900.653477128266, 10967.0, 11184.832227516594, 11263.26788758728, 11618.186726929203, 14944.178070206026, 14958.0, 14962.17708026069, 14969.401223951138, 14980.925095374454, 7811.49225300365, 8168.550729709923, 8186.713465028695, 8476.406651534457, 8512.616932238065, 8789.912100879037, 8890.244329231959, 8932.821343573092, 8961.23829474489, 9017.0, 3927.509061367329, 4137.668986481134, 4561.657875659339, 4604.1252162089095, 4608.695652173913, 1797.6764182447023, 1824.9746393844384, 1826.032202932448, 1910.3218357483172, 1940.379078694804, 841.9200175983271, 903.0337538833517, 918.8300164469595, 971.562796741455, 989.851522271665, 18171.182296796676, 18473.1687074082, 20600.484987875123, 21213.257535986166, 22151.667724984138, 914.6661468563926, 936.3585943628636, 971.9562619682131, 982.557848967953, 1013.5793645637126, 9174.32101210671, 10693.41186234749, 11378.431078446045, 11383.487743051583, 11469.0, 591000.0, 625087.0, 629259.0, 639649.0, 649644.0, 105337.47331263295, 106027.0, 135518.0, 136859.0, 143523.0, 947.2185447006248, 958.4009993754044, 973.9951300243454, 974.7904200596905, 975.2782940623887, 15496.767548487007, 18474.983875886417, 18847.057647117865, 18945.52636184051, 19118.94845783495, 39286.0, 50701.74649126731, 51318.40771145984, 56629.31909425874, 57524.84950300887, 77207.61396192983, 82263.0, 82392.0, 82487.0, 83344.0, 5829.979753543028, 7977.880331794911, 8308.418410711192, 8396.832063358821, 8423.241908228289, 12871.420786064462, 12880.291583962597, 12945.611631651065, 12973.221606703628, 13321.733565328444, 9296.674616388394, 10856.565737370416, 11098.834622364535, 11589.594364197214, 11630.185886987829, 8606.956965215133, 10939.50772215268, 11070.280431772231, 11158.163137764537, 11623.709407264885, 11419.001674706727, 11530.76938461243, 11793.587224447447, 11894.345810980132, 11909.404529773303, 8170.673173073011, 8208.343332533264, 8221.630026648934, 8351.665933362598, 8357.080721120794, 8244.422890397855, 10748.408837514013, 11108.333499990027, 11248.862716083919, 11408.315501069963], "value": 9602.388128307462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.3578464937052, 1565.4442672851137, 1789.3737191982807, 1896.4689886831693, 1969.615924894646, 8826.691065812698, 9396.953015234914, 9420.90579094208, 9424.90575094249, 9426.481543515112, 8330.66677332906, 8564.272036876857, 8871.068537803534, 9069.591868365922, 9176.678816241432, 2091.759447663523, 2435.5737745894485, 2464.544059349017, 2465.543874383236, 2469.814763892706, 2441.7192022917325, 2450.375154335642, 2482.2429159106464, 2485.6644353012384, 2487.129504673368, 2452.154006867637, 2463.1009681466226, 2475.059477398586, 2475.282168171228, 2477.467344520928, 2122.3632910127053, 2410.20463247128, 2436.3421876093535, 2441.4506735984437, 2461.6676748638884, 2442.7801497865275, 2447.6206188040883, 2448.4001419652122, 2453.6319552067334, 2458.6434966929696, 8336.374771892133, 9094.863577046284, 9147.359684822066, 9362.90637093627, 9372.015938326515, 5494.313210848644, 5655.802046928337, 5671.602987790856, 5671.631343962629, 5677.40387259336, 3574.608702534784, 3689.2252626948375, 3792.810359482015, 3793.791341476218, 3804.6005169457085, 1082.5128692088513, 1102.200904344352, 1107.3023994883254, 1130.1862658885589, 1131.134681968295, 12395.194312369757, 12465.252084874846, 12483.625491235187, 12490.000799935984, 12501.24992500453, 4789.425268967677, 4855.344528488679, 4863.781129849165, 4941.802327906916, 4978.303037574742, 10424.843627345595, 10436.686899393031, 10451.059404653617, 10464.476776161162, 10465.9476702616, 5539.030669632798, 5541.639793413496, 5542.11326187808, 5546.528545073633, 5571.749271282802, 3821.2548553031893, 4722.740249286254, 4942.5304596063315, 5043.571296439771, 5060.746962651852, 3392.270661807723, 4063.817128229237, 4146.398772178018, 4174.123434078878, 4183.518895327015, 1148.4085695866636, 1319.4392383237087, 1319.5975227555496, 1334.5462542735515, 1348.6358683155493, 921.8110287391203, 925.3990596268493, 932.8927173375013, 943.5848226780195, 979.2117345536769, 5726.79956201531, 5791.710414479344, 6052.303985041688, 6086.208792856989, 6202.34875338092, 418.9371594260885, 435.56443556443554, 446.92178868697846, 449.8133274691032, 457.2113104894031, 3894.3184942634925, 3908.9218215636097, 3942.0, 3984.183242435294, 4054.918901621951, 10745.677629671123, 11271.436428178558, 11283.66149015531, 11297.265677731086, 11310.434478276218, 11199.048080913051, 11208.991190792867, 11209.0, 11222.382768947786, 11231.606893758679, 8031.718889838828, 8314.085450600429, 8421.19998600132, 8461.40770146084, 8563.914360856312, 5745.454181852718, 5805.3614102447855, 5886.58793884424, 6058.394160583906, 6068.757249710139, 10372.844407333745, 10394.376337419779, 10424.0, 10612.097971672494, 10620.52207650642, 10120.392776433437, 10826.621068262573, 10847.0, 10855.728606784893, 10864.837027444437, 7208.0, 7414.8887766682465, 7800.0, 7861.960690196513, 8007.519548827089, 8725.083866193958, 8806.60370283326, 8935.463872167691, 8955.41789783662, 8956.507392093237, 7755.0, 7886.44794864354, 7906.723264685708, 7911.802204944923, 8015.679372825021, 6738.6967586459705, 7751.689932402641, 7757.495762775401, 7769.067711874612, 7801.804954876174, 7110.0, 7234.059572255573, 7239.457040721862, 7240.565566066053, 7257.745978890925, 4621.399218101626, 4877.731724755031, 4912.533309335608, 5043.193089105725, 5202.063628546898, 4188.7905604719035, 4970.378702662168, 5088.262201980618, 5134.10153223177, 5166.0], "value": 4650.914663261686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.93269480714235, 312.5546096812043, 320.63607805141163, 320.93420848726015, 326.92441866260003, 4856.247281671338, 5182.067227898977, 5473.726313684319, 5508.669479831213, 5518.1998610201545, 4694.225452800284, 4737.981334013187, 4935.358403407561, 5114.156164232897, 5399.892002159954, 4040.0505881117915, 4215.515215750197, 4215.59951804578, 4231.915361692764, 4268.701190916637, 4113.239050775601, 4242.809073591696, 4254.404598275647, 4259.318509038554, 4288.898439764508, 3880.72834901557, 4029.194161167778, 4112.527059388164, 4151.58484151584, 4193.790310484479, 4120.484939382577, 4155.563665815092, 4166.791660416998, 4179.3939878717565, 4197.937030944508, 3335.8832440864453, 3376.8818091366684, 3667.651573100551, 3670.4310831821113, 3671.5777685566236, 5239.397469291004, 5299.920501192485, 5349.518543331119, 5372.973135134338, 5412.269343638598, 3775.377062784637, 4818.301346304801, 4858.368412106403, 4883.5604795568215, 4973.353464049686, 5574.414686457944, 5747.166660834156, 5796.652200867919, 5826.766929322822, 5853.32686741026, 3652.8356223969986, 3687.8893633191046, 3900.726949113563, 3932.58707835676, 3956.643902048829, 4709.905801883943, 5154.974225128888, 5171.7672704728, 5538.280023596906, 6046.551146785559, 3891.9416208756893, 3893.0, 3897.668698160688, 3904.590018048064, 3909.338531124261, 3844.0774214188955, 3864.787436691009, 4044.2518134145275, 4044.2518134145275, 4048.2510735514024, 4686.859394218179, 4703.45910220329, 4714.764261786897, 4718.834840780625, 4771.355866957916, 4531.614812740954, 4551.613112885442, 5065.316182315414, 5596.8806238751595, 5881.32364778056, 1169.7660467906453, 1364.583801940398, 1380.475419340644, 1386.8058471813954, 1393.4217299820461, 739.8372358081214, 801.410962942237, 836.2640876029055, 841.6911702302978, 857.3398483167925, 3971.3447281198855, 4463.933041004388, 4571.9085618287445, 4588.040713739686, 4589.403377560896, 4003.479547658844, 4340.023494713727, 4915.281329923314, 5047.646664733434, 5085.8728531787, 4357.346398040256, 4536.818527258873, 4570.794314255866, 4572.702774319659, 4601.907961840811, 2156.654935210359, 2304.896279667419, 2380.797632201248, 2514.57252267115, 2636.299586766563, 4340.502526628308, 5168.916555920856, 5176.818811341585, 5220.686758794409, 5301.628885978022, 3987.4816273884207, 4388.385626012361, 4450.933236001462, 4721.905561888743, 5063.746632748465, 4120.848938826467, 4588.174128656874, 4907.779149938261, 5173.456787037307, 5201.011807756514, 4203.07532342884, 4995.377426850787, 4996.250562415521, 5014.7994080236385, 5047.678068088573, 4237.91524169521, 4414.955850441583, 4424.623906967944, 4908.558229759339, 4985.750712464434, 4863.756812159449, 5146.974265128651, 5186.429492755869, 5944.464998150187, 6132.78535251264, 3359.765755772384, 3676.1544844685336, 3712.702983761347, 3985.5815139409942, 3993.3610622300293, 5985.610935289193, 6039.577229593886, 6040.0, 6043.214382130295, 6059.212762129469, 5169.431362550041, 5400.352892367866, 5648.587853036741, 5739.71301434935, 5766.826995189983, 4502.0, 5457.536109430743, 5749.626274292157, 5812.447817457335, 5833.67914764692, 4953.702777833341, 5085.618578606545, 5085.821996230115, 5376.919346209888, 5687.9431205687415, 5146.382434107931, 5534.972325138509, 5803.535717142534, 5819.214406055297, 5838.854028649318, 5686.346070201815, 5729.939961107209, 5731.713414329351, 5754.19441278213, 5759.2512973313205], "value": 3973.554275571631, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.8015355700405, 763.6258233465602, 809.4617079642038, 828.9295409890159, 851.9318454523639, 16072.196390180488, 17266.0, 17275.0, 17296.135193240352, 17344.56638584036, 16848.74726879098, 17333.7399939001, 17556.209970551325, 17591.73612395815, 17658.82341176588, 742.5730205132044, 899.3389858454032, 920.3143657974819, 920.8434566123775, 924.3021518753366, 752.3304259209308, 901.5717534171249, 923.201430762389, 931.417863835103, 935.3078721745927, 977.8924318325014, 983.8327484327646, 985.2069084387066, 985.4579981010452, 987.6395115782759, 975.6341371985505, 978.0757184460688, 979.6277414582413, 979.8726165598498, 981.0287815063108, 655.3151956205777, 685.3763075601179, 723.6960476599788, 726.1213931143322, 728.6283995162453, 16046.5988350291, 16177.948433351912, 16213.756793648105, 16230.0, 16253.83746162547, 14416.92791536046, 14806.925965370105, 14810.407583696639, 14847.554573362708, 14887.553373398816, 11842.0, 12135.332556709378, 12240.510379584806, 12287.69280767988, 12435.813462798065, 3939.980300098481, 3967.583403742623, 3989.4614227079264, 3994.520657521116, 4105.97947010266, 121359.0, 125156.0, 125446.0, 126136.0, 131353.0, 11143.0, 11264.0, 11509.76980460386, 11531.192816502931, 11614.883851161549, 22706.091756329894, 22734.772652273597, 22908.9690963907, 23024.079036838673, 23089.53820923572, 7963.601819908981, 8182.18178182189, 8416.537090460084, 8452.535110568977, 8553.700620478254, 4652.302154676826, 4741.122892264942, 4776.357032688207, 4816.975915120472, 4836.443808961944, 3492.930141397158, 3635.5455568053994, 3649.5802982657333, 3652.945205821915, 3654.561452625702, 590.2238556298454, 683.3200965039817, 691.2948792231996, 702.5679207287482, 707.9539829911039, 606.6087373643975, 658.9703463344161, 672.9562578432386, 684.698732557673, 715.1882613234017, 9763.658271960447, 9880.654177103766, 9894.55474503649, 10162.593496260066, 10194.133498652698, 656.0323522803922, 668.7602633367522, 716.5449939288485, 716.9211386747454, 724.463896716426, 4593.425821772278, 4609.95390046102, 4760.143174228672, 4994.325766021613, 5025.271335656309, 103354.0, 104975.0, 145955.0, 158598.0, 158955.0, 88499.55750221208, 126944.0, 129833.70166298405, 139166.0, 141048.29475852556, 118598.4070079644, 121684.0, 124157.0, 125373.37313313558, 126463.0, 9598.760030999281, 10317.74205644865, 10375.533101010624, 10386.0, 10439.217058720778, 64302.0, 66413.66793166003, 66977.0, 67931.0, 68357.0, 93369.95369285559, 98301.52547711648, 98328.50835745776, 103189.0, 104010.47994759977, 11712.355820429959, 12687.302198379179, 13232.809047185414, 13350.532731354357, 13840.723185536031, 14790.334434950239, 14918.925405372904, 15064.62338441504, 15710.607234819221, 16714.58213544671, 13049.608511744664, 13189.472421103048, 13876.437341648623, 14045.227512486912, 14478.927605361905, 13577.52478663242, 14809.33357998871, 14975.850241497446, 15285.388584456497, 15468.303926323568, 14349.713005740035, 14510.0, 14703.970722049355, 14815.777763333343, 15127.54617361481, 10566.413544130462, 11465.770684586429, 11592.768144637228, 12004.87873153004, 12314.199577027823, 11559.595414160463, 11612.0, 11814.113941454598, 11865.5847045353, 11872.0], "value": 8294.296584405967, "unit": "score"}], "name": "dromaeo_css", "value": 7472.605919796154, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 114.0, 115.0, 112.0, 113.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 127.0, 135.0, 137.0, 105.0, 106.0, 107.0, 106.0, 136.0, 106.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 191.0, 184.0, 184.0, 181.0, 182.0, 181.0, 182.0, 182.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 89.0, 61.0, 58.0, 58.0, 60.0, 103.0, 81.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 93.0, 70.0, 67.0, 67.0, 91.0, 69.0, 67.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 87.0, 83.0, 86.0, 89.0, 134.0, 127.0, 86.0, 83.0], "value": 94.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 95.0, 93.0, 95.0, 94.0, 93.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 84.0, 86.0, 83.0, 85.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 50.0, 53.0, 52.0, 55.0, 54.0, 55.0, 55.0, 56.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 63.0, 75.0, 70.0, 67.0, 68.0, 69.0, 68.0, 70.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 99.0, 80.0, 82.0, 78.0, 83.0, 84.0, 83.0, 88.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 147.0, 143.0, 150.0, 137.0, 139.0, 139.0, 192.0, 121.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 162.0, 161.0, 161.0, 160.0, 159.0, 158.0, 158.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 66.0, 66.0, 67.0, 64.0, 64.0, 64.0, 68.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1417.2, "alertThreshold": 2.0}]} 05:14:54 INFO - Return code: 0 05:14:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:14:54 INFO - # TBPL SUCCESS # 05:14:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:54 INFO - 2016-11-27 05:14:54.498 screenresolution[1968:27614] starting screenresolution argv=screenresolution get 05:14:54 INFO - 2016-11-27 05:14:54.501 screenresolution[1968:27614] Display 0: 1600x1200x32@60 05:14:54 INFO - 2016-11-27 05:14:54.507 screenresolution[1969:27617] starting screenresolution argv=screenresolution list 05:14:54 INFO - Available Modes on Display 0 05:14:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:54 INFO - Intel Iris: 05:14:54 INFO - Chipset Model: Intel Iris 05:14:54 INFO - Type: GPU 05:14:54 INFO - Bus: Built-In 05:14:54 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:54 INFO - Vendor: Intel (0x8086) 05:14:54 INFO - Device ID: 0x0a2e 05:14:54 INFO - Revision ID: 0x0009 05:14:54 INFO - Displays: 05:14:54 INFO - Display: 05:14:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:54 INFO - Display Serial Number: 1600x1200 60 05:14:54 INFO - Main Display: Yes 05:14:54 INFO - Mirror: Off 05:14:54 INFO - Online: Yes 05:14:54 INFO - Rotation: Supported 05:14:54 INFO - Return code: 0 05:14:54 INFO - Running post-action listener: _resource_record_post_action 05:14:54 INFO - [mozharness: 2016-11-27 13:14:54.741365Z] Finished run-tests step (success) 05:14:54 INFO - Running post-run listener: _resource_record_post_run 05:14:54 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 1216512; Write bytes: 495852544; Read time: 7; Write time: 1640 05:14:54 INFO - TinderboxPrint: CPU usage
53.3% 05:14:54 INFO - TinderboxPrint: I/O read bytes / time
1,216,512 / 7 05:14:54 INFO - TinderboxPrint: I/O write bytes / time
495,852,544 / 1,640 05:14:54 INFO - TinderboxPrint: CPU idle
2,229.8 (46.7%) 05:14:54 INFO - TinderboxPrint: CPU system
950.3 (19.9%) 05:14:54 INFO - TinderboxPrint: CPU user
1,597.5 (33.4%) 05:14:54 INFO - TinderboxPrint: Swap in / out
195,940,352 / 0 05:14:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183308800; Write bytes: 178370048; Read time: 16651; Write time: 405 05:14:54 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 1216512; Write bytes: 297375232; Read time: 7; Write time: 1172 05:14:55 INFO - Running post-run listener: _upload_blobber_files 05:14:55 INFO - Blob upload gear active. 05:14:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:55 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 05:14:55 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'] 05:14:55 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 05:14:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:14:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:56 INFO - (blobuploader) - INFO - Done attempting. 05:14:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:14:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:14:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:57 INFO - (blobuploader) - INFO - Done attempting. 05:14:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:59 INFO - (blobuploader) - INFO - Done attempting. 05:14:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:59 INFO - Return code: 0 05:14:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/098ec11c67d399e09499df6afdbeb58176fc1b28971c7159bdc4e55906116676c02ccb5ae758e65f19ee4827bd7b7abdcc2d0f459f3f9f2587421bfac1df8679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507db5009f4091a7a902f36cb1c7a549ae98c53b9ff83c38ac9af0257af7f0e727f4750536c70e2e94abc2a6127d42194229a3b11c84a7327f8f4d675aea8a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/379657553d44d75849a747a318a0b888f28b7f5133a0e1b06c363cd8a84b67089e04e17e6b425199c3c8e1182b14924751c67c226170e9c4edd845cbf3fb4f01"} 05:14:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:59 INFO - Contents: 05:14:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/098ec11c67d399e09499df6afdbeb58176fc1b28971c7159bdc4e55906116676c02ccb5ae758e65f19ee4827bd7b7abdcc2d0f459f3f9f2587421bfac1df8679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507db5009f4091a7a902f36cb1c7a549ae98c53b9ff83c38ac9af0257af7f0e727f4750536c70e2e94abc2a6127d42194229a3b11c84a7327f8f4d675aea8a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/379657553d44d75849a747a318a0b888f28b7f5133a0e1b06c363cd8a84b67089e04e17e6b425199c3c8e1182b14924751c67c226170e9c4edd845cbf3fb4f01"} 05:14:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:59 INFO - Copying logs to upload dir... 05:14:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.688095 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-27 05:14:59.456842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 05:14:59.460127) ========= 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.KQcngwvI94/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.TisqDbPzFL/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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/098ec11c67d399e09499df6afdbeb58176fc1b28971c7159bdc4e55906116676c02ccb5ae758e65f19ee4827bd7b7abdcc2d0f459f3f9f2587421bfac1df8679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507db5009f4091a7a902f36cb1c7a549ae98c53b9ff83c38ac9af0257af7f0e727f4750536c70e2e94abc2a6127d42194229a3b11c84a7327f8f4d675aea8a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/379657553d44d75849a747a318a0b888f28b7f5133a0e1b06c363cd8a84b67089e04e17e6b425199c3c8e1182b14924751c67c226170e9c4edd845cbf3fb4f01"} build_url:https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011072 build_url: 'https://queue.taskcluster.net/v1/task/G0Hhm9GFRLSKkUHRyAH3dA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/098ec11c67d399e09499df6afdbeb58176fc1b28971c7159bdc4e55906116676c02ccb5ae758e65f19ee4827bd7b7abdcc2d0f459f3f9f2587421bfac1df8679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507db5009f4091a7a902f36cb1c7a549ae98c53b9ff83c38ac9af0257af7f0e727f4750536c70e2e94abc2a6127d42194229a3b11c84a7327f8f4d675aea8a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/379657553d44d75849a747a318a0b888f28b7f5133a0e1b06c363cd8a84b67089e04e17e6b425199c3c8e1182b14924751c67c226170e9c4edd845cbf3fb4f01"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 05:14:59.494591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:14:59.494982) ========= 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.KQcngwvI94/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.TisqDbPzFL/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.005222 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:14:59.544230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 05:14:59.544558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 05:14:59.544960) ========= ========= Total master_lag: 0.18 =========