builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1487088901.72 results: success (0) buildid: 20170214065344 builduid: d4521834f4b0420289cc785aa81e8bd1 revision: 006d94b8192c1a1ff9d3d9746a48c51f0a570a2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:01.724630) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:01.725134) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:01.725596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:01.752920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:01.753364) ========= 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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-14 08:15:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-02-14 08:15:01 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.211659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:01.988913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:01.989286) ========= 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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.019868 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:02.038059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 08:15:02.038453) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 006d94b8192c1a1ff9d3d9746a48c51f0a570a2b --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-aurora --rev 006d94b8192c1a1ff9d3d9746a48c51f0a570a2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-14 08:15:02,086 truncating revision to first 12 chars 2017-02-14 08:15:02,087 Setting DEBUG logging. 2017-02-14 08:15:02,087 attempt 1/10 2017-02-14 08:15:02,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/006d94b8192c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 08:15:03,363 unpacking tar archive at: mozilla-aurora-006d94b8192c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.518988 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 08:15:03.717890) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:03.718283) ========= script_repo_revision: 006d94b8192c1a1ff9d3d9746a48c51f0a570a2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:03.718777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:03.719097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 08:15:03.739272) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-14 08:15:03.739624) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:03 INFO - MultiFileLogger online at 20170214 08:15:03 in /builds/slave/test 08:15:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:15:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:03 INFO - {'append_to_log': False, 08:15:03 INFO - 'base_work_dir': '/builds/slave/test', 08:15:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:15:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:03 INFO - 'branch': 'Mozilla-Aurora', 08:15:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:03 INFO - 'config_files': ('talos/mac_config.py',), 08:15:03 INFO - 'default_actions': ('clobber', 08:15:03 INFO - 'read-buildbot-config', 08:15:03 INFO - 'download-and-extract', 08:15:03 INFO - 'populate-webroot', 08:15:03 INFO - 'create-virtualenv', 08:15:03 INFO - 'install', 08:15:03 INFO - 'run-tests'), 08:15:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:03 INFO - 'download_minidump_stackwalk': True, 08:15:03 INFO - 'download_symbols': 'ondemand', 08:15:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:03 INFO - 'installer_path': 'installer.exe', 08:15:03 INFO - 'log_level': 'info', 08:15:03 INFO - 'log_name': 'talos', 08:15:03 INFO - 'log_to_console': True, 08:15:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:15:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:15:03 INFO - 'opt_config_files': (), 08:15:03 INFO - 'pip_index': False, 08:15:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:03 INFO - 'cmd': ('bash', 08:15:03 INFO - '-c', 08:15:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:03 INFO - 'enabled': True, 08:15:03 INFO - 'halt_on_failure': False, 08:15:03 INFO - 'name': 'check_screen_resolution'},), 08:15:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:03 INFO - 'cmd': ('bash', 08:15:03 INFO - '-c', 08:15:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:03 INFO - 'enabled': True, 08:15:03 INFO - 'halt_on_failure': False, 08:15:03 INFO - 'name': 'check_screen_resolution'},), 08:15:03 INFO - 'run_cmd_checks_enabled': True, 08:15:03 INFO - 'sps_profile': False, 08:15:03 INFO - 'sps_profile_interval': 0, 08:15:03 INFO - 'suite': 'dromaeojs', 08:15:03 INFO - 'system_bits': '32', 08:15:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:03 INFO - 'title': 't-yosemite-r7-0387', 08:15:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:03 INFO - 'use_talos_json': True, 08:15:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:03 INFO - 'work_dir': 'build'} 08:15:03 INFO - [mozharness: 2017-02-14 16:15:03.905108Z] Running clobber step. 08:15:03 INFO - Running pre-action listener: _resource_record_pre_action 08:15:03 INFO - Running main action method: clobber 08:15:03 INFO - rmtree: /builds/slave/test/build 08:15:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:04 INFO - Running post-action listener: _resource_record_post_action 08:15:04 INFO - [mozharness: 2017-02-14 16:15:04.244335Z] Finished clobber step (success) 08:15:04 INFO - [mozharness: 2017-02-14 16:15:04.244457Z] Running read-buildbot-config step. 08:15:04 INFO - Running pre-action listener: _resource_record_pre_action 08:15:04 INFO - Running main action method: read_buildbot_config 08:15:04 INFO - Using buildbot properties: 08:15:04 INFO - { 08:15:04 INFO - "project": "", 08:15:04 INFO - "product": "firefox", 08:15:04 INFO - "script_repo_revision": "production", 08:15:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:15:04 INFO - "repository": "", 08:15:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:15:04 INFO - "buildid": "20170214065344", 08:15:04 INFO - "pgo_build": "False", 08:15:04 INFO - "basedir": "/builds/slave/test", 08:15:04 INFO - "buildnumber": 71, 08:15:04 INFO - "slavename": "t-yosemite-r7-0387", 08:15:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:15:04 INFO - "platform": "yosemite_r7", 08:15:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:15:04 INFO - "branch": "mozilla-aurora", 08:15:04 INFO - "repo_path": "releases/mozilla-aurora", 08:15:04 INFO - "revision": "006d94b8192c1a1ff9d3d9746a48c51f0a570a2b", 08:15:04 INFO - "stage_platform": "macosx64", 08:15:04 INFO - "builduid": "d4521834f4b0420289cc785aa81e8bd1", 08:15:04 INFO - "slavebuilddir": "test" 08:15:04 INFO - } 08:15:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:15:04 INFO - Running post-action listener: _resource_record_post_action 08:15:04 INFO - [mozharness: 2017-02-14 16:15:04.247950Z] Finished read-buildbot-config step (success) 08:15:04 INFO - [mozharness: 2017-02-14 16:15:04.248074Z] Running download-and-extract step. 08:15:04 INFO - Running pre-action listener: _resource_record_pre_action 08:15:04 INFO - Running main action method: download_and_extract 08:15:04 INFO - mkdir: /builds/slave/test/build/tests 08:15:04 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')]} 08:15:04 INFO - trying https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:15:05 INFO - Downloaded 1199 bytes. 08:15:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:15:05 INFO - Using the following test package requirements: 08:15:05 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:15:05 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:15:05 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:15:05 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'jsshell-mac.zip'], 08:15:05 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:15:05 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:15:05 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:15:05 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:15:05 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:15:05 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:15:05 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:15:05 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:15:06 INFO - Expected file size: 16358340 08:15:06 INFO - Obtained file size: 16358340 08:15:13 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:15:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:15:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:15:13 INFO - Fetch https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:15:14 INFO - Expected file size: 16358340 08:15:14 INFO - Obtained file size: 16358340 08:15:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:15:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:15:20 INFO - Fetch https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:15:21 INFO - Expected file size: 14403485 08:15:21 INFO - Obtained file size: 14403485 08:15: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')]} 08:15:21 INFO - trying https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:15:21 INFO - Downloading https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:15:23 INFO - Downloaded 73952484 bytes. 08:15:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:15:23 INFO - mkdir: /builds/slave/test/properties 08:15:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:23 INFO - Contents: 08:15:23 INFO - build_url:https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:15:24 INFO - Running post-action listener: _resource_record_post_action 08:15:24 INFO - Running post-action listener: set_extra_try_arguments 08:15:24 INFO - [mozharness: 2017-02-14 16:15:24.588349Z] Finished download-and-extract step (success) 08:15:24 INFO - [mozharness: 2017-02-14 16:15:24.588469Z] Running populate-webroot step. 08:15:24 INFO - Running pre-action listener: _resource_record_pre_action 08:15:24 INFO - Running main action method: populate_webroot 08:15:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:24 INFO - '--tppagecycles', 08:15:24 INFO - '7'], 08:15:24 INFO - 'tests': ['tsvgm']}}, 08:15:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:15:24 INFO - 'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:15:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:15:24 INFO - 'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['damp', 'tps']}, 08:15:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:15:24 INFO - 'tests': ['damp', 'tps']}, 08:15:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['dromaeo_dom']}, 08:15:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['basic_compositor_video']}, 08:15:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:15:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['a11yr', 08:15:24 INFO - 'ts_paint', 08:15:24 INFO - 'tpaint', 08:15:24 INFO - 'sessionrestore', 08:15:24 INFO - 'sessionrestore_no_auto_restore', 08:15:24 INFO - 'tabpaint']}, 08:15:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:24 INFO - 'ts_paint', 08:15:24 INFO - 'tpaint', 08:15:24 INFO - 'sessionrestore', 08:15:24 INFO - 'sessionrestore_no_auto_restore', 08:15:24 INFO - 'tabpaint']}, 08:15:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:24 INFO - 'ts_paint', 08:15:24 INFO - 'tpaint', 08:15:24 INFO - 'sessionrestore', 08:15:24 INFO - 'sessionrestore_no_auto_restore', 08:15:24 INFO - 'tabpaint']}, 08:15:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:24 INFO - 'ts_paint', 08:15:24 INFO - 'tpaint', 08:15:24 INFO - 'sessionrestore', 08:15:24 INFO - 'sessionrestore_no_auto_restore', 08:15:24 INFO - 'tabpaint']}, 08:15:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['a11yr', 08:15:24 INFO - 'ts_paint', 08:15:24 INFO - 'tpaint', 08:15:24 INFO - 'sessionrestore', 08:15:24 INFO - 'sessionrestore_no_auto_restore', 08:15:24 INFO - 'tabpaint']}, 08:15:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['a11yr', 08:15:24 INFO - 'ts_paint', 08:15:24 INFO - 'tpaint', 08:15:24 INFO - 'sessionrestore', 08:15:24 INFO - 'sessionrestore_no_auto_restore', 08:15:24 INFO - 'tabpaint']}, 08:15:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['tsvgx', 08:15:24 INFO - 'tsvgr_opacity', 08:15:24 INFO - 'tart', 08:15:24 INFO - 'tscrollx', 08:15:24 INFO - 'cart', 08:15:24 INFO - 'tsvg_static']}, 08:15:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:24 INFO - 'tsvgr_opacity', 08:15:24 INFO - 'tart', 08:15:24 INFO - 'tscrollx', 08:15:24 INFO - 'cart', 08:15:24 INFO - 'tsvg_static']}, 08:15:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:15:24 INFO - 'talos_options': ['--disable-e10s'], 08:15:24 INFO - 'tests': ['tp5o']}, 08:15:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:15:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:15:24 INFO - 'talos_options': ['--disable-e10s', 08:15:24 INFO - '--xperf_path', 08:15:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:24 INFO - 'tests': ['tp5n']}, 08:15:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:15:24 INFO - 'talos_options': ['--xperf_path', 08:15:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:24 INFO - 'tests': ['tp5n']}}, 08:15:24 INFO - 'talos.zip': {'path': '', 08:15:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:24 INFO - Running post-action listener: _resource_record_post_action 08:15:24 INFO - [mozharness: 2017-02-14 16:15:24.606746Z] Finished populate-webroot step (success) 08:15:24 INFO - [mozharness: 2017-02-14 16:15:24.606883Z] Running create-virtualenv step. 08:15:24 INFO - Running pre-action listener: _resource_record_pre_action 08:15:24 INFO - Running main action method: create_virtualenv 08:15:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:24 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 08:15:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:24 INFO - Using real prefix '/tools/python27' 08:15:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:28 INFO - Installing pip.................done. 08:15:28 INFO - Return code: 0 08:15:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:15:28 INFO - Reading from file tmpfile_stdout 08:15:28 INFO - Output received: 08:15:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:15:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:28 INFO - 'HOME': '/Users/cltbld', 08:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:28 INFO - 'LOGNAME': 'cltbld', 08:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:28 INFO - 'MOZ_NO_REMOTE': '1', 08:15:28 INFO - 'NO_EM_RESTART': '1', 08:15:28 INFO - 'PAGER': '/bin/cat', 08:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:28 INFO - 'PWD': '/builds/slave/test', 08:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:28 INFO - 'SHELL': '/bin/bash', 08:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:28 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:28 INFO - 'USER': 'cltbld', 08:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:28 INFO - 'XPC_FLAGS': '0x0', 08:15:28 INFO - 'XPC_SERVICE_NAME': '0', 08:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:28 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 08:15:28 INFO - Cleaning up... 08:15:28 INFO - Return code: 0 08:15:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:28 INFO - 'HOME': '/Users/cltbld', 08:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:28 INFO - 'LOGNAME': 'cltbld', 08:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:28 INFO - 'MOZ_NO_REMOTE': '1', 08:15:28 INFO - 'NO_EM_RESTART': '1', 08:15:28 INFO - 'PAGER': '/bin/cat', 08:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:28 INFO - 'PWD': '/builds/slave/test', 08:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:28 INFO - 'SHELL': '/bin/bash', 08:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:28 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:28 INFO - 'USER': 'cltbld', 08:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:28 INFO - 'XPC_FLAGS': '0x0', 08:15:28 INFO - 'XPC_SERVICE_NAME': '0', 08:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:29 INFO - Downloading/unpacking psutil>=3.1.1 08:15:29 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 08:15:29 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 08:15:29 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 08:15:29 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 08:15:29 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 08:15:29 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 08:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:32 INFO - Installing collected packages: psutil 08:15:32 INFO - Running setup.py install for psutil 08:15:32 INFO - building 'psutil._psutil_osx' extension 08:15:32 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 08:15:32 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 08:15:33 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 08:15:33 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 08:15:33 INFO - building 'psutil._psutil_posix' extension 08:15:33 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 08:15:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:15:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:15:33 INFO - ^ 08:15:33 INFO - 1 warning generated. 08:15:33 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 08:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:33 INFO - Successfully installed psutil 08:15:33 INFO - Cleaning up... 08:15:33 INFO - Return code: 0 08:15:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:33 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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:33 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 08:15:33 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 08:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:33 INFO - 'HOME': '/Users/cltbld', 08:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:33 INFO - 'LOGNAME': 'cltbld', 08:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:33 INFO - 'MOZ_NO_REMOTE': '1', 08:15:33 INFO - 'NO_EM_RESTART': '1', 08:15:33 INFO - 'PAGER': '/bin/cat', 08:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:33 INFO - 'PWD': '/builds/slave/test', 08:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:33 INFO - 'SHELL': '/bin/bash', 08:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:33 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:33 INFO - 'USER': 'cltbld', 08:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:33 INFO - 'XPC_FLAGS': '0x0', 08:15:33 INFO - 'XPC_SERVICE_NAME': '0', 08:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:36 INFO - Installing collected packages: mozsystemmonitor 08:15:36 INFO - Running setup.py install for mozsystemmonitor 08:15:36 INFO - Successfully installed mozsystemmonitor 08:15:36 INFO - Cleaning up... 08:15:36 INFO - Return code: 0 08:15:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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', '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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:15: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 jsonschema==2.5.1 08:15:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:36 INFO - 'HOME': '/Users/cltbld', 08:15:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:36 INFO - 'LOGNAME': 'cltbld', 08:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:36 INFO - 'MOZ_NO_REMOTE': '1', 08:15:36 INFO - 'NO_EM_RESTART': '1', 08:15:36 INFO - 'PAGER': '/bin/cat', 08:15:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:36 INFO - 'PWD': '/builds/slave/test', 08:15:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:36 INFO - 'SHELL': '/bin/bash', 08:15:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:36 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:36 INFO - 'USER': 'cltbld', 08:15:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:36 INFO - 'XPC_FLAGS': '0x0', 08:15:36 INFO - 'XPC_SERVICE_NAME': '0', 08:15:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:36 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 08:15:36 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 08:15:36 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 08:15:36 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 08:15:36 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 08:15:36 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 08:15:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:39 INFO - warning: no files found matching '*.txt' 08:15:40 INFO - no previously-included directories found matching 'build' 08:15:40 INFO - no previously-included directories found matching 'dist' 08:15:40 INFO - no previously-included directories found matching '.git*' 08:15:40 INFO - Installing collected packages: jsonschema, functools32 08:15:40 INFO - Running setup.py install for functools32 08:15:40 INFO - warning: no files found matching '*.txt' 08:15:40 INFO - no previously-included directories found matching 'build' 08:15:40 INFO - no previously-included directories found matching 'dist' 08:15:40 INFO - no previously-included directories found matching '.git*' 08:15:40 INFO - Successfully installed jsonschema functools32 08:15:40 INFO - Cleaning up... 08:15:40 INFO - Return code: 0 08:15:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:15:40 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')]} 08:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:40 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')]} 08:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:40 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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:40 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 08:15:40 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 08:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:40 INFO - 'HOME': '/Users/cltbld', 08:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:40 INFO - 'LOGNAME': 'cltbld', 08:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:40 INFO - 'MOZ_NO_REMOTE': '1', 08:15:40 INFO - 'NO_EM_RESTART': '1', 08:15:40 INFO - 'PAGER': '/bin/cat', 08:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:40 INFO - 'PWD': '/builds/slave/test', 08:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:40 INFO - 'SHELL': '/bin/bash', 08:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:40 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:40 INFO - 'USER': 'cltbld', 08:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:40 INFO - 'XPC_FLAGS': '0x0', 08:15:40 INFO - 'XPC_SERVICE_NAME': '0', 08:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:15:40 INFO - Cleaning up... 08:15:40 INFO - Return code: 0 08:15:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:15:40 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')]} 08:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:40 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')]} 08:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:40 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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:40 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 08:15:40 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 08:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:40 INFO - 'HOME': '/Users/cltbld', 08:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:40 INFO - 'LOGNAME': 'cltbld', 08:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:40 INFO - 'MOZ_NO_REMOTE': '1', 08:15:40 INFO - 'NO_EM_RESTART': '1', 08:15:40 INFO - 'PAGER': '/bin/cat', 08:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:40 INFO - 'PWD': '/builds/slave/test', 08:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:40 INFO - 'SHELL': '/bin/bash', 08:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:40 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:40 INFO - 'USER': 'cltbld', 08:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:40 INFO - 'XPC_FLAGS': '0x0', 08:15:40 INFO - 'XPC_SERVICE_NAME': '0', 08:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15:43 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 08:15:43 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 08:15:43 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 08:15:43 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 08:15:43 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 08:15:43 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 08:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15:44 INFO - Downloading docopt-0.6.1.tar.gz 08:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:44 INFO - Running setup.py install for blobuploader 08:15:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:44 INFO - Running setup.py install for requests 08:15:45 INFO - Running setup.py install for docopt 08:15:45 INFO - Successfully installed blobuploader requests docopt 08:15:45 INFO - Cleaning up... 08:15:45 INFO - Return code: 0 08:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:45 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')]} 08:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:45 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')]} 08:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:45 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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:45 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 08:15:45 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 08:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:45 INFO - 'HOME': '/Users/cltbld', 08:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:45 INFO - 'LOGNAME': 'cltbld', 08:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:45 INFO - 'MOZ_NO_REMOTE': '1', 08:15:45 INFO - 'NO_EM_RESTART': '1', 08:15:45 INFO - 'PAGER': '/bin/cat', 08:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:45 INFO - 'PWD': '/builds/slave/test', 08:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:45 INFO - 'SHELL': '/bin/bash', 08:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:45 INFO - 'USER': 'cltbld', 08:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:45 INFO - 'XPC_FLAGS': '0x0', 08:15:45 INFO - 'XPC_SERVICE_NAME': '0', 08:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-TeD9ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-1vRflR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-KmCKyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-qGNI4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-tSMUgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-5Iqzoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-I8X_EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-IeOkQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-97I9FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GR1uHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fqf1Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fI71dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-DutVm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zKWj5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nUhDfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zImZul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-j8uDuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:47 INFO - Running setup.py install for manifestparser 08:15:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:47 INFO - Running setup.py install for mozcrash 08:15:47 INFO - Running setup.py install for mozdebug 08:15:48 INFO - Running setup.py install for mozdevice 08:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Running setup.py install for mozfile 08:15:48 INFO - Running setup.py install for mozhttpd 08:15:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Running setup.py install for mozinfo 08:15:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Running setup.py install for mozInstall 08:15:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:48 INFO - Running setup.py install for mozleak 08:15:49 INFO - Running setup.py install for mozlog 08:15:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:49 INFO - Running setup.py install for moznetwork 08:15:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:49 INFO - Running setup.py install for mozprocess 08:15:49 INFO - Running setup.py install for mozprofile 08:15:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:49 INFO - Running setup.py install for mozrunner 08:15:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:49 INFO - Running setup.py install for mozscreenshot 08:15:49 INFO - Running setup.py install for moztest 08:15:50 INFO - Running setup.py install for mozversion 08:15:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:50 INFO - Cleaning up... 08:15:50 INFO - Return code: 0 08:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:50 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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:50 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 08:15:50 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 08:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:50 INFO - 'HOME': '/Users/cltbld', 08:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:50 INFO - 'LOGNAME': 'cltbld', 08:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:50 INFO - 'MOZ_NO_REMOTE': '1', 08:15:50 INFO - 'NO_EM_RESTART': '1', 08:15:50 INFO - 'PAGER': '/bin/cat', 08:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:50 INFO - 'PWD': '/builds/slave/test', 08:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:50 INFO - 'SHELL': '/bin/bash', 08:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:50 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:50 INFO - 'USER': 'cltbld', 08:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:50 INFO - 'XPC_FLAGS': '0x0', 08:15:50 INFO - 'XPC_SERVICE_NAME': '0', 08:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-C1tekL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:50 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)) 08:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-_5lmMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-F0fNqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:50 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)) 08:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-VAPId1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GrFWME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-HqukRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-kXJEET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-sytii5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-xhfEhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-7HUmMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-s03eDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-u4uLTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-hrCRhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:51 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)) 08:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-JoFcaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:52 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-SNjVup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:52 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)) 08:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:52 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ttcCgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:52 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-PwcS2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:52 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)) 08:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:52 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)) 08:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:52 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 08:15:52 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 08:15:52 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 08:15:52 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 08:15:52 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 08:15:52 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 08:15:54 INFO - Downloading blessings-1.6.tar.gz 08:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:55 INFO - Installing collected packages: blessings 08:15:55 INFO - Running setup.py install for blessings 08:15:55 INFO - Successfully installed blessings 08:15:55 INFO - Cleaning up... 08:15:55 INFO - Return code: 0 08:15:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:55 INFO - Reading from file tmpfile_stdout 08:15:55 INFO - Current package versions: 08:15:55 INFO - blessings == 1.6 08:15:55 INFO - blobuploader == 1.2.4 08:15:55 INFO - docopt == 0.6.1 08:15:55 INFO - functools32 == 3.2.3-2 08:15:55 INFO - jsonschema == 2.5.1 08:15:55 INFO - manifestparser == 1.1 08:15:55 INFO - mozInstall == 1.12 08:15:55 INFO - mozcrash == 1.0 08:15:55 INFO - mozdebug == 0.1 08:15:55 INFO - mozdevice == 0.49 08:15:55 INFO - mozfile == 1.2 08:15:55 INFO - mozhttpd == 0.7 08:15:55 INFO - mozinfo == 0.9 08:15:55 INFO - mozleak == 0.1 08:15:55 INFO - mozlog == 3.4 08:15:55 INFO - moznetwork == 0.27 08:15:55 INFO - mozprocess == 0.24 08:15:55 INFO - mozprofile == 0.28 08:15:55 INFO - mozrunner == 6.13 08:15:55 INFO - mozscreenshot == 0.1 08:15:55 INFO - mozsystemmonitor == 0.3 08:15:55 INFO - moztest == 0.8 08:15:55 INFO - mozversion == 1.4 08:15:55 INFO - psutil == 3.1.1 08:15:55 INFO - requests == 1.2.3 08:15:55 INFO - wsgiref == 0.1.2 08:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:55 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')]} 08:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:55 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')]} 08:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:55 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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:55 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 08:15:55 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 08:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:55 INFO - 'HOME': '/Users/cltbld', 08:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:55 INFO - 'LOGNAME': 'cltbld', 08:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:55 INFO - 'MOZ_NO_REMOTE': '1', 08:15:55 INFO - 'NO_EM_RESTART': '1', 08:15:55 INFO - 'PAGER': '/bin/cat', 08:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:55 INFO - 'PWD': '/builds/slave/test', 08:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:55 INFO - 'SHELL': '/bin/bash', 08:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:55 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:55 INFO - 'USER': 'cltbld', 08:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:55 INFO - 'XPC_FLAGS': '0x0', 08:15:55 INFO - 'XPC_SERVICE_NAME': '0', 08:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 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)) 08:15:55 INFO - Cleaning up... 08:15:55 INFO - Return code: 0 08:15:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:55 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')]} 08:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:55 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')]} 08:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:55 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 0x100fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81da582050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, '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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 08:15:55 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 08:15:55 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 08:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:55 INFO - 'HOME': '/Users/cltbld', 08:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:55 INFO - 'LOGNAME': 'cltbld', 08:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:55 INFO - 'MOZ_NO_REMOTE': '1', 08:15:55 INFO - 'NO_EM_RESTART': '1', 08:15:55 INFO - 'PAGER': '/bin/cat', 08:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:55 INFO - 'PWD': '/builds/slave/test', 08:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:55 INFO - 'SHELL': '/bin/bash', 08:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:15:55 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:55 INFO - 'USER': 'cltbld', 08:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:55 INFO - 'XPC_FLAGS': '0x0', 08:15:55 INFO - 'XPC_SERVICE_NAME': '0', 08:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:56 INFO - Cleaning up... 08:15:56 INFO - Return code: 0 08:15:56 INFO - Running post-action listener: _resource_record_post_action 08:15:56 INFO - Running post-action listener: _start_resource_monitoring 08:15:56 INFO - Starting resource monitoring. 08:15:56 INFO - [mozharness: 2017-02-14 16:15:56.103414Z] Finished create-virtualenv step (success) 08:15:56 INFO - [mozharness: 2017-02-14 16:15:56.104354Z] Running install step. 08:15:56 INFO - Running pre-action listener: _resource_record_pre_action 08:15:56 INFO - Running main action method: install 08:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:56 INFO - Reading from file tmpfile_stdout 08:15:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:56 INFO - Reading from file tmpfile_stdout 08:15:56 INFO - Output received: 08:15:56 INFO - Usage: mozinstall [options] installer 08:15:56 INFO - Options: 08:15:56 INFO - -h, --help show this help message and exit 08:15:56 INFO - -d DEST, --destination=DEST 08:15:56 INFO - Directory to install application into. [default: 08:15:56 INFO - "/builds/slave/test"] 08:15:56 INFO - --app=APP Application being installed. [default: firefox] 08:15:56 INFO - mkdir: /builds/slave/test/build/application 08:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:16:16 INFO - Reading from file tmpfile_stdout 08:16:16 INFO - Output received: 08:16:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:16:16 INFO - Running post-action listener: _resource_record_post_action 08:16:16 INFO - [mozharness: 2017-02-14 16:16:16.703195Z] Finished install step (success) 08:16:16 INFO - [mozharness: 2017-02-14 16:16:16.703366Z] Running run-tests step. 08:16:16 INFO - Running pre-action listener: _resource_record_pre_action 08:16:16 INFO - Running main action method: run_tests 08:16:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:16:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:16:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:16:16 INFO - 2017-02-14 08:16:16.717 screenresolution[1968:277862] starting screenresolution argv=screenresolution get 08:16:16 INFO - 2017-02-14 08:16:16.720 screenresolution[1968:277862] Display 0: 1600x1200x32@60 08:16:16 INFO - 2017-02-14 08:16:16.726 screenresolution[1969:277865] starting screenresolution argv=screenresolution list 08:16:16 INFO - Available Modes on Display 0 08:16:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:16:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:16:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:16:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:16:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:16:16 INFO - Intel Iris: 08:16:16 INFO - Chipset Model: Intel Iris 08:16:16 INFO - Type: GPU 08:16:16 INFO - Bus: Built-In 08:16:16 INFO - VRAM (Dynamic, Max): 1536 MB 08:16:16 INFO - Vendor: Intel (0x8086) 08:16:16 INFO - Device ID: 0x0a2e 08:16:16 INFO - Revision ID: 0x0009 08:16:16 INFO - Displays: 08:16:16 INFO - Display: 08:16:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:16:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:16:16 INFO - Display Serial Number: 1600x1200 60 08:16:16 INFO - Main Display: Yes 08:16:16 INFO - Mirror: Off 08:16:16 INFO - Online: Yes 08:16:16 INFO - Rotation: Supported 08:16:16 INFO - Return code: 0 08:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:16 INFO - Python 2.7.3 08:16:16 INFO - Return code: 0 08:16:16 INFO - grabbing minidump binary from tooltool 08:16:16 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')]} 08:16:16 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 0x100dbcd30>, '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 0x100ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:16 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 08:16:16 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 08:16:16 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 08:16:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:17 INFO - Return code: 0 08:16:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:16:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:16:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 08:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --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 08:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f1CtGnqbsH/Render', 08:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:17 INFO - 'HOME': '/Users/cltbld', 08:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:17 INFO - 'LOGNAME': 'cltbld', 08:16:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:17 INFO - 'MOZ_NO_REMOTE': '1', 08:16:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:17 INFO - 'NO_EM_RESTART': '1', 08:16:17 INFO - 'PAGER': '/bin/cat', 08:16:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:17 INFO - 'PWD': '/builds/slave/test', 08:16:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:17 INFO - 'SHELL': '/bin/bash', 08:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dj6KF7rdIL/Listeners', 08:16:17 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 08:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:17 INFO - 'USER': 'cltbld', 08:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:17 INFO - 'XPC_FLAGS': '0x0', 08:16:17 INFO - 'XPC_SERVICE_NAME': '0', 08:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 08:16:17 INFO - mozversion application_buildid: 20170214065344 08:16:17 INFO - mozversion application_changeset: 006d94b8192c1a1ff9d3d9746a48c51f0a570a2b 08:16:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:16:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:17 INFO - mozversion application_name: Firefox 08:16:17 INFO - mozversion application_remotingname: firefox-dev 08:16:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:17 INFO - mozversion application_vendor: Mozilla 08:16:17 INFO - mozversion application_version: 53.0a2 08:16:17 INFO - mozversion platform_buildid: 20170214065344 08:16:17 INFO - mozversion platform_changeset: 006d94b8192c1a1ff9d3d9746a48c51f0a570a2b 08:16:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:17 INFO - mozversion platform_version: 53.0a2 08:16:17 INFO - using testdate: 1487088977 08:16:17 INFO - actual date: 1487088977 08:16:17 INFO - starting webserver on 'localhost:49307' 08:16:17 INFO - SUITE-START | Running 2 tests 08:16:17 INFO - TEST-START | dromaeo_css 08:16:17 INFO - operating with platform_type : mac_ 08:16:17 INFO - Initialising browser for dromaeo_css test... 08:16:17 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpW02E5l/profile http://localhost:49307/getInfo.html) 08:16:19 INFO - PROCESS | 1979 | __metrics Screen width/height:1600/1200 08:16:19 INFO - PROCESS | 1979 | colorDepth:24 08:16:19 INFO - PROCESS | 1979 | Browser inner width/height: 1024/689 08:16:19 INFO - PROCESS | 1979 | __metrics 08:16:19 INFO - PROCESS | 1979 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:16:19 INFO - PROCESS | 1979 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:20 INFO - TEST-INFO | 1979: exit 0 08:16:20 INFO - Browser initialized. 08:16:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:20 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpW02E5l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:32 INFO - PROCESS | 1983 | RSS: Main: 213843968 08:16:32 INFO - PROCESS | 1983 | 08:19:35 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49307/tests/dromaeo/cssquery-ext.html) 08:19:38 INFO - PROCESS | 1983 | RSS: Main: 481832960 08:19:38 INFO - PROCESS | 1983 | 08:21:22 INFO - PROCESS | 1983 | ************************* 08:21:22 INFO - PROCESS | 1983 | A coding exception was thrown and uncaught in a Task. 08:21:22 INFO - PROCESS | 1983 | 08:21:22 ERROR - PROCESS | 1983 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:21:22 INFO - PROCESS | 1983 | Full stack: 08:21:22 INFO - PROCESS | 1983 | ************************* 08:22:41 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-ext.html (next: http://localhost:49307/tests/dromaeo/cssquery-jquery.html) 08:22:42 INFO - PROCESS | 1983 | RSS: Main: 349425664 08:22:42 INFO - PROCESS | 1983 | 08:25:44 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49307/tests/dromaeo/cssquery-mootools.html) 08:25:45 INFO - PROCESS | 1983 | RSS: Main: 336068608 08:25:45 INFO - PROCESS | 1983 | 08:28:47 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49307/tests/dromaeo/cssquery-prototype.html) 08:28:48 INFO - PROCESS | 1983 | RSS: Main: 338436096 08:28:48 INFO - PROCESS | 1983 | 08:31:51 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49307/tests/dromaeo/cssquery-yui.html) 08:31:52 INFO - PROCESS | 1983 | RSS: Main: 315019264 08:31:52 INFO - PROCESS | 1983 | 08:34:55 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-yui.html (next: http://localhost:49307/tests/dromaeo/cssquery-dojo.html) 08:34:56 INFO - PROCESS | 1983 | RSS: Main: 459481088 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | __start_tp_report 08:34:56 INFO - PROCESS | 1983 | _x_x_mozilla_page_load 08:34:56 INFO - PROCESS | 1983 | _x_x_mozilla_page_load_details 08:34:56 INFO - PROCESS | 1983 | |i|pagename|runs| 08:34:56 INFO - PROCESS | 1983 | |0;dojo.html;3221.5489831423597;3239.8218098004613;3255.300110476247;3266.608007039156;3316.5191047298144;5501.449855014496;5518.392976772552;5540.473655002774;5542.251796007537;5546.944530554693;5465.72671366432;5556.361018482876;5562.610617256793;5593.356763972144;5619.522340601044;5033.874153146182;5067.949320506785;5076.492350764913;5130.07658621448;5204.089284375238;4425.760786979635;4963.851084467454;4966.354373931384;4981.452040275567;5079.085764562377;4888.437829649582;4991.600671946236;5065.265536497206;5065.4174769901565;5071.163258062434;5068.1130802109665;5095.006473737622;5096.898062038776;5109.923351149717;5139.383274007106;4816.349792777965;5041.243813427978;5076.568491678212;5079.644424890259;5083.669561478529;4729.645276604234;5420.810271640513;5430.185472179165;5438.265834112383;5536.806211782568;6079.148919151322;6097.7865774697675;6099.512039036911;6108.4409807303255;6110.406879924458;6089.969550152221;6143.32423433422;6146.231721034871;6171.938280617182;6189.752409903598;5429.945700542944;5520.227168196456;5549;5629.80295689653;5653.462921022538;6111.53932221086;6114.844865410725;6122.510199184055;6180.907286390708;6203.844903877349;5782.306123265151;5797.797077102281;5805.680687562224;5812.418758124239;5831.650100993954;5797;5942.494887934487;5992.550558708114;5997.160397544348;6008.819735407945;5754.827355179267;5825.0679891217205;5936.050231962865;5957.910631340446;6011.09833524966;6059.787907423219;6063.029915213545;6070.605410648382;6094.878102437927;6109.816705498843;4842.757862106881;4848.200046992278;4856.150173719585;4857.927131093036;4905.950940490549;4164.500259968823;4257.042165512735;4269.210196113667;4327.026419055687;4341.261985462415;5532.474414930575;5532.972335138298;5533.972330138324;5535.612507124462;5547.11246200606;6007.36922623127;6015.218021657157;6047.12316714074;6049.939500605025;6068.393160683896;5558.722063896789;5599.7480113394995;5609.074502707008;5622.522085622768;5634;5272.156454967264;5287.947120528823;5288.68267903927;5291.074062039128;5294.391145018372;5868.23712917318;5913.763449462145;6232.875342493125;6258.655773932386;6260.467860231749;5642.774289028393;5762.971185144215;5772.509336706259;5781.103928891029;5793.710314484343;5997.100434934795;6004.909926351021;6005.579609427298;6015.4586087252355;6022.7289771959495;5696.715164241854;5699.487046165865;5699.658020518782;5713.342965559014;5717.142428635738;5768.105943578752;5771.9134212986;5775.104858746901;5776.42235776419;5777.62445441045;5654.6324488908085;5776.364599893925;5830.125481177857;5890.9116363253725;5896.498797602252;5793.15999180125;5915.674637894957;5920.496757775637;5927.851803704942;5954.523638109027;5778.959787238337;5785.103308987113;5788.942110578841;5789.247397838254;5813.360530341574;5691.26013618227;5772.797952071657;5775.826725198251;5930.169776231245;5932.199153114274;5672.347680016851;5720.971395142998;5750.913736293875;5782.566307527037;5802.5357971361345 08:34:56 INFO - PROCESS | 1983 | |1;ext.html;484.03435146881975;487.65132929955075;497.43541080873206;508.9845757713361;512.9051125541773;34370.31259374811;41342.75971720849;41598.79200603993;42015.159696806084;44677.553224467745;42860.142797144115;43454.78272608641;43525.564744352625;43558.12883742323;43617.90955226113;8430.072692003874;8638.395312328139;9307.208887244575;9516.667666526691;9582.329236953381;11157.609483668073;11459.541618335257;11522.65432037036;11659.067274618053;11670.35813030283;11404.54381824726;11448.141389395787;11452.255603385795;11460.656180314603;11462;8422.410431269813;8609.48343099416;11165.553377864875;11373.772524549504;11453.083753299758;11169.776604467865;11400.657980260605;11410.258333208314;11412.144089193343;11414.71463213418;40029.99925001869;40285.59714402848;40375;40407.7979610103;40504.987375315555;3868.2843673920415;3992.540857801361;3997.8200980955926;3999.440078389028;4089.3661482469965;26982.920683172648;29160.56259156114;29333.853330733422;30330.54504182439;31041.37917241665;3028.439738648357;3163.7943533670236;3170.524421336795;3194.073718621597;3256.2998955224502;471729;480994;481319;481641.9999999965;482258;63057;63471.73056538843;63603.6819815898;63621.68189159025;63770;50529.494705053214;60649;61325.38674613197;61412.38587614156;61425.07862382068;16270.674586508203;16722.581935451468;16809.91595042017;16823.990560566406;16838.663226735396;11484.138689598314;11782.116341274439;11799.469023893946;12878.9356053221;12908.612741617766;19825;20369.490762730755;20730.792692073188;20738.896305518378;20853.37439876776;7149.60677162761;7300.488965772345;8650.221480066824;8652.307815374756;8665.913340866637;891.4428482198626;891.9643214271487;895.1585509620935;914.7621618379136;924.8520236762221;25447.74552254491;30077.783931306818;30187.245318866764;30319.393612127635;30791.692083078884;1056.7939251845817;1086.6685660873352;1093.6445655162104;1098.9725256868642;1182.3024415594841;15297.311620977083;15667.216639168224;15754.842451575567;15764.842351576337;15817.686400792667;646246;650802;651680;651832;653031;61034.694826525585;61266;61309.693451532454;61407.771844562856;61635.76728465406;1432.2838580709645;1447.0594113825887;1449.2319370368346;1452.716720239543;1453.3169410377106;24639.876800615883;28133.43733125367;29139.854300728362;29140.854295729234;29754.553681695226;50954;51647.225291621406;52190.73904630452;52239.21641175461;52303.476965229864;544988;547713;548372;548668;548913;42164.78917605515;42676.78661606672;43605.56394436015;43607;43813.78093109514;46733.29900051434;47941;47970.04059918852;48193.75903120462;48252.5174748248;37985.43021854619;38707.03232419212;38808.22383552256;40035;40222.99442513961;38360.84917452481;38381.6161838378;38471.230575388894;39782.80108599438;39900.401493977035;34761.82619086889;37462.62537374591;37974;38080;38217.044573885876;30418;31979.36041279208;32441;32557;32589.348213035133;24121.638175427735;24130.51738965246;24384.63423048691;24712.752872471046;24874 08:34:56 INFO - PROCESS | 1983 | |2;jquery.html;327.5414419812261;398.92021595680853;401.98191081401336;409.93236116040845;430.0624638288532;15128;15205.695886082272;17769.20038598263;20622.278220262295;21123.683144752842;21074.473138171554;21283.361499155013;21427.892860535674;21600.81195534245;21755.456113597167;5592.4407559244155;5745.942540574582;5838.678872662002;5842.123681447774;5994.910076348859;3855.20968201518;5148.716820574867;6086.391360863922;6090;6093.329733729286;4048.696347773914;5321.866953326178;6560.1143845580955;6612.867742645144;6659.400653941144;6424.5502814802985;6632.568883022588;6646.667666616674;6657.633830139341;6666.966665166691;5971.462568368825;5981.342052374235;5982.7906023289415;5987.43119403656;5991.610545314584;9575.760605984837;13127;13143.211407315592;13318.600441986757;13323.067385283033;2567.6020216866414;2611.673540807399;2655.1768951624863;2659.6143559184;2689.623452716621;9894.802103957953;9983.101520863158;10076.546555405024;10188;10353;1783.4649605118414;1809.3576780243088;1830.094103418803;1836.1920754867815;1858.8141185881439;112067.87932120738;140631;142500;149560.2521987383;150235;9888.208943284664;10436.425996570262;10593.735156621146;11828.585999489977;12136.635900922987;12756.234625922474;12794.68013299675;12826.102172847997;12890.226586404846;12905.935470322776;8242.711505097293;8282;8335.416520843604;8379.413441059067;8380.036295825936;8532.658693652184;8546.61540230691;8554.486730796172;8677.869831952527;8688.652453901774;3428.7428442866885;4011.13760541485;4056.918861622751;4135.214309281287;4136.028033412145;1789.337944960373;2047.9692804607944;2055.794420557962;2056.3316922000113;2059.083707750067;847.7795773099039;860.5568132411813;927.8654595083675;936.2743873498093;974.8294048541477;17799.644007119787;20010.29963951255;20255.041370834977;20276.695849562268;21028.684569731467;934.8270569944582;936.3632729743839;942.217959093964;958.0993865766158;963.4652767713986;10226.28416010872;10920;10940.726481838017;10947.83578246327;10963.122950163968;756602;769016;773717;783842;786499;133667;138137;140203;150515;160382;1012.9392236465835;1049.1397054415459;1063.1919740996898;1068.6580294305902;1072.2976450424985;18799.342023029127;18899.716504252174;19788.40634780959;20167.09248083869;20217.191312347928;51550.74224628853;57097.14354284772;60336.69831650814;60891.39108608857;60958.695206523684;90959;91996.54001729949;92491.53754231185;93244.53377733068;93983;8134.389920756085;8313.334933205208;8406.1173576776;8543.829123417621;8652.22130008277;11594.88405115938;12887.42006609686;12952.935235323763;13290.734185316047;13399.598012059654;9252.398594091363;9526.761830954005;11106.777864442827;11297.661070167907;11478.88521114778;11107.333559986426;11455.369954652575;11539.249948753304;11561.710957226136;11568.595099171489;11314.434278285888;11393.943030284796;11579.421028948687;11793.823092653445;11839.82240266414;8159.551224682462;8191.098979112412;8325.375596830141;8454.1123182065;8618.870716939125;8301.377396695152;8307.543085130375;10917.399543024892;11607.477663505331;11718.179727419 08:34:56 INFO - PROCESS | 1983 | |3;mootools.html;1423.6440889777555;1429.0639631041665;1445.40738297298;1451.9346629401675;1451.9491817786377;7911.881321780171;8336.249737523622;8343.415960882732;8344.833103337929;8366.623501942428;7117.857642847153;7431.182569917319;7432.145303290124;7878.172791856859;8143.592820358988;2203.3830527452337;2240.932772016842;2241.652543855705;2247.0899285789283;2249.4151520604596;2212.1483228956886;2243.663450482424;2248.067052173354;2255.379770563092;2256.9210077647285;1977.1399441243104;2057.77364489906;2136.2523116909033;2263.513344630904;2292.1748170658548;2170.6201414752436;2190.047329411711;2191.627423338028;2196.2971849008322;2198.1756841184556;2127.3086246969797;2175.9020844062056;2190.791874771894;2304.4354133237466;2309.0763694522325;8209.507429554245;8270.503769773833;8278.503289802631;8282.58587070644;8327.167283271685;4424.7123936944;4544.15933052383;4889.8777530561665;5129.410117836422;5139.794408223666;3197.2006998250436;3321.1697075731067;3347.6150242722156;3377.172592714776;3414.4024795660907;1119.4717368245467;1145.083932853722;1168.6201984355034;1187.3766272706812;1192.2071822238202;10552.208584356204;10568.313059651098;10572.207084468619;10577.999999999924;10586.629467968662;3864.903377415531;3912;4509.7970591323465;4547.5679810418615;4560.657950653715;9420.481873497023;9433.76415589602;9447.385919915321;9451.858222126673;9455.479948602893;4670.738900496847;4922.310876477296;5129.435762066169;5136.9743151284;5149.304843846033;4140.0270936329935;4158.792060397029;4277.807498662568;4550.567696068868;4596.563326483979;3768.453574231721;3792.4500947362476;3855.132595166065;3885.0481631999774;3888.7083468739957;1263.6145975477384;1275.101053757099;1277.7955527115616;1287.2340957130493;1288.8131220972907;765.7511308824654;851.29342645604;900.4372267332917;902.3953950852945;923.9953800231091;5425.240466334716;5446.645968012067;5498.5876059295715;5636.661800291914;5710.65736055838;949.3971328206638;961.6297725375781;1005.7076656496367;1015.5480811039017;1024.5799222318963;3460.671236232554;3532.2229109595846;3643.544556930384;3719.123784420663;3861.2084522673345;8618.267447266928;9496.053309071624;9567.856482152773;9569.330146889652;9571.138597526256;9495.955444901056;9505.429674219431;9506.334556580972;9527.142557169887;9545.284103692251;7318.231585683427;7567.508111972704;7661.885071723928;7684.923150768533;7741.5742134183165;5565.638233514808;5626.887462250814;5699.487046165865;5775.797847075332;5811.82564523065;8684.175003374668;8906.332025098014;9018.503982281038;9035.909640903506;9220.170184683142;7726.9227307726205;9127;9255.907440925774;9268.668972553152;9361.157495825408;6389.137466441971;6599.901001485077;6612.966935165294;7048.118985126859;7208.639568021683;7464.925350746423;7789.298963093349;7792.220777922163;7866.646000929857;7888.053433587776;6922.723091076502;7014.298570142945;7036.226015138228;7045.964770176116;7161.319674630901;6852.177738671391;6968.477364197807;6990.685419156252;7032.156141263081;7049.048378468841;6313.305536391085;6320.936790632219;6382.425581697669;6394.26465956421;6394.904076438764;4915.508449155056;4938.259261110862;4979.103761322852;5003.199488081889;5016;4927.1377508935075;4937;4979.253112033224;5099.158638824552;5104.336436263262 08:34:56 INFO - PROCESS | 1983 | |4;prototype.html;352.91706448984485;353.38510990875886;363.7017645530664;372.87392075930705;376.94157405602107;4858.538438848313;5163.81926632568;5175.999999999995;5215.2698622192875;5329.173978033401;4653.302004699297;5161.083987547043;5167.054778776099;5289.86775330616;5298.894022119555;3831.63599458051;3954.624310690494;4123.752574845519;4144;4214.241436541429;3634.7460126256533;3722.5346831646043;4058.127502586943;4070.694697897655;4129.772862492577;3777.054816769366;4071.8982025449454;4088.3458646616546;4093.304138296482;4126.174765047002;3444.603870554881;3772.07584141887;4080.9387859182134;4112.732672376301;4157.23317590023;3121.7044926355534;3218.6159951220966;3401.234722187513;3658.664587425597;3675.9081022974374;4184.961512140799;4916.655834091615;5020.523050310215;5039.21892106724;5041.546260836542;3785.9242815143816;4301.247201790825;4464.308032255006;4471.441069866267;4507.887302817423;4682.719036857766;4985.401751789772;5166.147585648364;5452;5526.778928842841;3749.643783840531;3801.1067399161175;3801.3347664158937;3801.752886062397;3806.7525610835482;5292.629515933886;5553.444655534455;5688.9715551422805;5692.203091567184;5779.9422005779825;3350.5141754445467;3693.9815300923324;3729.5524537055726;3730.291244663505;3744.831482583236;3233.1270556949494;3653;3812.84748610058;3823.311803875329;3865.304245235828;3783.3000894834545;3925.783007267699;4329.28566786483;4486.730796152176;4546.88632784183;4658.464276608166;4797;5432.130859062531;5437.395968189394;5486.341639003345;1056.587930707025;1080.810858099845;1221.558560898131;1255.2593969557822;1276.7296539942631;811.3063330852036;854.2055888024197;862.2670729879552;872.9738107856774;874.4958671085723;4288.7855607220135;4727.763611819464;4963.801447942042;4966.528179822911;4985.45450910219;4799.776057105416;4876.756162191876;5139.331886854685;5166.870828229325;5365.865853353619;3960.7821569813937;4292.227399068135;4979.601631869442;5006.249062640561;5018.322526458881;2597.908878271093;2634.2755742171057;2822.8165169263934;2882;2905.273681579605;4137.234611596864;5117.616178786606;5120;5371.6239863209985;5741.827745167651;5251.973740131275;5262.684238945675;5581.748821303051;5629.634073785191;5667.149927510906;5133.948660513422;5260.606424077036;5372.033034053908;5671;5734.913976290276;4675.509071547439;4770.996181603666;5061.6962982221185;5101.29631295414;5286.440500052417;4075.816588253595;4539.72761634303;4915.901681966412;5196.142636464941;5327.09439395296;4687.812487500461;5136.844210052708;5289.894202115859;5436.891262174813;5708.5147762439;3393.0838673558496;3552.6552475366134;3563.3051554946537;3863.0728625130328;3981.3828856527284;4550.067236216501;5551.861203469945;5562.554995600423;5572.219889215432;5656.37779844225;4790.377250957354;5142.8971420572125;5217.747740542167;5393.919091213556;5488.615796894179;4654.743989080498;5429.520645467426;5514;5538.833834984957;5754.625949313281;5306.771156114519;5341.172118321666;5397.299850547065;5397.460253974571;5497.532709719719;4663.152898858388;4716;5290.968261189031;5357.705326207096;5407.351117865881;4475.471358682334;5202.479752024768;5319.489137169604;5372.555487253212;5380.3274590676165 08:34:56 INFO - PROCESS | 1983 | |5;yui.html;688.2394953576298;720.099875156055;787.6416230615067;824.233462879522;824.7649419915325;13886.722265554683;14634.560963171109;14986.775198372034;15494.922525387357;15606.609834754137;14152.929235353835;14292.928535357334;14315.069520481162;14346.497872574462;14393.712125757505;667.1860330396908;687.4191308344441;845.733593917917;846.3821410370433;873.1486800369652;854.940154189207;857.9699710510133;864.1444969480201;865.2645251536206;870.1907226279558;916.221211969827;917.7889085510336;918.0635751533432;922.2069020642242;924.8936372317169;695.9965200173966;713.2582114600809;908.604756930734;909.7134402663173;913.7167478081816;667.6995352091578;683.2484267305973;688.6006116452496;691.1878542712293;692.4045321023915;14526.854731452657;14572.198529080897;14580.052296600794;14583.416663333453;14585.562433127023;13080.542181023618;13154.736905261936;13203.207807531482;13210.273434961073;13214.405351759098;11782.705432364173;11810.645680629596;11841.644750657408;12082.214656047418;12346.320952347618;4344.869653910388;4444.755538445384;4474.642028637733;4497.527759585262;4548.7725613719185;88700;90090;94235;96318;97028;9022.503762293005;10434.321769084985;10582.735431614272;10726.463676816127;11161.441927903572;20329.593408131754;20674.58650826975;20695.896520517603;20758.58482830335;20812.687809682866;6843.213030501456;7270.272972702794;7447.478676492702;7480.438967077491;7535.886961695579;4202.516710578261;4246.554111818276;4288.24955632763;4307.396964424983;4315.374270730789;3338.7829791063987;3451.050960985749;3453.2748122894473;3453.395655760232;3460.567429071366;630.3570358234575;633.8763941031547;638.4222278837659;644.4779728419995;647.1910112359551;578.8842231553622;625.9296602809156;632.34552238433;638.4636904999822;647.8056583025074;9058.230050445654;9256.305777066747;9424.387414818015;9840.557174927146;9883;572.2960758267271;573.1116769008021;588.4821357205632;592.8695686948864;682.436989483678;4327.415798867176;4542.31865220213;4768.9523104768505;4990.476000019946;4997.675151115166;73971.26028739751;88381;91858.54070729738;95938;98796.01203987868;82589;85774;89580.7604809885;91410;91622.54188729014;77345;78681;79945.80081298786;80204;80386.5980670093;10524.491109900571;10802.243842930919;10878.45607719595;11023.944880275547;11080;48025.75987120042;49589.76025599389;49962.50037499724;51471;51472.48527514827;49271;67065.9940100889;69040.30959690339;69363.95954060592;70274.94587581293;12460.875391246334;12506.93580072888;12581.8535926151;12643.747125057263;12816.87183128194;13429;13440.513192258439;14097.718045638825;14185.645358866112;14355.928220358832;12097.153199275966;13071.542496012595;13376.264305463294;13518.25649589282;13689.589312320646;10309.896901030894;12937.54718584845;13086.738265234833;13286.53497127596;13382.464701412224;12068.75862482763;12339.75320493603;13087.41106650222;13121.147125437197;13255.270960096901;9879.901200987899;10097.737782777152;10704.625338113128;11123.169286830658;11391.772164556829;11019.614313498989;11161.553537858395;11182.32906025641;11267.605633802777;11331.093512519143 08:34:56 INFO - PROCESS | 1983 | __end_tp_report 08:34:56 INFO - PROCESS | 1983 | __start_cc_report 08:34:56 INFO - PROCESS | 1983 | _x_x_mozilla_cycle_collect,3228 08:34:56 INFO - PROCESS | 1983 | __end_cc_report 08:34:56 INFO - PROCESS | 1983 | __startTimestamp1487090096121__endTimestamp 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | ------- Summary: start ------- 08:34:56 INFO - PROCESS | 1983 | Number of tests: 6 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | [#0] dojo.html Cycles:165 Average:5529.69 Median:5713.34 stddev:604.98 (10.6%) stddev-sans-first:579.11 08:34:56 INFO - PROCESS | 1983 | Values: 3221.5 3239.8 3255.3 3266.6 3316.5 5501.4 5518.4 5540.5 5542.3 5546.9 5465.7 5556.4 5562.6 5593.4 5619.5 5033.9 5067.9 5076.5 5130.1 5204.1 4425.8 4963.9 4966.4 4981.5 5079.1 4888.4 4991.6 5065.3 5065.4 5071.2 5068.1 5095.0 5096.9 5109.9 5139.4 4816.3 5041.2 5076.6 5079.6 5083.7 4729.6 5420.8 5430.2 5438.3 5536.8 6079.1 6097.8 6099.5 6108.4 6110.4 6090.0 6143.3 6146.2 6171.9 6189.8 5429.9 5520.2 5549.0 5629.8 5653.5 6111.5 6114.8 6122.5 6180.9 6203.8 5782.3 5797.8 5805.7 5812.4 5831.7 5797.0 5942.5 5992.6 5997.2 6008.8 5754.8 5825.1 5936.1 5957.9 6011.1 6059.8 6063.0 6070.6 6094.9 6109.8 4842.8 4848.2 4856.2 4857.9 4906.0 4164.5 4257.0 4269.2 4327.0 4341.3 5532.5 5533.0 5534.0 5535.6 5547.1 6007.4 6015.2 6047.1 6049.9 6068.4 5558.7 5599.7 5609.1 5622.5 5634.0 5272.2 5287.9 5288.7 5291.1 5294.4 5868.2 5913.8 6232.9 6258.7 6260.5 5642.8 5763.0 5772.5 5781.1 5793.7 5997.1 6004.9 6005.6 6015.5 6022.7 5696.7 5699.5 5699.7 5713.3 5717.1 5768.1 5771.9 5775.1 5776.4 5777.6 5654.6 5776.4 5830.1 5890.9 5896.5 5793.2 5915.7 5920.5 5927.9 5954.5 5779.0 5785.1 5788.9 5789.2 5813.4 5691.3 5772.8 5775.8 5930.2 5932.2 5672.3 5721.0 5750.9 5782.6 5802.5 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | [#1] ext.html Cycles:180 Average:70164.16 Median:39295.51 stddev:150412.72 (382.8%) stddev-sans-first:150743.68 08:34:56 INFO - PROCESS | 1983 | Values: 484.0 487.7 497.4 509.0 512.9 34370.3 41342.8 41598.8 42015.2 44677.6 42860.1 43454.8 43525.6 43558.1 43617.9 8430.1 8638.4 9307.2 9516.7 9582.3 11157.6 11459.5 11522.7 11659.1 11670.4 11404.5 11448.1 11452.3 11460.7 11462.0 8422.4 8609.5 11165.6 11373.8 11453.1 11169.8 11400.7 11410.3 11412.1 11414.7 40030.0 40285.6 40375.0 40407.8 40505.0 3868.3 3992.5 3997.8 3999.4 4089.4 26982.9 29160.6 29333.9 30330.5 31041.4 3028.4 3163.8 3170.5 3194.1 3256.3 471729.0 480994.0 481319.0 481642.0 482258.0 63057.0 63471.7 63603.7 63621.7 63770.0 50529.5 60649.0 61325.4 61412.4 61425.1 16270.7 16722.6 16809.9 16824.0 16838.7 11484.1 11782.1 11799.5 12878.9 12908.6 19825.0 20369.5 20730.8 20738.9 20853.4 7149.6 7300.5 8650.2 8652.3 8665.9 891.4 892.0 895.2 914.8 924.9 25447.7 30077.8 30187.2 30319.4 30791.7 1056.8 1086.7 1093.6 1099.0 1182.3 15297.3 15667.2 15754.8 15764.8 15817.7 646246.0 650802.0 651680.0 651832.0 653031.0 61034.7 61266.0 61309.7 61407.8 61635.8 1432.3 1447.1 1449.2 1452.7 1453.3 24639.9 28133.4 29139.9 29140.9 29754.6 50954.0 51647.2 52190.7 52239.2 52303.5 544988.0 547713.0 548372.0 548668.0 548913.0 42164.8 42676.8 43605.6 43607.0 43813.8 46733.3 47941.0 47970.0 48193.8 48252.5 37985.4 38707.0 38808.2 40035.0 40223.0 38360.8 38381.6 38471.2 39782.8 39900.4 34761.8 37462.6 37974.0 38080.0 38217.0 30418.0 31979.4 32441.0 32557.0 32589.3 24121.6 24130.5 24384.6 24712.8 24874.0 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | [#2] jquery.html Cycles:180 Average:41053.31 Median:2674.62 stddev:128839.49 (4817.1%) stddev-sans-first:129164.62 08:34:56 INFO - PROCESS | 1983 | Values: 327.5 398.9 402.0 409.9 430.1 15128.0 15205.7 17769.2 20622.3 21123.7 21074.5 21283.4 21427.9 21600.8 21755.5 5592.4 5745.9 5838.7 5842.1 5994.9 3855.2 5148.7 6086.4 6090.0 6093.3 4048.7 5321.9 6560.1 6612.9 6659.4 6424.6 6632.6 6646.7 6657.6 6667.0 5971.5 5981.3 5982.8 5987.4 5991.6 9575.8 13127.0 13143.2 13318.6 13323.1 2567.6 2611.7 2655.2 2659.6 2689.6 9894.8 9983.1 10076.5 10188.0 10353.0 1783.5 1809.4 1830.1 1836.2 1858.8 112067.9 140631.0 142500.0 149560.3 150235.0 9888.2 10436.4 10593.7 11828.6 12136.6 12756.2 12794.7 12826.1 12890.2 12905.9 8242.7 8282.0 8335.4 8379.4 8380.0 8532.7 8546.6 8554.5 8677.9 8688.7 3428.7 4011.1 4056.9 4135.2 4136.0 1789.3 2048.0 2055.8 2056.3 2059.1 847.8 860.6 927.9 936.3 974.8 17799.6 20010.3 20255.0 20276.7 21028.7 934.8 936.4 942.2 958.1 963.5 10226.3 10920.0 10940.7 10947.8 10963.1 756602.0 769016.0 773717.0 783842.0 786499.0 133667.0 138137.0 140203.0 150515.0 160382.0 1012.9 1049.1 1063.2 1068.7 1072.3 18799.3 18899.7 19788.4 20167.1 20217.2 51550.7 57097.1 60336.7 60891.4 60958.7 90959.0 91996.5 92491.5 93244.5 93983.0 8134.4 8313.3 8406.1 8543.8 8652.2 11594.9 12887.4 12952.9 13290.7 13399.6 9252.4 9526.8 11106.8 11297.7 11478.9 11107.3 11455.4 11539.2 11561.7 11568.6 11314.4 11393.9 11579.4 11793.8 11839.8 8159.6 8191.1 8325.4 8454.1 8618.9 8301.4 8307.5 10917.4 11607.5 11718.2 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | [#3] mootools.html Cycles:180 Average:5297.58 Median:5138.38 stddev:2876.62 (56.0%) stddev-sans-first:2869.96 08:34:56 INFO - PROCESS | 1983 | Values: 1423.6 1429.1 1445.4 1451.9 1451.9 7911.9 8336.2 8343.4 8344.8 8366.6 7117.9 7431.2 7432.1 7878.2 8143.6 2203.4 2240.9 2241.7 2247.1 2249.4 2212.1 2243.7 2248.1 2255.4 2256.9 1977.1 2057.8 2136.3 2263.5 2292.2 2170.6 2190.0 2191.6 2196.3 2198.2 2127.3 2175.9 2190.8 2304.4 2309.1 8209.5 8270.5 8278.5 8282.6 8327.2 4424.7 4544.2 4889.9 5129.4 5139.8 3197.2 3321.2 3347.6 3377.2 3414.4 1119.5 1145.1 1168.6 1187.4 1192.2 10552.2 10568.3 10572.2 10578.0 10586.6 3864.9 3912.0 4509.8 4547.6 4560.7 9420.5 9433.8 9447.4 9451.9 9455.5 4670.7 4922.3 5129.4 5137.0 5149.3 4140.0 4158.8 4277.8 4550.6 4596.6 3768.5 3792.5 3855.1 3885.0 3888.7 1263.6 1275.1 1277.8 1287.2 1288.8 765.8 851.3 900.4 902.4 924.0 5425.2 5446.6 5498.6 5636.7 5710.7 949.4 961.6 1005.7 1015.5 1024.6 3460.7 3532.2 3643.5 3719.1 3861.2 8618.3 9496.1 9567.9 9569.3 9571.1 9496.0 9505.4 9506.3 9527.1 9545.3 7318.2 7567.5 7661.9 7684.9 7741.6 5565.6 5626.9 5699.5 5775.8 5811.8 8684.2 8906.3 9018.5 9035.9 9220.2 7726.9 9127.0 9255.9 9268.7 9361.2 6389.1 6599.9 6613.0 7048.1 7208.6 7464.9 7789.3 7792.2 7866.6 7888.1 6922.7 7014.3 7036.2 7046.0 7161.3 6852.2 6968.5 6990.7 7032.2 7049.0 6313.3 6320.9 6382.4 6394.3 6394.9 4915.5 4938.3 4979.1 5003.2 5016.0 4927.1 4937.0 4979.3 5099.2 5104.3 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | [#4] prototype.html Cycles:180 Average:4333.12 Median:4798.39 stddev:1306.73 (27.2%) stddev-sans-first:1275.79 08:34:56 INFO - PROCESS | 1983 | Values: 352.9 353.4 363.7 372.9 376.9 4858.5 5163.8 5176.0 5215.3 5329.2 4653.3 5161.1 5167.1 5289.9 5298.9 3831.6 3954.6 4123.8 4144.0 4214.2 3634.7 3722.5 4058.1 4070.7 4129.8 3777.1 4071.9 4088.3 4093.3 4126.2 3444.6 3772.1 4080.9 4112.7 4157.2 3121.7 3218.6 3401.2 3658.7 3675.9 4185.0 4916.7 5020.5 5039.2 5041.5 3785.9 4301.2 4464.3 4471.4 4507.9 4682.7 4985.4 5166.1 5452.0 5526.8 3749.6 3801.1 3801.3 3801.8 3806.8 5292.6 5553.4 5689.0 5692.2 5779.9 3350.5 3694.0 3729.6 3730.3 3744.8 3233.1 3653.0 3812.8 3823.3 3865.3 3783.3 3925.8 4329.3 4486.7 4546.9 4658.5 4797.0 5432.1 5437.4 5486.3 1056.6 1080.8 1221.6 1255.3 1276.7 811.3 854.2 862.3 873.0 874.5 4288.8 4727.8 4963.8 4966.5 4985.5 4799.8 4876.8 5139.3 5166.9 5365.9 3960.8 4292.2 4979.6 5006.2 5018.3 2597.9 2634.3 2822.8 2882.0 2905.3 4137.2 5117.6 5120.0 5371.6 5741.8 5252.0 5262.7 5581.7 5629.6 5667.1 5133.9 5260.6 5372.0 5671.0 5734.9 4675.5 4771.0 5061.7 5101.3 5286.4 4075.8 4539.7 4915.9 5196.1 5327.1 4687.8 5136.8 5289.9 5436.9 5708.5 3393.1 3552.7 3563.3 3863.1 3981.4 4550.1 5551.9 5562.6 5572.2 5656.4 4790.4 5142.9 5217.7 5393.9 5488.6 4654.7 5429.5 5514.0 5538.8 5754.6 5306.8 5341.2 5397.3 5397.5 5497.5 4663.2 4716.0 5291.0 5357.7 5407.4 4475.5 5202.5 5319.5 5372.6 5380.3 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - PROCESS | 1983 | [#5] yui.html Cycles:180 Average:19549.75 Median:26397.36 stddev:27407.12 (103.8%) stddev-sans-first:27447.41 08:34:56 INFO - PROCESS | 1983 | Values: 688.2 720.1 787.6 824.2 824.8 13886.7 14634.6 14986.8 15494.9 15606.6 14152.9 14292.9 14315.1 14346.5 14393.7 667.2 687.4 845.7 846.4 873.1 854.9 858.0 864.1 865.3 870.2 916.2 917.8 918.1 922.2 924.9 696.0 713.3 908.6 909.7 913.7 667.7 683.2 688.6 691.2 692.4 14526.9 14572.2 14580.1 14583.4 14585.6 13080.5 13154.7 13203.2 13210.3 13214.4 11782.7 11810.6 11841.6 12082.2 12346.3 4344.9 4444.8 4474.6 4497.5 4548.8 88700.0 90090.0 94235.0 96318.0 97028.0 9022.5 10434.3 10582.7 10726.5 11161.4 20329.6 20674.6 20695.9 20758.6 20812.7 6843.2 7270.3 7447.5 7480.4 7535.9 4202.5 4246.6 4288.2 4307.4 4315.4 3338.8 3451.1 3453.3 3453.4 3460.6 630.4 633.9 638.4 644.5 647.2 578.9 625.9 632.3 638.5 647.8 9058.2 9256.3 9424.4 9840.6 9883.0 572.3 573.1 588.5 592.9 682.4 4327.4 4542.3 4769.0 4990.5 4997.7 73971.3 88381.0 91858.5 95938.0 98796.0 82589.0 85774.0 89580.8 91410.0 91622.5 77345.0 78681.0 79945.8 80204.0 80386.6 10524.5 10802.2 10878.5 11023.9 11080.0 48025.8 49589.8 49962.5 51471.0 51472.5 49271.0 67066.0 69040.3 69364.0 70274.9 12460.9 12506.9 12581.9 12643.7 12816.9 13429.0 13440.5 14097.7 14185.6 14355.9 12097.2 13071.5 13376.3 13518.3 13689.6 10309.9 12937.5 13086.7 13286.5 13382.5 12068.8 12339.8 13087.4 13121.1 13255.3 9879.9 10097.7 10704.6 11123.2 11391.8 11019.6 11161.6 11182.3 11267.6 11331.1 08:34:56 INFO - PROCESS | 1983 | -------- Summary: end -------- 08:34:56 INFO - PROCESS | 1983 | 08:34:56 INFO - TEST-INFO | 1983: exit 0 08:34:56 INFO - TEST-OK | dromaeo_css | took 1119455ms 08:34:56 INFO - TEST-START | kraken 08:34:56 INFO - operating with platform_type : mac_ 08:34:56 INFO - Initialising browser for kraken test... 08:34:56 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmph6uELD/profile http://localhost:49307/getInfo.html) 08:34:59 INFO - PROCESS | 1988 | __metrics Screen width/height:1600/1200 08:34:59 INFO - PROCESS | 1988 | colorDepth:24 08:34:59 INFO - PROCESS | 1988 | Browser inner width/height: 1024/689 08:34:59 INFO - PROCESS | 1988 | __metrics 08:34:59 INFO - PROCESS | 1988 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:34:59 INFO - PROCESS | 1988 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:59 INFO - TEST-INFO | 1988: exit 0 08:34:59 INFO - Browser initialized. 08:34:59 INFO - Running cycle 1/1 for kraken test... 08:34:59 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmph6uELD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:11 INFO - PROCESS | 1989 | RSS: Main: 213692416 08:35:11 INFO - PROCESS | 1989 | 08:35:14 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:15 INFO - PROCESS | 1989 | RSS: Main: 266371072 08:35:15 INFO - PROCESS | 1989 | 08:35:18 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-dft) 08:35:18 INFO - PROCESS | 1989 | RSS: Main: 275378176 08:35:18 INFO - PROCESS | 1989 | 08:35:22 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-fft) 08:35:22 INFO - PROCESS | 1989 | RSS: Main: 373837824 08:35:22 INFO - PROCESS | 1989 | 08:35:24 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-oscillator) 08:35:25 INFO - PROCESS | 1989 | RSS: Main: 276381696 08:35:25 INFO - PROCESS | 1989 | 08:35:27 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:27 INFO - PROCESS | 1989 | RSS: Main: 277975040 08:35:27 INFO - PROCESS | 1989 | 08:35:30 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49307/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:31 INFO - PROCESS | 1989 | RSS: Main: 318001152 08:35:31 INFO - PROCESS | 1989 | 08:35:34 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49307/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:34 INFO - PROCESS | 1989 | RSS: Main: 318341120 08:35:34 INFO - PROCESS | 1989 | 08:35:37 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49307/tests/kraken/driver.html?testName=json-parse-financial) 08:35:38 INFO - PROCESS | 1989 | RSS: Main: 316076032 08:35:38 INFO - PROCESS | 1989 | 08:35:39 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:40 INFO - PROCESS | 1989 | RSS: Main: 295473152 08:35:40 INFO - PROCESS | 1989 | 08:35:42 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:43 INFO - PROCESS | 1989 | RSS: Main: 300085248 08:35:43 INFO - PROCESS | 1989 | 08:35:45 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:45 INFO - PROCESS | 1989 | RSS: Main: 301838336 08:35:45 INFO - PROCESS | 1989 | 08:35:48 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:49 INFO - PROCESS | 1989 | RSS: Main: 315265024 08:35:49 INFO - PROCESS | 1989 | 08:35:52 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:52 INFO - PROCESS | 1989 | RSS: Main: 308260864 08:35:52 INFO - PROCESS | 1989 | 08:35:54 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49307/tests/kraken/driver.html?testName=ai-astar) 08:35:55 INFO - PROCESS | 1989 | RSS: Main: 352321536 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | __start_tp_report 08:35:55 INFO - PROCESS | 1989 | _x_x_mozilla_page_load 08:35:55 INFO - PROCESS | 1989 | _x_x_mozilla_page_load_details 08:35:55 INFO - PROCESS | 1989 | |i|pagename|runs| 08:35:55 INFO - PROCESS | 1989 | |0;ai-astar;115;114;113;114;115;114;113;114;114;114 08:35:55 INFO - PROCESS | 1989 | |1;audio-beat-detection;138;110;107;141;113;92;111;131;156;139 08:35:55 INFO - PROCESS | 1989 | |2;audio-dft;181;195;260;203;183;197;256;201;182;184 08:35:55 INFO - PROCESS | 1989 | |3;audio-fft;83;59;60;88;62;59;57;58;73;57 08:35:55 INFO - PROCESS | 1989 | |4;audio-oscillator;91;70;87;71;68;69;80;67;69;82 08:35:55 INFO - PROCESS | 1989 | |5;imaging-gaussian-blur;86;83;86;83;91;130;114;84;86;83 08:35:55 INFO - PROCESS | 1989 | |6;imaging-darkroom;93;93;94;106;148;118;94;93;92;94 08:35:55 INFO - PROCESS | 1989 | |7;imaging-desaturate;84;87;85;87;84;87;87;86;90;86 08:35:55 INFO - PROCESS | 1989 | |8;json-parse-financial;56;53;53;54;58;56;56;56;56;57 08:35:55 INFO - PROCESS | 1989 | |9;json-stringify-tinderbox;68;73;76;76;74;68;70;68;69;71 08:35:55 INFO - PROCESS | 1989 | |10;stanford-crypto-aes;88;86;84;84;84;86;83;84;84;84 08:35:55 INFO - PROCESS | 1989 | |11;stanford-crypto-ccm;146;142;145;139;137;139;143;141;180;150 08:35:55 INFO - PROCESS | 1989 | |12;stanford-crypto-pbkdf2;167;170;169;195;168;174;167;168;167;166 08:35:55 INFO - PROCESS | 1989 | |13;stanford-crypto-sha256-iterative;65;67;85;83;84;83;64;65;65;63 08:35:55 INFO - PROCESS | 1989 | __end_tp_report 08:35:55 INFO - PROCESS | 1989 | __start_cc_report 08:35:55 INFO - PROCESS | 1989 | _x_x_mozilla_cycle_collect,1951 08:35:55 INFO - PROCESS | 1989 | __end_cc_report 08:35:55 INFO - PROCESS | 1989 | __startTimestamp1487090155013__endTimestamp 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | ------- Summary: start ------- 08:35:55 INFO - PROCESS | 1989 | Number of tests: 14 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 08:35:55 INFO - PROCESS | 1989 | Values: 115.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:138.50 stddev:19.95 (14.4%) stddev-sans-first:20.49 08:35:55 INFO - PROCESS | 1989 | Values: 138.0 110.0 107.0 141.0 113.0 92.0 111.0 131.0 156.0 139.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#2] audio-dft Cycles:10 Average:204.20 Median:199.00 stddev:29.50 (14.8%) stddev-sans-first:30.07 08:35:55 INFO - PROCESS | 1989 | Values: 181.0 195.0 260.0 203.0 183.0 197.0 256.0 201.0 182.0 184.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#3] audio-fft Cycles:10 Average:65.60 Median:61.00 stddev:11.53 (18.9%) stddev-sans-first:10.37 08:35:55 INFO - PROCESS | 1989 | Values: 83.0 59.0 60.0 88.0 62.0 59.0 57.0 58.0 73.0 57.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:75.50 stddev:8.81 (11.7%) stddev-sans-first:7.31 08:35:55 INFO - PROCESS | 1989 | Values: 91.0 70.0 87.0 71.0 68.0 69.0 80.0 67.0 69.0 82.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#5] imaging-gaussian-blur Cycles:10 Average:92.60 Median:85.00 stddev:16.13 (19.0%) stddev-sans-first:16.93 08:35:55 INFO - PROCESS | 1989 | Values: 86.0 83.0 86.0 83.0 91.0 130.0 114.0 84.0 86.0 83.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:93.00 stddev:18.01 (19.4%) stddev-sans-first:18.78 08:35:55 INFO - PROCESS | 1989 | Values: 93.0 93.0 94.0 106.0 148.0 118.0 94.0 93.0 92.0 94.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:87.00 stddev:1.77 (2.0%) stddev-sans-first:1.67 08:35:55 INFO - PROCESS | 1989 | Values: 84.0 87.0 85.0 87.0 84.0 87.0 87.0 86.0 90.0 86.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.65 (2.9%) stddev-sans-first:1.74 08:35:55 INFO - PROCESS | 1989 | Values: 56.0 53.0 53.0 54.0 58.0 56.0 56.0 56.0 56.0 57.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:3.23 (4.5%) stddev-sans-first:3.20 08:35:55 INFO - PROCESS | 1989 | Values: 68.0 73.0 76.0 76.0 74.0 68.0 70.0 68.0 69.0 71.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:1.49 (1.8%) stddev-sans-first:1.00 08:35:55 INFO - PROCESS | 1989 | Values: 88.0 86.0 84.0 84.0 84.0 86.0 83.0 84.0 84.0 84.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:144.00 stddev:12.48 (8.7%) stddev-sans-first:13.24 08:35:55 INFO - PROCESS | 1989 | Values: 146.0 142.0 145.0 139.0 137.0 139.0 143.0 141.0 180.0 150.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:168.50 stddev:8.70 (5.2%) stddev-sans-first:9.10 08:35:55 INFO - PROCESS | 1989 | Values: 167.0 170.0 169.0 195.0 168.0 174.0 167.0 168.0 167.0 166.0 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - PROCESS | 1989 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:75.00 stddev:9.83 (13.1%) stddev-sans-first:10.06 08:35:55 INFO - PROCESS | 1989 | Values: 65.0 67.0 85.0 83.0 84.0 83.0 64.0 65.0 65.0 63.0 08:35:55 INFO - PROCESS | 1989 | -------- Summary: end -------- 08:35:55 INFO - PROCESS | 1989 | 08:35:55 INFO - TEST-INFO | 1989: exit 0 08:35:56 INFO - TEST-OK | kraken | took 59280ms 08:35:56 INFO - SUITE-END | took 1178s 08:35:56 INFO - Completed test suite (00:19:38) 08:35:56 INFO - javascript benchmark 08:35:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3221.5489831423597, 3239.8218098004613, 3255.300110476247, 3266.608007039156, 3316.5191047298144, 5501.449855014496, 5518.392976772552, 5540.473655002774, 5542.251796007537, 5546.944530554693, 5465.72671366432, 5556.361018482876, 5562.610617256793, 5593.356763972144, 5619.522340601044, 5033.874153146182, 5067.949320506785, 5076.492350764913, 5130.07658621448, 5204.089284375238, 4425.760786979635, 4963.851084467454, 4966.354373931384, 4981.452040275567, 5079.085764562377, 4888.437829649582, 4991.600671946236, 5065.265536497206, 5065.4174769901565, 5071.163258062434, 5068.1130802109665, 5095.006473737622, 5096.898062038776, 5109.923351149717, 5139.383274007106, 4816.349792777965, 5041.243813427978, 5076.568491678212, 5079.644424890259, 5083.669561478529, 4729.645276604234, 5420.810271640513, 5430.185472179165, 5438.265834112383, 5536.806211782568, 6079.148919151322, 6097.7865774697675, 6099.512039036911, 6108.4409807303255, 6110.406879924458, 6089.969550152221, 6143.32423433422, 6146.231721034871, 6171.938280617182, 6189.752409903598, 5429.945700542944, 5520.227168196456, 5549.0, 5629.80295689653, 5653.462921022538, 6111.53932221086, 6114.844865410725, 6122.510199184055, 6180.907286390708, 6203.844903877349, 5782.306123265151, 5797.797077102281, 5805.680687562224, 5812.418758124239, 5831.650100993954, 5797.0, 5942.494887934487, 5992.550558708114, 5997.160397544348, 6008.819735407945, 5754.827355179267, 5825.0679891217205, 5936.050231962865, 5957.910631340446, 6011.09833524966, 6059.787907423219, 6063.029915213545, 6070.605410648382, 6094.878102437927, 6109.816705498843, 4842.757862106881, 4848.200046992278, 4856.150173719585, 4857.927131093036, 4905.950940490549, 4164.500259968823, 4257.042165512735, 4269.210196113667, 4327.026419055687, 4341.261985462415, 5532.474414930575, 5532.972335138298, 5533.972330138324, 5535.612507124462, 5547.11246200606, 6007.36922623127, 6015.218021657157, 6047.12316714074, 6049.939500605025, 6068.393160683896, 5558.722063896789, 5599.7480113394995, 5609.074502707008, 5622.522085622768, 5634.0, 5272.156454967264, 5287.947120528823, 5288.68267903927, 5291.074062039128, 5294.391145018372, 5868.23712917318, 5913.763449462145, 6232.875342493125, 6258.655773932386, 6260.467860231749, 5642.774289028393, 5762.971185144215, 5772.509336706259, 5781.103928891029, 5793.710314484343, 5997.100434934795, 6004.909926351021, 6005.579609427298, 6015.4586087252355, 6022.7289771959495, 5696.715164241854, 5699.487046165865, 5699.658020518782, 5713.342965559014, 5717.142428635738, 5768.105943578752, 5771.9134212986, 5775.104858746901, 5776.42235776419, 5777.62445441045, 5654.6324488908085, 5776.364599893925, 5830.125481177857, 5890.9116363253725, 5896.498797602252, 5793.15999180125, 5915.674637894957, 5920.496757775637, 5927.851803704942, 5954.523638109027, 5778.959787238337, 5785.103308987113, 5788.942110578841, 5789.247397838254, 5813.360530341574, 5691.26013618227, 5772.797952071657, 5775.826725198251, 5930.169776231245, 5932.199153114274, 5672.347680016851, 5720.971395142998, 5750.913736293875, 5782.566307527037, 5802.5357971361345], "value": 5491.2948257391545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.03435146881975, 487.65132929955075, 497.43541080873206, 508.9845757713361, 512.9051125541773, 34370.31259374811, 41342.75971720849, 41598.79200603993, 42015.159696806084, 44677.553224467745, 42860.142797144115, 43454.78272608641, 43525.564744352625, 43558.12883742323, 43617.90955226113, 8430.072692003874, 8638.395312328139, 9307.208887244575, 9516.667666526691, 9582.329236953381, 11157.609483668073, 11459.541618335257, 11522.65432037036, 11659.067274618053, 11670.35813030283, 11404.54381824726, 11448.141389395787, 11452.255603385795, 11460.656180314603, 11462.0, 8422.410431269813, 8609.48343099416, 11165.553377864875, 11373.772524549504, 11453.083753299758, 11169.776604467865, 11400.657980260605, 11410.258333208314, 11412.144089193343, 11414.71463213418, 40029.99925001869, 40285.59714402848, 40375.0, 40407.7979610103, 40504.987375315555, 3868.2843673920415, 3992.540857801361, 3997.8200980955926, 3999.440078389028, 4089.3661482469965, 26982.920683172648, 29160.56259156114, 29333.853330733422, 30330.54504182439, 31041.37917241665, 3028.439738648357, 3163.7943533670236, 3170.524421336795, 3194.073718621597, 3256.2998955224502, 471729.0, 480994.0, 481319.0, 481641.9999999965, 482258.0, 63057.0, 63471.73056538843, 63603.6819815898, 63621.68189159025, 63770.0, 50529.494705053214, 60649.0, 61325.38674613197, 61412.38587614156, 61425.07862382068, 16270.674586508203, 16722.581935451468, 16809.91595042017, 16823.990560566406, 16838.663226735396, 11484.138689598314, 11782.116341274439, 11799.469023893946, 12878.9356053221, 12908.612741617766, 19825.0, 20369.490762730755, 20730.792692073188, 20738.896305518378, 20853.37439876776, 7149.60677162761, 7300.488965772345, 8650.221480066824, 8652.307815374756, 8665.913340866637, 891.4428482198626, 891.9643214271487, 895.1585509620935, 914.7621618379136, 924.8520236762221, 25447.74552254491, 30077.783931306818, 30187.245318866764, 30319.393612127635, 30791.692083078884, 1056.7939251845817, 1086.6685660873352, 1093.6445655162104, 1098.9725256868642, 1182.3024415594841, 15297.311620977083, 15667.216639168224, 15754.842451575567, 15764.842351576337, 15817.686400792667, 646246.0, 650802.0, 651680.0, 651832.0, 653031.0, 61034.694826525585, 61266.0, 61309.693451532454, 61407.771844562856, 61635.76728465406, 1432.2838580709645, 1447.0594113825887, 1449.2319370368346, 1452.716720239543, 1453.3169410377106, 24639.876800615883, 28133.43733125367, 29139.854300728362, 29140.854295729234, 29754.553681695226, 50954.0, 51647.225291621406, 52190.73904630452, 52239.21641175461, 52303.476965229864, 544988.0, 547713.0, 548372.0, 548668.0, 548913.0, 42164.78917605515, 42676.78661606672, 43605.56394436015, 43607.0, 43813.78093109514, 46733.29900051434, 47941.0, 47970.04059918852, 48193.75903120462, 48252.5174748248, 37985.43021854619, 38707.03232419212, 38808.22383552256, 40035.0, 40222.99442513961, 38360.84917452481, 38381.6161838378, 38471.230575388894, 39782.80108599438, 39900.401493977035, 34761.82619086889, 37462.62537374591, 37974.0, 38080.0, 38217.044573885876, 30418.0, 31979.36041279208, 32441.0, 32557.0, 32589.348213035133, 24121.638175427735, 24130.51738965246, 24384.63423048691, 24712.752872471046, 24874.0], "value": 20648.56909389681, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5414419812261, 398.92021595680853, 401.98191081401336, 409.93236116040845, 430.0624638288532, 15128.0, 15205.695886082272, 17769.20038598263, 20622.278220262295, 21123.683144752842, 21074.473138171554, 21283.361499155013, 21427.892860535674, 21600.81195534245, 21755.456113597167, 5592.4407559244155, 5745.942540574582, 5838.678872662002, 5842.123681447774, 5994.910076348859, 3855.20968201518, 5148.716820574867, 6086.391360863922, 6090.0, 6093.329733729286, 4048.696347773914, 5321.866953326178, 6560.1143845580955, 6612.867742645144, 6659.400653941144, 6424.5502814802985, 6632.568883022588, 6646.667666616674, 6657.633830139341, 6666.966665166691, 5971.462568368825, 5981.342052374235, 5982.7906023289415, 5987.43119403656, 5991.610545314584, 9575.760605984837, 13127.0, 13143.211407315592, 13318.600441986757, 13323.067385283033, 2567.6020216866414, 2611.673540807399, 2655.1768951624863, 2659.6143559184, 2689.623452716621, 9894.802103957953, 9983.101520863158, 10076.546555405024, 10188.0, 10353.0, 1783.4649605118414, 1809.3576780243088, 1830.094103418803, 1836.1920754867815, 1858.8141185881439, 112067.87932120738, 140631.0, 142500.0, 149560.2521987383, 150235.0, 9888.208943284664, 10436.425996570262, 10593.735156621146, 11828.585999489977, 12136.635900922987, 12756.234625922474, 12794.68013299675, 12826.102172847997, 12890.226586404846, 12905.935470322776, 8242.711505097293, 8282.0, 8335.416520843604, 8379.413441059067, 8380.036295825936, 8532.658693652184, 8546.61540230691, 8554.486730796172, 8677.869831952527, 8688.652453901774, 3428.7428442866885, 4011.13760541485, 4056.918861622751, 4135.214309281287, 4136.028033412145, 1789.337944960373, 2047.9692804607944, 2055.794420557962, 2056.3316922000113, 2059.083707750067, 847.7795773099039, 860.5568132411813, 927.8654595083675, 936.2743873498093, 974.8294048541477, 17799.644007119787, 20010.29963951255, 20255.041370834977, 20276.695849562268, 21028.684569731467, 934.8270569944582, 936.3632729743839, 942.217959093964, 958.0993865766158, 963.4652767713986, 10226.28416010872, 10920.0, 10940.726481838017, 10947.83578246327, 10963.122950163968, 756602.0, 769016.0, 773717.0, 783842.0, 786499.0, 133667.0, 138137.0, 140203.0, 150515.0, 160382.0, 1012.9392236465835, 1049.1397054415459, 1063.1919740996898, 1068.6580294305902, 1072.2976450424985, 18799.342023029127, 18899.716504252174, 19788.40634780959, 20167.09248083869, 20217.191312347928, 51550.74224628853, 57097.14354284772, 60336.69831650814, 60891.39108608857, 60958.695206523684, 90959.0, 91996.54001729949, 92491.53754231185, 93244.53377733068, 93983.0, 8134.389920756085, 8313.334933205208, 8406.1173576776, 8543.829123417621, 8652.22130008277, 11594.88405115938, 12887.42006609686, 12952.935235323763, 13290.734185316047, 13399.598012059654, 9252.398594091363, 9526.761830954005, 11106.777864442827, 11297.661070167907, 11478.88521114778, 11107.333559986426, 11455.369954652575, 11539.249948753304, 11561.710957226136, 11568.595099171489, 11314.434278285888, 11393.943030284796, 11579.421028948687, 11793.823092653445, 11839.82240266414, 8159.551224682462, 8191.098979112412, 8325.375596830141, 8454.1123182065, 8618.870716939125, 8301.377396695152, 8307.543085130375, 10917.399543024892, 11607.477663505331, 11718.179727419], "value": 9588.465803272342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.6440889777555, 1429.0639631041665, 1445.40738297298, 1451.9346629401675, 1451.9491817786377, 7911.881321780171, 8336.249737523622, 8343.415960882732, 8344.833103337929, 8366.623501942428, 7117.857642847153, 7431.182569917319, 7432.145303290124, 7878.172791856859, 8143.592820358988, 2203.3830527452337, 2240.932772016842, 2241.652543855705, 2247.0899285789283, 2249.4151520604596, 2212.1483228956886, 2243.663450482424, 2248.067052173354, 2255.379770563092, 2256.9210077647285, 1977.1399441243104, 2057.77364489906, 2136.2523116909033, 2263.513344630904, 2292.1748170658548, 2170.6201414752436, 2190.047329411711, 2191.627423338028, 2196.2971849008322, 2198.1756841184556, 2127.3086246969797, 2175.9020844062056, 2190.791874771894, 2304.4354133237466, 2309.0763694522325, 8209.507429554245, 8270.503769773833, 8278.503289802631, 8282.58587070644, 8327.167283271685, 4424.7123936944, 4544.15933052383, 4889.8777530561665, 5129.410117836422, 5139.794408223666, 3197.2006998250436, 3321.1697075731067, 3347.6150242722156, 3377.172592714776, 3414.4024795660907, 1119.4717368245467, 1145.083932853722, 1168.6201984355034, 1187.3766272706812, 1192.2071822238202, 10552.208584356204, 10568.313059651098, 10572.207084468619, 10577.999999999924, 10586.629467968662, 3864.903377415531, 3912.0, 4509.7970591323465, 4547.5679810418615, 4560.657950653715, 9420.481873497023, 9433.76415589602, 9447.385919915321, 9451.858222126673, 9455.479948602893, 4670.738900496847, 4922.310876477296, 5129.435762066169, 5136.9743151284, 5149.304843846033, 4140.0270936329935, 4158.792060397029, 4277.807498662568, 4550.567696068868, 4596.563326483979, 3768.453574231721, 3792.4500947362476, 3855.132595166065, 3885.0481631999774, 3888.7083468739957, 1263.6145975477384, 1275.101053757099, 1277.7955527115616, 1287.2340957130493, 1288.8131220972907, 765.7511308824654, 851.29342645604, 900.4372267332917, 902.3953950852945, 923.9953800231091, 5425.240466334716, 5446.645968012067, 5498.5876059295715, 5636.661800291914, 5710.65736055838, 949.3971328206638, 961.6297725375781, 1005.7076656496367, 1015.5480811039017, 1024.5799222318963, 3460.671236232554, 3532.2229109595846, 3643.544556930384, 3719.123784420663, 3861.2084522673345, 8618.267447266928, 9496.053309071624, 9567.856482152773, 9569.330146889652, 9571.138597526256, 9495.955444901056, 9505.429674219431, 9506.334556580972, 9527.142557169887, 9545.284103692251, 7318.231585683427, 7567.508111972704, 7661.885071723928, 7684.923150768533, 7741.5742134183165, 5565.638233514808, 5626.887462250814, 5699.487046165865, 5775.797847075332, 5811.82564523065, 8684.175003374668, 8906.332025098014, 9018.503982281038, 9035.909640903506, 9220.170184683142, 7726.9227307726205, 9127.0, 9255.907440925774, 9268.668972553152, 9361.157495825408, 6389.137466441971, 6599.901001485077, 6612.966935165294, 7048.118985126859, 7208.639568021683, 7464.925350746423, 7789.298963093349, 7792.220777922163, 7866.646000929857, 7888.053433587776, 6922.723091076502, 7014.298570142945, 7036.226015138228, 7045.964770176116, 7161.319674630901, 6852.177738671391, 6968.477364197807, 6990.685419156252, 7032.156141263081, 7049.048378468841, 6313.305536391085, 6320.936790632219, 6382.425581697669, 6394.26465956421, 6394.904076438764, 4915.508449155056, 4938.259261110862, 4979.103761322852, 5003.199488081889, 5016.0, 4927.1377508935075, 4937.0, 4979.253112033224, 5099.158638824552, 5104.336436263262], "value": 4317.031847438736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.91706448984485, 353.38510990875886, 363.7017645530664, 372.87392075930705, 376.94157405602107, 4858.538438848313, 5163.81926632568, 5175.999999999995, 5215.2698622192875, 5329.173978033401, 4653.302004699297, 5161.083987547043, 5167.054778776099, 5289.86775330616, 5298.894022119555, 3831.63599458051, 3954.624310690494, 4123.752574845519, 4144.0, 4214.241436541429, 3634.7460126256533, 3722.5346831646043, 4058.127502586943, 4070.694697897655, 4129.772862492577, 3777.054816769366, 4071.8982025449454, 4088.3458646616546, 4093.304138296482, 4126.174765047002, 3444.603870554881, 3772.07584141887, 4080.9387859182134, 4112.732672376301, 4157.23317590023, 3121.7044926355534, 3218.6159951220966, 3401.234722187513, 3658.664587425597, 3675.9081022974374, 4184.961512140799, 4916.655834091615, 5020.523050310215, 5039.21892106724, 5041.546260836542, 3785.9242815143816, 4301.247201790825, 4464.308032255006, 4471.441069866267, 4507.887302817423, 4682.719036857766, 4985.401751789772, 5166.147585648364, 5452.0, 5526.778928842841, 3749.643783840531, 3801.1067399161175, 3801.3347664158937, 3801.752886062397, 3806.7525610835482, 5292.629515933886, 5553.444655534455, 5688.9715551422805, 5692.203091567184, 5779.9422005779825, 3350.5141754445467, 3693.9815300923324, 3729.5524537055726, 3730.291244663505, 3744.831482583236, 3233.1270556949494, 3653.0, 3812.84748610058, 3823.311803875329, 3865.304245235828, 3783.3000894834545, 3925.783007267699, 4329.28566786483, 4486.730796152176, 4546.88632784183, 4658.464276608166, 4797.0, 5432.130859062531, 5437.395968189394, 5486.341639003345, 1056.587930707025, 1080.810858099845, 1221.558560898131, 1255.2593969557822, 1276.7296539942631, 811.3063330852036, 854.2055888024197, 862.2670729879552, 872.9738107856774, 874.4958671085723, 4288.7855607220135, 4727.763611819464, 4963.801447942042, 4966.528179822911, 4985.45450910219, 4799.776057105416, 4876.756162191876, 5139.331886854685, 5166.870828229325, 5365.865853353619, 3960.7821569813937, 4292.227399068135, 4979.601631869442, 5006.249062640561, 5018.322526458881, 2597.908878271093, 2634.2755742171057, 2822.8165169263934, 2882.0, 2905.273681579605, 4137.234611596864, 5117.616178786606, 5120.0, 5371.6239863209985, 5741.827745167651, 5251.973740131275, 5262.684238945675, 5581.748821303051, 5629.634073785191, 5667.149927510906, 5133.948660513422, 5260.606424077036, 5372.033034053908, 5671.0, 5734.913976290276, 4675.509071547439, 4770.996181603666, 5061.6962982221185, 5101.29631295414, 5286.440500052417, 4075.816588253595, 4539.72761634303, 4915.901681966412, 5196.142636464941, 5327.09439395296, 4687.812487500461, 5136.844210052708, 5289.894202115859, 5436.891262174813, 5708.5147762439, 3393.0838673558496, 3552.6552475366134, 3563.3051554946537, 3863.0728625130328, 3981.3828856527284, 4550.067236216501, 5551.861203469945, 5562.554995600423, 5572.219889215432, 5656.37779844225, 4790.377250957354, 5142.8971420572125, 5217.747740542167, 5393.919091213556, 5488.615796894179, 4654.743989080498, 5429.520645467426, 5514.0, 5538.833834984957, 5754.625949313281, 5306.771156114519, 5341.172118321666, 5397.299850547065, 5397.460253974571, 5497.532709719719, 4663.152898858388, 4716.0, 5290.968261189031, 5357.705326207096, 5407.351117865881, 4475.471358682334, 5202.479752024768, 5319.489137169604, 5372.555487253212, 5380.3274590676165], "value": 3933.3415537837973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.2394953576298, 720.099875156055, 787.6416230615067, 824.233462879522, 824.7649419915325, 13886.722265554683, 14634.560963171109, 14986.775198372034, 15494.922525387357, 15606.609834754137, 14152.929235353835, 14292.928535357334, 14315.069520481162, 14346.497872574462, 14393.712125757505, 667.1860330396908, 687.4191308344441, 845.733593917917, 846.3821410370433, 873.1486800369652, 854.940154189207, 857.9699710510133, 864.1444969480201, 865.2645251536206, 870.1907226279558, 916.221211969827, 917.7889085510336, 918.0635751533432, 922.2069020642242, 924.8936372317169, 695.9965200173966, 713.2582114600809, 908.604756930734, 909.7134402663173, 913.7167478081816, 667.6995352091578, 683.2484267305973, 688.6006116452496, 691.1878542712293, 692.4045321023915, 14526.854731452657, 14572.198529080897, 14580.052296600794, 14583.416663333453, 14585.562433127023, 13080.542181023618, 13154.736905261936, 13203.207807531482, 13210.273434961073, 13214.405351759098, 11782.705432364173, 11810.645680629596, 11841.644750657408, 12082.214656047418, 12346.320952347618, 4344.869653910388, 4444.755538445384, 4474.642028637733, 4497.527759585262, 4548.7725613719185, 88700.0, 90090.0, 94235.0, 96318.0, 97028.0, 9022.503762293005, 10434.321769084985, 10582.735431614272, 10726.463676816127, 11161.441927903572, 20329.593408131754, 20674.58650826975, 20695.896520517603, 20758.58482830335, 20812.687809682866, 6843.213030501456, 7270.272972702794, 7447.478676492702, 7480.438967077491, 7535.886961695579, 4202.516710578261, 4246.554111818276, 4288.24955632763, 4307.396964424983, 4315.374270730789, 3338.7829791063987, 3451.050960985749, 3453.2748122894473, 3453.395655760232, 3460.567429071366, 630.3570358234575, 633.8763941031547, 638.4222278837659, 644.4779728419995, 647.1910112359551, 578.8842231553622, 625.9296602809156, 632.34552238433, 638.4636904999822, 647.8056583025074, 9058.230050445654, 9256.305777066747, 9424.387414818015, 9840.557174927146, 9883.0, 572.2960758267271, 573.1116769008021, 588.4821357205632, 592.8695686948864, 682.436989483678, 4327.415798867176, 4542.31865220213, 4768.9523104768505, 4990.476000019946, 4997.675151115166, 73971.26028739751, 88381.0, 91858.54070729738, 95938.0, 98796.01203987868, 82589.0, 85774.0, 89580.7604809885, 91410.0, 91622.54188729014, 77345.0, 78681.0, 79945.80081298786, 80204.0, 80386.5980670093, 10524.491109900571, 10802.243842930919, 10878.45607719595, 11023.944880275547, 11080.0, 48025.75987120042, 49589.76025599389, 49962.50037499724, 51471.0, 51472.48527514827, 49271.0, 67065.9940100889, 69040.30959690339, 69363.95954060592, 70274.94587581293, 12460.875391246334, 12506.93580072888, 12581.8535926151, 12643.747125057263, 12816.87183128194, 13429.0, 13440.513192258439, 14097.718045638825, 14185.645358866112, 14355.928220358832, 12097.153199275966, 13071.542496012595, 13376.264305463294, 13518.25649589282, 13689.589312320646, 10309.896901030894, 12937.54718584845, 13086.738265234833, 13286.53497127596, 13382.464701412224, 12068.75862482763, 12339.75320493603, 13087.41106650222, 13121.147125437197, 13255.270960096901, 9879.901200987899, 10097.737782777152, 10704.625338113128, 11123.169286830658, 11391.772164556829, 11019.614313498989, 11161.553537858395, 11182.32906025641, 11267.605633802777, 11331.093512519143], "value": 7325.098765515602, "unit": "score"}], "name": "dromaeo_css", "value": 7164.530024176964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 110.0, 107.0, 141.0, 113.0, 92.0, 111.0, 131.0, 156.0, 139.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 195.0, 260.0, 203.0, 183.0, 197.0, 256.0, 201.0, 182.0, 184.0], "value": 204.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 88.0, 62.0, 59.0, 57.0, 58.0, 73.0, 57.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 71.0, 68.0, 69.0, 80.0, 67.0, 69.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 91.0, 130.0, 114.0, 84.0, 86.0, 83.0], "value": 92.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 106.0, 148.0, 118.0, 94.0, 93.0, 92.0, 94.0], "value": 102.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 85.0, 87.0, 84.0, 87.0, 87.0, 86.0, 90.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 58.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 76.0, 76.0, 74.0, 68.0, 70.0, 68.0, 69.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 84.0, 84.0, 84.0, 86.0, 83.0, 84.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 142.0, 145.0, 139.0, 137.0, 139.0, 143.0, 141.0, 180.0, 150.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 169.0, 195.0, 168.0, 174.0, 167.0, 168.0, 167.0, 166.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 85.0, 83.0, 84.0, 83.0, 64.0, 65.0, 65.0, 63.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1465.6, "alertThreshold": 2.0}]} 08:35:56 INFO - Return code: 0 08:35:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:35:56 ERROR - # TBPL SUCCESS # 08:35:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:56 INFO - 2017-02-14 08:35:56.349 screenresolution[1993:279868] starting screenresolution argv=screenresolution get 08:35:56 INFO - 2017-02-14 08:35:56.352 screenresolution[1993:279868] Display 0: 1600x1200x32@60 08:35:56 INFO - 2017-02-14 08:35:56.359 screenresolution[1994:279871] starting screenresolution argv=screenresolution list 08:35:56 INFO - Available Modes on Display 0 08:35:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:56 INFO - Intel Iris: 08:35:56 INFO - Chipset Model: Intel Iris 08:35:56 INFO - Type: GPU 08:35:56 INFO - Bus: Built-In 08:35:56 INFO - VRAM (Dynamic, Max): 1536 MB 08:35:56 INFO - Vendor: Intel (0x8086) 08:35:56 INFO - Device ID: 0x0a2e 08:35:56 INFO - Revision ID: 0x0009 08:35:56 INFO - Displays: 08:35:56 INFO - Display: 08:35:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:56 INFO - Display Serial Number: 1600x1200 60 08:35:56 INFO - Main Display: Yes 08:35:56 INFO - Mirror: Off 08:35:56 INFO - Online: Yes 08:35:56 INFO - Rotation: Supported 08:35:56 INFO - Return code: 0 08:35:56 INFO - Running post-action listener: _resource_record_post_action 08:35:56 INFO - [mozharness: 2017-02-14 16:35:56.604560Z] Finished run-tests step (success) 08:35:56 INFO - Running post-run listener: _resource_record_post_run 08:35:56 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 1424384; Write bytes: 506846208; Read time: 20; Write time: 1548 08:35:56 INFO - TinderboxPrint: CPU usage
53.7% 08:35:56 INFO - TinderboxPrint: I/O read bytes / time
1,424,384 / 20 08:35:56 INFO - TinderboxPrint: I/O write bytes / time
506,846,208 / 1,548 08:35:56 INFO - TinderboxPrint: CPU idle
2,224.9 (46.3%) 08:35:56 INFO - TinderboxPrint: CPU system
961.6 (20.0%) 08:35:56 INFO - TinderboxPrint: CPU user
1,615.0 (33.6%) 08:35:56 INFO - TinderboxPrint: Swap in / out
224,845,824 / 0 08:35:56 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201150976; Write bytes: 198959104; Read time: 15679; Write time: 423 08:35:56 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1424384; Write bytes: 295577088; Read time: 20; Write time: 1081 08:35:57 INFO - Running post-run listener: _upload_blobber_files 08:35:57 INFO - Blob upload gear active. 08:35:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:35:57 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:57 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:57 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:58 INFO - (blobuploader) - INFO - Done attempting. 08:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:59 INFO - (blobuploader) - INFO - Done attempting. 08:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:00 INFO - (blobuploader) - INFO - Done attempting. 08:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:02 INFO - (blobuploader) - INFO - Done attempting. 08:36:02 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:02 INFO - Return code: 0 08:36:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c92767039f686b526049589e251e473958d5b24ebe4d256469b33c2eb7b73ac514799f78ea362475bc0219b8649c36c7efa5ffdf5a4e7d9f757fdf98ae73e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab3d7344f23f818e33bc169bf4aab2c06ab9cbb65d7fbbfa04261ff8318e4a84c45210a6e0b210bd6f6c231732f446502d755406f5e745d49ebe127de7852123", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0680574863097ebb5e87da9c7a0df9299a06d320b00c1edc48cad389b8c685222b5c1a35046853bc2f8c355e7c05fe459d08fa3a2dbaa8ffa2bbb61a2be64559", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfb2c86fd3970ed33df7e6b8e24c014bfbb2e45ca16fecd6e28a564950f86eaaa54f20a94ae639b0406d46cebdb717943982de16c4620735915274c888cd1b82"} 08:36:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:02 INFO - Contents: 08:36:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c92767039f686b526049589e251e473958d5b24ebe4d256469b33c2eb7b73ac514799f78ea362475bc0219b8649c36c7efa5ffdf5a4e7d9f757fdf98ae73e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab3d7344f23f818e33bc169bf4aab2c06ab9cbb65d7fbbfa04261ff8318e4a84c45210a6e0b210bd6f6c231732f446502d755406f5e745d49ebe127de7852123", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0680574863097ebb5e87da9c7a0df9299a06d320b00c1edc48cad389b8c685222b5c1a35046853bc2f8c355e7c05fe459d08fa3a2dbaa8ffa2bbb61a2be64559", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfb2c86fd3970ed33df7e6b8e24c014bfbb2e45ca16fecd6e28a564950f86eaaa54f20a94ae639b0406d46cebdb717943982de16c4620735915274c888cd1b82"} 08:36:02 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:02 INFO - Copying logs to upload dir... 08:36:02 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.871147 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-14 08:36:02.670422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 08:36:02.674410) ========= 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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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-Aurora/sha512/1c92767039f686b526049589e251e473958d5b24ebe4d256469b33c2eb7b73ac514799f78ea362475bc0219b8649c36c7efa5ffdf5a4e7d9f757fdf98ae73e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab3d7344f23f818e33bc169bf4aab2c06ab9cbb65d7fbbfa04261ff8318e4a84c45210a6e0b210bd6f6c231732f446502d755406f5e745d49ebe127de7852123", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0680574863097ebb5e87da9c7a0df9299a06d320b00c1edc48cad389b8c685222b5c1a35046853bc2f8c355e7c05fe459d08fa3a2dbaa8ffa2bbb61a2be64559", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfb2c86fd3970ed33df7e6b8e24c014bfbb2e45ca16fecd6e28a564950f86eaaa54f20a94ae639b0406d46cebdb717943982de16c4620735915274c888cd1b82"} build_url:https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011021 build_url: 'https://queue.taskcluster.net/v1/task/edvUzyZsSeuXF68HTBpBCw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c92767039f686b526049589e251e473958d5b24ebe4d256469b33c2eb7b73ac514799f78ea362475bc0219b8649c36c7efa5ffdf5a4e7d9f757fdf98ae73e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab3d7344f23f818e33bc169bf4aab2c06ab9cbb65d7fbbfa04261ff8318e4a84c45210a6e0b210bd6f6c231732f446502d755406f5e745d49ebe127de7852123", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0680574863097ebb5e87da9c7a0df9299a06d320b00c1edc48cad389b8c685222b5c1a35046853bc2f8c355e7c05fe459d08fa3a2dbaa8ffa2bbb61a2be64559", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfb2c86fd3970ed33df7e6b8e24c014bfbb2e45ca16fecd6e28a564950f86eaaa54f20a94ae639b0406d46cebdb717943982de16c4620735915274c888cd1b82"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 08:36:02.710016) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:36:02.710416) ========= 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.f1CtGnqbsH/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.Dj6KF7rdIL/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005161 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:36:02.759188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 08:36:02.759559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 08:36:02.760244) ========= ========= Total master_lag: 0.34 =========