builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0377 starttime: 1491602560.84 results: success (0) buildid: 20170407133121 builduid: 2a0ada5df388430eb82c97934e90962e revision: 65bd52f60c9f0c5dec2901e5936c1eb4698d6709 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:40.842478) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:40.842922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:40.843196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:40.869374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:40.869645) ========= 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.6P5QY4zZXF/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.iazIMu56Cq/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-04-07 15:02:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2017-04-07 15:02:40 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123677 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:41.118077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:41.118389) ========= 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.6P5QY4zZXF/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.iazIMu56Cq/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.027757 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:41.167624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 15:02:41.167944) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 65bd52f60c9f0c5dec2901e5936c1eb4698d6709 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 65bd52f60c9f0c5dec2901e5936c1eb4698d6709 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6P5QY4zZXF/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.iazIMu56Cq/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-04-07 15:02:41,267 truncating revision to first 12 chars 2017-04-07 15:02:41,267 Setting DEBUG logging. 2017-04-07 15:02:41,267 attempt 1/10 2017-04-07 15:02:41,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/65bd52f60c9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 15:02:42,029 unpacking tar archive at: mozilla-beta-65bd52f60c9f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.045037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 15:02:42.236602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:42.236944) ========= script_repo_revision: 65bd52f60c9f0c5dec2901e5936c1eb4698d6709 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:42.237334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:42.237601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 15:02:42.257494) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-07 15:02:42.257854) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6P5QY4zZXF/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.iazIMu56Cq/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:02:42 INFO - MultiFileLogger online at 20170407 15:02:42 in /builds/slave/test 15:02:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:02:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:02:42 INFO - {'append_to_log': False, 15:02:42 INFO - 'base_work_dir': '/builds/slave/test', 15:02:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:02:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:02:42 INFO - 'branch': 'Mozilla-Beta', 15:02:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:02:42 INFO - 'config_files': ('talos/mac_config.py',), 15:02:42 INFO - 'default_actions': ('clobber', 15:02:42 INFO - 'read-buildbot-config', 15:02:42 INFO - 'download-and-extract', 15:02:42 INFO - 'populate-webroot', 15:02:42 INFO - 'create-virtualenv', 15:02:42 INFO - 'install', 15:02:42 INFO - 'run-tests'), 15:02:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:02:42 INFO - 'download_minidump_stackwalk': True, 15:02:42 INFO - 'download_symbols': 'ondemand', 15:02:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:02:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:02:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:02:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:02:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:02:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:02:42 INFO - 'installer_path': 'installer.exe', 15:02:42 INFO - 'log_level': 'info', 15:02:42 INFO - 'log_name': 'talos', 15:02:42 INFO - 'log_to_console': True, 15:02:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:02:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:02:42 INFO - 'opt_config_files': (), 15:02:42 INFO - 'pip_index': False, 15:02:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:02:42 INFO - 'cmd': ('bash', 15:02:42 INFO - '-c', 15:02:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:02:42 INFO - 'enabled': True, 15:02:42 INFO - 'halt_on_failure': False, 15:02:42 INFO - 'name': 'check_screen_resolution'},), 15:02:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:02:42 INFO - 'cmd': ('bash', 15:02:42 INFO - '-c', 15:02:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:02:42 INFO - 'enabled': True, 15:02:42 INFO - 'halt_on_failure': False, 15:02:42 INFO - 'name': 'check_screen_resolution'},), 15:02:42 INFO - 'run_cmd_checks_enabled': True, 15:02:42 INFO - 'sps_profile': False, 15:02:42 INFO - 'sps_profile_interval': 0, 15:02:42 INFO - 'suite': 'dromaeojs', 15:02:42 INFO - 'system_bits': '32', 15:02:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:02:42 INFO - 'title': 't-yosemite-r7-0377', 15:02:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:02:42 INFO - 'use_talos_json': True, 15:02:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:02:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:02:42 INFO - 'work_dir': 'build'} 15:02:42 INFO - [mozharness: 2017-04-07 22:02:42.463972Z] Running clobber step. 15:02:42 INFO - Running pre-action listener: _resource_record_pre_action 15:02:42 INFO - Running main action method: clobber 15:02:42 INFO - rmtree: /builds/slave/test/build 15:02:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:02:45 INFO - Running post-action listener: _resource_record_post_action 15:02:45 INFO - [mozharness: 2017-04-07 22:02:45.002617Z] Finished clobber step (success) 15:02:45 INFO - [mozharness: 2017-04-07 22:02:45.002748Z] Running read-buildbot-config step. 15:02:45 INFO - Running pre-action listener: _resource_record_pre_action 15:02:45 INFO - Running main action method: read_buildbot_config 15:02:45 INFO - Using buildbot properties: 15:02:45 INFO - { 15:02:45 INFO - "project": "", 15:02:45 INFO - "product": "firefox", 15:02:45 INFO - "script_repo_revision": "production", 15:02:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:02:45 INFO - "repository": "", 15:02:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:02:45 INFO - "buildid": "20170407133121", 15:02:45 INFO - "pgo_build": "False", 15:02:45 INFO - "basedir": "/builds/slave/test", 15:02:45 INFO - "buildnumber": 15, 15:02:45 INFO - "slavename": "t-yosemite-r7-0377", 15:02:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:02:45 INFO - "platform": "yosemite_r7", 15:02:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:02:45 INFO - "branch": "mozilla-beta", 15:02:45 INFO - "repo_path": "releases/mozilla-beta", 15:02:45 INFO - "revision": "65bd52f60c9f0c5dec2901e5936c1eb4698d6709", 15:02:45 INFO - "stage_platform": "macosx64", 15:02:45 INFO - "builduid": "2a0ada5df388430eb82c97934e90962e", 15:02:45 INFO - "slavebuilddir": "test" 15:02:45 INFO - } 15:02:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:02:45 INFO - Running post-action listener: _resource_record_post_action 15:02:45 INFO - [mozharness: 2017-04-07 22:02:45.006167Z] Finished read-buildbot-config step (success) 15:02:45 INFO - [mozharness: 2017-04-07 22:02:45.006297Z] Running download-and-extract step. 15:02:45 INFO - Running pre-action listener: _resource_record_pre_action 15:02:45 INFO - Running main action method: download_and_extract 15:02:45 INFO - mkdir: /builds/slave/test/build/tests 15:02: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')]} 15:02:45 INFO - trying https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:02:45 INFO - Downloading https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 15:02:46 INFO - Downloaded 1165 bytes. 15:02:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:02:46 INFO - Using the following test package requirements: 15:02:46 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:02:46 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:02:46 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:02:46 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:02:46 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:02:46 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:02:46 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:02:46 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:02:46 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:02:46 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:02:46 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:02:46 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:02:46 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:02:46 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:02:46 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:02:46 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:02:46 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:02:46 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:02:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:02:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:02:46 INFO - Fetch https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:02:47 INFO - Expected file size: 16116458 15:02:47 INFO - Obtained file size: 16116458 15:02:53 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:02:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:02:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:02:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:02:54 INFO - Expected file size: 16116458 15:02:54 INFO - Obtained file size: 16116458 15:03:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:03:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:03:01 INFO - Fetch https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:03:02 INFO - Expected file size: 14403650 15:03:02 INFO - Obtained file size: 14403650 15:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:02 INFO - trying https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:03:02 INFO - Downloading https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:03:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 15:03:04 INFO - Downloaded 58739271 bytes. 15:03:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:03:04 INFO - mkdir: /builds/slave/test/properties 15:03:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:03:04 INFO - Writing to file /builds/slave/test/properties/build_url 15:03:04 INFO - Contents: 15:03:04 INFO - build_url:https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:03:05 INFO - Running post-action listener: _resource_record_post_action 15:03:05 INFO - Running post-action listener: set_extra_try_arguments 15:03:05 INFO - [mozharness: 2017-04-07 22:03:05.079975Z] Finished download-and-extract step (success) 15:03:05 INFO - [mozharness: 2017-04-07 22:03:05.080122Z] Running populate-webroot step. 15:03:05 INFO - Running pre-action listener: _resource_record_pre_action 15:03:05 INFO - Running main action method: populate_webroot 15:03:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:03:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:03:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:03:05 INFO - '--tppagecycles', 15:03:05 INFO - '7'], 15:03:05 INFO - 'tests': ['tsvgm']}}, 15:03:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:03:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:03:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:03:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:03:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:03:05 INFO - 'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:03:05 INFO - 'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['damp', 'tps']}, 15:03:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:03:05 INFO - 'tests': ['damp', 'tps']}, 15:03:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['dromaeo_dom']}, 15:03:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:03:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['basic_compositor_video']}, 15:03:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:03:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['a11yr', 15:03:05 INFO - 'ts_paint', 15:03:05 INFO - 'tpaint', 15:03:05 INFO - 'sessionrestore', 15:03:05 INFO - 'sessionrestore_no_auto_restore', 15:03:05 INFO - 'tabpaint']}, 15:03:05 INFO - 'other-e10s': {'tests': ['a11yr', 15:03:05 INFO - 'ts_paint', 15:03:05 INFO - 'tpaint', 15:03:05 INFO - 'sessionrestore', 15:03:05 INFO - 'sessionrestore_no_auto_restore', 15:03:05 INFO - 'tabpaint']}, 15:03:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:03:05 INFO - 'ts_paint', 15:03:05 INFO - 'tpaint', 15:03:05 INFO - 'sessionrestore', 15:03:05 INFO - 'sessionrestore_no_auto_restore', 15:03:05 INFO - 'tabpaint']}, 15:03:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:03:05 INFO - 'ts_paint', 15:03:05 INFO - 'tpaint', 15:03:05 INFO - 'sessionrestore', 15:03:05 INFO - 'sessionrestore_no_auto_restore', 15:03:05 INFO - 'tabpaint']}, 15:03:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['a11yr', 15:03:05 INFO - 'ts_paint', 15:03:05 INFO - 'tpaint', 15:03:05 INFO - 'sessionrestore', 15:03:05 INFO - 'sessionrestore_no_auto_restore', 15:03:05 INFO - 'tabpaint']}, 15:03:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['a11yr', 15:03:05 INFO - 'ts_paint', 15:03:05 INFO - 'tpaint', 15:03:05 INFO - 'sessionrestore', 15:03:05 INFO - 'sessionrestore_no_auto_restore', 15:03:05 INFO - 'tabpaint']}, 15:03:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['tsvgx', 15:03:05 INFO - 'tsvgr_opacity', 15:03:05 INFO - 'tart', 15:03:05 INFO - 'tscrollx', 15:03:05 INFO - 'cart', 15:03:05 INFO - 'tsvg_static']}, 15:03:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:03:05 INFO - 'tsvgr_opacity', 15:03:05 INFO - 'tart', 15:03:05 INFO - 'tscrollx', 15:03:05 INFO - 'cart', 15:03:05 INFO - 'tsvg_static']}, 15:03:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:03:05 INFO - 'talos_options': ['--disable-e10s'], 15:03:05 INFO - 'tests': ['tp5o']}, 15:03:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:03:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:03:05 INFO - 'talos_options': ['--disable-e10s', 15:03:05 INFO - '--xperf_path', 15:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:05 INFO - 'tests': ['tp5n']}, 15:03:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:03:05 INFO - 'talos_options': ['--xperf_path', 15:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:05 INFO - 'tests': ['tp5n']}}, 15:03:05 INFO - 'talos.zip': {'path': '', 15:03:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:03:05 INFO - Running post-action listener: _resource_record_post_action 15:03:05 INFO - [mozharness: 2017-04-07 22:03:05.098562Z] Finished populate-webroot step (success) 15:03:05 INFO - [mozharness: 2017-04-07 22:03:05.098707Z] Running create-virtualenv step. 15:03:05 INFO - Running pre-action listener: _resource_record_pre_action 15:03:05 INFO - Running main action method: create_virtualenv 15:03:05 INFO - Creating virtualenv /builds/slave/test/build/venv 15:03:05 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 15:03:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:03:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:03:05 INFO - Using real prefix '/tools/python27' 15:03:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:03:05 INFO - Installing distribute.............................................................................................................................................................................................done. 15:03:08 INFO - Installing pip.................done. 15:03:08 INFO - Return code: 0 15:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:03:09 INFO - Reading from file tmpfile_stdout 15:03:09 INFO - Output received: 15:03:09 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) 15:03:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:03:09 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')]} 15:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 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')]} 15:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:09 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 15:03:09 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 15:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:09 INFO - 'HOME': '/Users/cltbld', 15:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:09 INFO - 'LOGNAME': 'cltbld', 15:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:09 INFO - 'MOZ_NO_REMOTE': '1', 15:03:09 INFO - 'NO_EM_RESTART': '1', 15:03:09 INFO - 'PAGER': '/bin/cat', 15:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:09 INFO - 'PWD': '/builds/slave/test', 15:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:09 INFO - 'SHELL': '/bin/bash', 15:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:09 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:09 INFO - 'USER': 'cltbld', 15:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:09 INFO - 'XPC_FLAGS': '0x0', 15:03:09 INFO - 'XPC_SERVICE_NAME': '0', 15:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:09 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 15:03:09 INFO - Cleaning up... 15:03:09 INFO - Return code: 0 15:03:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:03:09 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')]} 15:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 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')]} 15:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:09 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 15:03:09 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 15:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:09 INFO - 'HOME': '/Users/cltbld', 15:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:09 INFO - 'LOGNAME': 'cltbld', 15:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:09 INFO - 'MOZ_NO_REMOTE': '1', 15:03:09 INFO - 'NO_EM_RESTART': '1', 15:03:09 INFO - 'PAGER': '/bin/cat', 15:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:09 INFO - 'PWD': '/builds/slave/test', 15:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:09 INFO - 'SHELL': '/bin/bash', 15:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:09 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:09 INFO - 'USER': 'cltbld', 15:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:09 INFO - 'XPC_FLAGS': '0x0', 15:03:09 INFO - 'XPC_SERVICE_NAME': '0', 15:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:09 INFO - Downloading/unpacking psutil>=3.1.1 15:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:03:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:13 INFO - Installing collected packages: psutil 15:03:13 INFO - Running setup.py install for psutil 15:03:13 INFO - building 'psutil._psutil_osx' extension 15:03:13 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 15:03:13 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 15:03:13 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 15:03:13 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 15:03:13 INFO - building 'psutil._psutil_posix' extension 15:03:13 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 15:03:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:03:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:03:13 INFO - ^ 15:03:14 INFO - 1 warning generated. 15:03:14 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 15:03:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:14 INFO - Successfully installed psutil 15:03:14 INFO - Cleaning up... 15:03:14 INFO - Return code: 0 15:03:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:03:14 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')]} 15:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:14 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')]} 15:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:14 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:14 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 15:03:14 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 15:03:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:14 INFO - 'HOME': '/Users/cltbld', 15:03:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:14 INFO - 'LOGNAME': 'cltbld', 15:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:14 INFO - 'MOZ_NO_REMOTE': '1', 15:03:14 INFO - 'NO_EM_RESTART': '1', 15:03:14 INFO - 'PAGER': '/bin/cat', 15:03:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:14 INFO - 'PWD': '/builds/slave/test', 15:03:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:14 INFO - 'SHELL': '/bin/bash', 15:03:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:14 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:14 INFO - 'USER': 'cltbld', 15:03:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:14 INFO - 'XPC_FLAGS': '0x0', 15:03:14 INFO - 'XPC_SERVICE_NAME': '0', 15:03:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:03:17 INFO - Installing collected packages: mozsystemmonitor 15:03:17 INFO - Running setup.py install for mozsystemmonitor 15:03:17 INFO - Successfully installed mozsystemmonitor 15:03:17 INFO - Cleaning up... 15:03:17 INFO - Return code: 0 15:03:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:17 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:17 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 15:03:17 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 15:03:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:17 INFO - 'HOME': '/Users/cltbld', 15:03:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:17 INFO - 'LOGNAME': 'cltbld', 15:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:17 INFO - 'MOZ_NO_REMOTE': '1', 15:03:17 INFO - 'NO_EM_RESTART': '1', 15:03:17 INFO - 'PAGER': '/bin/cat', 15:03:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:17 INFO - 'PWD': '/builds/slave/test', 15:03:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:17 INFO - 'SHELL': '/bin/bash', 15:03:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:17 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:17 INFO - 'USER': 'cltbld', 15:03:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:17 INFO - 'XPC_FLAGS': '0x0', 15:03:17 INFO - 'XPC_SERVICE_NAME': '0', 15:03:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:17 INFO - Downloading/unpacking jsonschema==2.5.1 15:03:17 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 15:03:17 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 15:03:17 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 15:03:17 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 15:03:17 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 15:03:17 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 15:03:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:03:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:03:20 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 15:03:20 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 15:03:20 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 15:03:20 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 15:03:20 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 15:03:20 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 15:03:20 INFO - Downloading functools32-3.2.3-2.tar.gz 15:03:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:03:20 INFO - warning: no files found matching '*.txt' 15:03:20 INFO - no previously-included directories found matching 'build' 15:03:20 INFO - no previously-included directories found matching 'dist' 15:03:20 INFO - no previously-included directories found matching '.git*' 15:03:20 INFO - Installing collected packages: jsonschema, functools32 15:03:20 INFO - Running setup.py install for functools32 15:03:20 INFO - warning: no files found matching '*.txt' 15:03:20 INFO - no previously-included directories found matching 'build' 15:03:20 INFO - no previously-included directories found matching 'dist' 15:03:20 INFO - no previously-included directories found matching '.git*' 15:03:20 INFO - Successfully installed jsonschema functools32 15:03:20 INFO - Cleaning up... 15:03:21 INFO - Return code: 0 15:03:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:21 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:21 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 15:03:21 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 15:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:21 INFO - 'HOME': '/Users/cltbld', 15:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:21 INFO - 'LOGNAME': 'cltbld', 15:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:21 INFO - 'MOZ_NO_REMOTE': '1', 15:03:21 INFO - 'NO_EM_RESTART': '1', 15:03:21 INFO - 'PAGER': '/bin/cat', 15:03:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:21 INFO - 'PWD': '/builds/slave/test', 15:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:21 INFO - 'SHELL': '/bin/bash', 15:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:21 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:21 INFO - 'USER': 'cltbld', 15:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:21 INFO - 'XPC_FLAGS': '0x0', 15:03:21 INFO - 'XPC_SERVICE_NAME': '0', 15:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:03:21 INFO - Cleaning up... 15:03:21 INFO - Return code: 0 15:03:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:21 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:21 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 15:03:21 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 15:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:21 INFO - 'HOME': '/Users/cltbld', 15:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:21 INFO - 'LOGNAME': 'cltbld', 15:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:21 INFO - 'MOZ_NO_REMOTE': '1', 15:03:21 INFO - 'NO_EM_RESTART': '1', 15:03:21 INFO - 'PAGER': '/bin/cat', 15:03:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:21 INFO - 'PWD': '/builds/slave/test', 15:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:21 INFO - 'SHELL': '/bin/bash', 15:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:21 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:21 INFO - 'USER': 'cltbld', 15:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:21 INFO - 'XPC_FLAGS': '0x0', 15:03:21 INFO - 'XPC_SERVICE_NAME': '0', 15:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:21 INFO - Downloading/unpacking blobuploader==1.2.4 15:03:21 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 15:03:21 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 15:03:21 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 15:03:21 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 15:03:21 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 15:03:21 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 15:03:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:03:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:03:24 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 15:03:24 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 15:03:24 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 15:03:24 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 15:03:24 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 15:03:24 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 15:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:03:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:03:25 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 15:03:25 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 15:03:25 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 15:03:25 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 15:03:25 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 15:03:25 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 15:03:25 INFO - Downloading docopt-0.6.1.tar.gz 15:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:03:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:03:25 INFO - Running setup.py install for blobuploader 15:03:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:03:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:03:25 INFO - Running setup.py install for requests 15:03:26 INFO - Running setup.py install for docopt 15:03:26 INFO - Successfully installed blobuploader requests docopt 15:03:26 INFO - Cleaning up... 15:03:26 INFO - Return code: 0 15:03:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:26 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:26 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 15:03:26 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 15:03:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:26 INFO - 'HOME': '/Users/cltbld', 15:03:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:26 INFO - 'LOGNAME': 'cltbld', 15:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:26 INFO - 'MOZ_NO_REMOTE': '1', 15:03:26 INFO - 'NO_EM_RESTART': '1', 15:03:26 INFO - 'PAGER': '/bin/cat', 15:03:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:26 INFO - 'PWD': '/builds/slave/test', 15:03:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:26 INFO - 'SHELL': '/bin/bash', 15:03:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:26 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:26 INFO - 'USER': 'cltbld', 15:03:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:26 INFO - 'XPC_FLAGS': '0x0', 15:03:26 INFO - 'XPC_SERVICE_NAME': '0', 15:03:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-TKUsMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-wvlluY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-gRCQRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-XdcBem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5ovFoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-7hsakA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-QIFwsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-XHIapt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ACAhqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-nnUzU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-4kE8VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-_kuaol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-wy3sUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Glym5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-QaQPRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BtStDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-wA3TN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:03:28 INFO - Running setup.py install for manifestparser 15:03:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:03:28 INFO - Running setup.py install for mozcrash 15:03:28 INFO - Running setup.py install for mozdebug 15:03:28 INFO - Running setup.py install for mozdevice 15:03:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Running setup.py install for mozfile 15:03:29 INFO - Running setup.py install for mozhttpd 15:03:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Running setup.py install for mozinfo 15:03:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Running setup.py install for mozInstall 15:03:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:03:29 INFO - Running setup.py install for mozleak 15:03:29 INFO - Running setup.py install for mozlog 15:03:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:03:30 INFO - Running setup.py install for moznetwork 15:03:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:03:30 INFO - Running setup.py install for mozprocess 15:03:30 INFO - Running setup.py install for mozprofile 15:03:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:03:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:03:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:03:30 INFO - Running setup.py install for mozrunner 15:03:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:03:30 INFO - Running setup.py install for mozscreenshot 15:03:30 INFO - Running setup.py install for moztest 15:03:30 INFO - Running setup.py install for mozversion 15:03:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:03:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:03:31 INFO - Cleaning up... 15:03:31 INFO - Return code: 0 15:03:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:31 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:31 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 15:03:31 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 15:03:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:31 INFO - 'HOME': '/Users/cltbld', 15:03:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:31 INFO - 'LOGNAME': 'cltbld', 15:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:31 INFO - 'MOZ_NO_REMOTE': '1', 15:03:31 INFO - 'NO_EM_RESTART': '1', 15:03:31 INFO - 'PAGER': '/bin/cat', 15:03:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:31 INFO - 'PWD': '/builds/slave/test', 15:03:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:31 INFO - 'SHELL': '/bin/bash', 15:03:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:31 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:31 INFO - 'USER': 'cltbld', 15:03:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:31 INFO - 'XPC_FLAGS': '0x0', 15:03:31 INFO - 'XPC_SERVICE_NAME': '0', 15:03:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Vj1HkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:31 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)) 15:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-nJW1CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:31 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)) 15:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-OwuffN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:31 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)) 15:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ePfh9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:31 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)) 15:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-fA026E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:31 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)) 15:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-r1D7ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-YaqFan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Trueh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-36_J_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-N9Z_6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-GHxyiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-KLs1OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BS_KDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Tnl4SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:32 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)) 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:32 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-sH_W2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:33 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)) 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:33 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-dCR0Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:33 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)) 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:33 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Ktx8nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:33 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)) 15:03:33 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)) 15:03:33 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)) 15:03:33 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)) 15:03:33 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)) 15:03:33 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)) 15:03:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:36 INFO - Downloading blessings-1.6.tar.gz 15:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:36 INFO - Installing collected packages: blessings 15:03:36 INFO - Running setup.py install for blessings 15:03:36 INFO - Successfully installed blessings 15:03:36 INFO - Cleaning up... 15:03:36 INFO - Return code: 0 15:03:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:36 INFO - Reading from file tmpfile_stdout 15:03:36 INFO - Current package versions: 15:03:36 INFO - blessings == 1.6 15:03:36 INFO - blobuploader == 1.2.4 15:03:36 INFO - docopt == 0.6.1 15:03:36 INFO - functools32 == 3.2.3-2 15:03:36 INFO - jsonschema == 2.5.1 15:03:36 INFO - manifestparser == 1.1 15:03:36 INFO - mozInstall == 1.12 15:03:36 INFO - mozcrash == 1.0 15:03:36 INFO - mozdebug == 0.1 15:03:36 INFO - mozdevice == 0.49 15:03:36 INFO - mozfile == 1.2 15:03:36 INFO - mozhttpd == 0.7 15:03:36 INFO - mozinfo == 0.9 15:03:36 INFO - mozleak == 0.1 15:03:36 INFO - mozlog == 3.4 15:03:36 INFO - moznetwork == 0.27 15:03:36 INFO - mozprocess == 0.24 15:03:36 INFO - mozprofile == 0.28 15:03:36 INFO - mozrunner == 6.13 15:03:36 INFO - mozscreenshot == 0.1 15:03:36 INFO - mozsystemmonitor == 0.3 15:03:36 INFO - moztest == 0.8 15:03:36 INFO - mozversion == 1.4 15:03:36 INFO - psutil == 3.1.1 15:03:36 INFO - requests == 1.2.3 15:03:36 INFO - wsgiref == 0.1.2 15:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:37 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:37 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 15:03:37 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 15:03:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:37 INFO - 'HOME': '/Users/cltbld', 15:03:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:37 INFO - 'LOGNAME': 'cltbld', 15:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:37 INFO - 'MOZ_NO_REMOTE': '1', 15:03:37 INFO - 'NO_EM_RESTART': '1', 15:03:37 INFO - 'PAGER': '/bin/cat', 15:03:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:37 INFO - 'PWD': '/builds/slave/test', 15:03:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:37 INFO - 'SHELL': '/bin/bash', 15:03:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:37 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:37 INFO - 'USER': 'cltbld', 15:03:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:37 INFO - 'XPC_FLAGS': '0x0', 15:03:37 INFO - 'XPC_SERVICE_NAME': '0', 15:03:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 INFO - Cleaning up... 15:03:37 INFO - Return code: 0 15:03:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:37 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 0x1044a8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ab768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c83b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, '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.6P5QY4zZXF/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.iazIMu56Cq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:03:37 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 15:03:37 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 15:03:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:37 INFO - 'HOME': '/Users/cltbld', 15:03:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:37 INFO - 'LOGNAME': 'cltbld', 15:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:37 INFO - 'MOZ_NO_REMOTE': '1', 15:03:37 INFO - 'NO_EM_RESTART': '1', 15:03:37 INFO - 'PAGER': '/bin/cat', 15:03:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:37 INFO - 'PWD': '/builds/slave/test', 15:03:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:37 INFO - 'SHELL': '/bin/bash', 15:03:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:37 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:37 INFO - 'USER': 'cltbld', 15:03:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:37 INFO - 'XPC_FLAGS': '0x0', 15:03:37 INFO - 'XPC_SERVICE_NAME': '0', 15:03:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:03:37 INFO - Cleaning up... 15:03:37 INFO - Return code: 0 15:03:37 INFO - Running post-action listener: _resource_record_post_action 15:03:37 INFO - Running post-action listener: _start_resource_monitoring 15:03:37 INFO - Starting resource monitoring. 15:03:37 INFO - [mozharness: 2017-04-07 22:03:37.840582Z] Finished create-virtualenv step (success) 15:03:37 INFO - [mozharness: 2017-04-07 22:03:37.841544Z] Running install step. 15:03:37 INFO - Running pre-action listener: _resource_record_pre_action 15:03:37 INFO - Running main action method: install 15:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:38 INFO - Reading from file tmpfile_stdout 15:03:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:38 INFO - Reading from file tmpfile_stdout 15:03:38 INFO - Output received: 15:03:38 INFO - Usage: mozinstall [options] installer 15:03:38 INFO - Options: 15:03:38 INFO - -h, --help show this help message and exit 15:03:38 INFO - -d DEST, --destination=DEST 15:03:38 INFO - Directory to install application into. [default: 15:03:38 INFO - "/builds/slave/test"] 15:03:38 INFO - --app=APP Application being installed. [default: firefox] 15:03:38 INFO - mkdir: /builds/slave/test/build/application 15:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:03:53 INFO - Reading from file tmpfile_stdout 15:03:53 INFO - Output received: 15:03:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:03:53 INFO - Running post-action listener: _resource_record_post_action 15:03:53 INFO - [mozharness: 2017-04-07 22:03:53.050553Z] Finished install step (success) 15:03:53 INFO - [mozharness: 2017-04-07 22:03:53.050730Z] Running run-tests step. 15:03:53 INFO - Running pre-action listener: _resource_record_pre_action 15:03:53 INFO - Running main action method: run_tests 15:03:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:03:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:03:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:03:53 INFO - 2017-04-07 15:03:53.065 screenresolution[1624:7235] starting screenresolution argv=screenresolution get 15:03:53 INFO - 2017-04-07 15:03:53.067 screenresolution[1624:7235] Display 0: 1600x1200x32@60 15:03:53 INFO - 2017-04-07 15:03:53.073 screenresolution[1625:7237] starting screenresolution argv=screenresolution list 15:03:53 INFO - Available Modes on Display 0 15:03:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:03:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:03:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:03:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:03:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:03:53 INFO - Intel Iris: 15:03:53 INFO - Chipset Model: Intel Iris 15:03:53 INFO - Type: GPU 15:03:53 INFO - Bus: Built-In 15:03:53 INFO - VRAM (Dynamic, Max): 1536 MB 15:03:53 INFO - Vendor: Intel (0x8086) 15:03:53 INFO - Device ID: 0x0a2e 15:03:53 INFO - Revision ID: 0x0009 15:03:53 INFO - Displays: 15:03:53 INFO - Display: 15:03:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:03:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:03:53 INFO - Display Serial Number: 1600x1200 60 15:03:53 INFO - Main Display: Yes 15:03:53 INFO - Mirror: Off 15:03:53 INFO - Online: Yes 15:03:53 INFO - Rotation: Supported 15:03:53 INFO - Return code: 0 15:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:53 INFO - Python 2.7.3 15:03:53 INFO - Return code: 0 15:03:53 INFO - grabbing minidump binary from tooltool 15:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:53 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 0x104286d30>, '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 0x1041addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10427bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:53 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 15:03:53 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 15:03:53 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 15:03:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:53 INFO - Return code: 0 15:03:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:03:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:03:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 15:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --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 15:03:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6P5QY4zZXF/Render', 15:03:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:53 INFO - 'HOME': '/Users/cltbld', 15:03:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:53 INFO - 'LOGNAME': 'cltbld', 15:03:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:53 INFO - 'MOZ_NO_REMOTE': '1', 15:03:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:53 INFO - 'NO_EM_RESTART': '1', 15:03:53 INFO - 'PAGER': '/bin/cat', 15:03:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:53 INFO - 'PWD': '/builds/slave/test', 15:03:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:53 INFO - 'SHELL': '/bin/bash', 15:03:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iazIMu56Cq/Listeners', 15:03:53 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:03:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:53 INFO - 'USER': 'cltbld', 15:03:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:53 INFO - 'XPC_FLAGS': '0x0', 15:03:53 INFO - 'XPC_SERVICE_NAME': '0', 15:03:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 15:03:53 INFO - mozversion application_buildid: 20170407133121 15:03:53 INFO - mozversion application_changeset: 65bd52f60c9f0c5dec2901e5936c1eb4698d6709 15:03:53 INFO - mozversion application_display_name: Firefox 15:03:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:53 INFO - mozversion application_name: Firefox 15:03:53 INFO - mozversion application_remotingname: firefox 15:03:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:03:53 INFO - mozversion application_vendor: Mozilla 15:03:53 INFO - mozversion application_version: 53.0 15:03:53 INFO - mozversion platform_buildid: 20170407133121 15:03:53 INFO - mozversion platform_changeset: 65bd52f60c9f0c5dec2901e5936c1eb4698d6709 15:03:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:03:53 INFO - mozversion platform_version: 53.0 15:03:53 INFO - using testdate: 1491602633 15:03:53 INFO - actual date: 1491602633 15:03:53 INFO - starting webserver on 'localhost:49240' 15:03:53 INFO - SUITE-START | Running 2 tests 15:03:53 INFO - TEST-START | dromaeo_css 15:03:53 INFO - operating with platform_type : mac_ 15:03:53 INFO - Initialising browser for dromaeo_css test... 15:03:53 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpwGgSl2/profile http://localhost:49240/getInfo.html) 15:03:55 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 15:03:55 INFO - PROCESS | 1635 | colorDepth:24 15:03:55 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 15:03:55 INFO - PROCESS | 1635 | __metrics 15:03:55 INFO - PROCESS | 1635 | 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" 15:03:55 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:03:56 INFO - TEST-INFO | 1635: exit 0 15:03:56 INFO - Browser initialized. 15:03:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:03:56 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpwGgSl2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:08 INFO - PROCESS | 1638 | RSS: Main: 163713024 15:04:08 INFO - PROCESS | 1638 | 15:07:11 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 15:07:12 INFO - PROCESS | 1638 | RSS: Main: 314138624 15:07:12 INFO - PROCESS | 1638 | 15:10:15 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 15:10:16 INFO - PROCESS | 1638 | RSS: Main: 307142656 15:10:16 INFO - PROCESS | 1638 | 15:13:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 15:13:19 INFO - PROCESS | 1638 | RSS: Main: 302542848 15:13:19 INFO - PROCESS | 1638 | 15:16:21 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 15:16:22 INFO - PROCESS | 1638 | RSS: Main: 282435584 15:16:22 INFO - PROCESS | 1638 | 15:19:25 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 15:19:26 INFO - PROCESS | 1638 | RSS: Main: 265695232 15:19:26 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 15:22:29 INFO - PROCESS | 1638 | RSS: Main: 365514752 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | __start_tp_report 15:22:29 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 15:22:29 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 15:22:29 INFO - PROCESS | 1638 | |i|pagename|runs| 15:22:29 INFO - PROCESS | 1638 | |0;dojo.html;3435.415979283522;3462.4460086386184;3463.948040779387;3496.1958749487603;3533.5406397168363;5844.26946631671;5898.056310990242;5909.704514774266;5912.645241285526;5917.0828521579115;5826.883462330761;5875.8531036724;5879.382664820197;5915.112733090039;5919.556033297509;4130.277201489727;4870.366852309195;5275.815346462875;5279.260903473507;5362.115250983583;5232.084385232588;5234.110201265775;5244.003639308538;5369.865753356178;5376.247325374431;5242.292290540767;5285.365756109272;5286.788528458857;5332.120200166968;5365.490278423563;5313.787448502056;5330.493603107699;5340.225667278261;5340.385855626614;5361.571074314045;5158.613104017214;5236.319278493809;5294.549963253128;5323.467653234684;5342.866428339323;4760.833370832039;5711.600187986843;5768.3654797972185;5771.278590176228;5772.826815195509;6250.124982502453;6275.18422605063;6288.088227207075;6325.525585581054;6334.4299013088585;6277.780277690259;6309.779157729457;6313.43179113882;6325.114483972247;6331.303556608769;6052.788152414689;6061.121137435091;6070.57505974582;6071.666058366833;6076.99729544629;6284.591501552384;6315.336889626615;6335.479484923678;6467.223933128054;6486.35136486357;6262.2172228471445;6306.054091886253;6311.179546658905;6314.305426403092;6321.778737744157;6285.277193122758;6319.368063193644;6339.017452294902;6339.936600633934;6360.300366959631;6203.100550420164;6275.780347687901;6303.905441418382;6313.715882785285;6337.271213810379;6254.186955695731;6270.059491076375;6272.780452684134;6272.937270627235;6286.151369565142;5154.098032844237;5155.587552995751;5160.277561141444;5165.1219292720325;5184.300119483897;4560.88597785058;4562.498125206224;4576.244919588297;4612.0545288215835;4633.4208223972;5775.306963164448;5804.448577385142;5820.476157145792;5858.443447872445;5958.344582095966;6211.9068213976825;6233.158523599347;6255.499560035186;6270.59241149333;6346.333634968262;6025.78909738157;6027.758889644453;6047.15339852421;6059.757609695563;6078.54410919174;5476.58925580583;5562.972185139049;5589.832305030855;5594.0769772987005;5612.579056570692;6435.646039467781;6438.227412710411;6472.288048314776;6486.578372405778;6574.342565743387;6320.968395157995;6323.4625056868845;6346.587471814318;6388.8083357499345;6421.293657697556;6500.689497239454;6544.116544266463;6553.901691474727;6564.901526477011;6583.769568065095;6206.038064100072;6234.407731265523;6235;6251.062340648939;6267.059941008885;6319.431251187415;6323.905141422974;6333.113364129118;6338;6338.778142764981;6263.78076767311;6289.213848268966;6304.684765761602;6307.495400367868;6318.589291696025;6147.047207682637;6213.130161777445;6216.595921265103;6233.283172435228;6236.126942228001;5155.407128180307;6229.0967809668255;6236.282827474898;6249.031400132987;6266.530010249341;6282.780102696383;6283.8580709645175;6286.057091436322;6301.558890877778;6302.747890084529;6038.215032045806;6123.84690382744;6131.601445906002;6137.355577664281;6249.187605611423 15:22:29 INFO - PROCESS | 1638 | |1;ext.html;489.9216125419932;501.2206019639459;526.5655833937003;534.401470353204;546.1643685161702;31878.68121318789;41430.171396572085;43019.78490107549;43051.35422968658;43148;43491.91270218238;44230.33654495185;44623.55376446235;44644.33033504492;44761.32858007133;8800.911990880106;9584.472853993046;9742.123208911196;9756.170725488306;9779.973102824208;8958.776030599221;11674.941625291862;11897.107716921266;11950.103742219324;12086.274823510574;11843.881561184407;11880.524779008872;11881;11894.048476121932;11915.2255103418;11915.642530724092;11990.580329688419;11999.820002699878;12006.21959572625;12018.459169337313;11773.705657358549;11850.881491185064;11860.11049171307;11864.110191735654;11866.52533898643;41913.161736765396;42252;42321.57678423207;42395;42448.93877653052;4032.213718324928;4058.6753059755147;4102.056526998807;4103.4870641169855;4129.112240868228;25444.491110177692;29545.40909181826;30518.542221866468;31288.21779455509;32396.83801580977;3279.8196099214774;3358.2947581008016;3358.4458564336855;3379.3748156590864;3509.0525558099425;498878.50560747326;499932.00067998853;502779;503158.9684103149;503199.99999999633;60452.39547604468;60827.695861520406;60850.39149608536;60938.0859287111;60987;62013;62153.75692486125;62230.37769622336;62250.68874655688;62385.68807155935;16557.337706491846;16777;16814.663706725798;16847.326106955585;16907.07011114376;11846.822297665542;12229.899309062228;12691.238525688488;12761.489540418279;13052.34738263083;16431.835681643268;18387.08064596765;18555.886646801235;18792.154353054146;18916;7849;7901.565413902291;7905;8041.437099402986;8062.516249025077;792.6274650914061;793.2266040610359;874.191372979991;887.5296093070683;912.7991841794794;28539.57302134885;28924.276893077422;30330.696693033227;30567.38865222683;30665.84667076695;992.3153024413132;1030.8814486334018;1090.4057288777635;1130.6042884990352;1240.5409998300506;15905.125218113115;16151.515454536382;16213.189340532927;16389.205248823968;16488.0931548766;647112.7644361842;654831;655241;655953;657556;64213;64662;64800;64819;64898.351016490175;1345.9663508412368;1402.691407890242;1471.1687896338535;1488.151753500516;1512.3194562446943;27416.314592135357;29845.85077074601;32603.673963260062;32681.509777352883;33311.83408580688;52214.21678674899;54847;56050.71974640101;56310.87378252494;58617.70691146517;611305;617413;617739;617918;618492;32785.672143278265;35471.29057418889;41964.16071678611;42384.940376490835;42701.35947960721;37534.249315013;44983;45188.322175166744;45667;45742.542574573825;30387.848060759556;31020.689793102683;31101.222469438446;31707.20731981719;32237.51643725299;30902.53646195354;30996.845015774776;31002.534961976038;31790.682093178773;32125.35749285048;35896.46155307725;36602.26795464129;37177.81411092927;37231.25537489289;37353.252934941695;30103.84948075333;30647.080587582408;30682.386352273275;31801.5229771549;32065.869460886148;23696.05215791349;24546.754532454448;24590.262292131265;24934.625980609944;25038.74961250364 15:22:29 INFO - PROCESS | 1638 | |2;jquery.html;399.80259123923855;406.12074857932566;409.104062103992;413.56988731719;431.5210116770384;20851.687224691625;20903.790962090374;22126;22278.55442891145;22377.776222237793;16504.75242871355;17714.734278985794;21406;21632.512261089978;22092.8895355523;5291;5930.436608522184;6124.133541515404;6201.534884883652;6203.131561581382;5797.884042319151;5956.97021514894;6021.849453763669;6029.427204415573;6032.728527216286;5977.790777322794;5981.072933695263;5983.700814959257;5986.311574168961;7615.923840761577;7931.167227441093;7963.084245311777;8095.02859656842;8174.34605231583;8179.386546009073;7956.801079972989;8003.079645840745;8115.14790946948;8119.350451963829;8128.715494957648;25417.872910635513;27213.727862721316;28669.713302866912;29516.557251641243;30057.248568785737;3221.371832492665;3327.317899830529;3387.7120444762227;3471.6701913318193;3573.160307327776;16356.427525036686;16676.83323166765;16685.66628667432;16710.916445417817;16838.915805421017;1743.755874177616;2094.392626138433;2111.9788802111934;2124.511362386644;2392.5812982727953;161430;162031;165873.341266587;170096;178057;19910.805351678944;20200.58595898273;21840.563188736138;22806.543869122524;24130.638040429407;41558.79220603938;41571.584284157376;42431.7878410606;42442;42808.3578746319;8578.613962371708;8765.211130998241;9084.183163367354;9159.633614655339;9210.309226808016;8956.820863582692;8964.907107048059;8971.955140224387;9139;9168.81662366749;4808.0624278266105;4894.11905856942;4901.289313049588;4965.255211718271;4985.800567977313;1856.5637075287298;1989.4979290635476;2038.2967876082728;2076.4705000224844;2086.35323049855;878.3412440669371;967.3905439573165;1012.696191142669;1050.9579616815395;1091.5470079916904;19240.903795481212;21092.894535527223;21448.24931127403;21495.191851848318;21807.127714891227;977.8484334928097;1051.0960573906586;1056.392574269798;1080.9729756756144;1084.772197838447;10605.84091238632;10892.997287926797;10958.726031849108;10970.341779493256;10979.451027448597;671956;675371;695863;719268;720704;152312;156483;156768;159915;161347;996.9860881020443;1012.9442880641489;1035.409816404642;1036.103770238738;1040.422565476168;17974.5506362342;18496.797708148926;18691.252349906394;18744.906275468536;18748;43303;58419;58665;59230.70384648222;59525;73604;85904;88839.11160888567;89899.1010089917;90578.64132038156;8088.595570221348;8103.87844182326;8191.262786349257;8488.830223395375;8619.353548484014;9351.672691455766;11888.227265227733;12430.440630171483;12832.55086071983;12862;10918.72703182395;11086.168537359892;11149.665510034712;11319.660410187707;11352.205345625727;5028.798848046037;7370.562740265596;10265.538050787583;10437.217208709226;10689.9465502672;10953.616623418142;11212.327260364404;11440.913113254228;11441.42792860337;11982.221155624857;8233.34133269325;8328.750137495885;8377.371697122619;8766.561671916506;8772.122787721177;8385.454945428528;11054.060404865677;11071.280366776135;11236.101111910864;11537.88462115368 15:22:29 INFO - PROCESS | 1638 | |3;mootools.html;1377.6762460821699;1474.1302631447443;1477.8300495443025;1494.2304713072765;1495.970080598388;6780.8982865257;7638.885416718754;7981.600919954001;8532.744017679464;8586.184312490303;8425.241728244457;8496.872546911802;8511.936007999;8512.10622884596;8513.702020429286;1976.505873531617;2362.0197617988515;2402;2403.5553422616786;2403.9158629447975;2140.67889816528;2218.2125345502354;2350.8707021113833;2422.200673777658;2426.8786560671897;2382.8093752499844;2410.7950824179966;2412.1798588479915;2420.3102115896972;2429.8177636677233;1989.3634037108131;2352.0121548949483;2366.751491093436;2372.3238876919995;2375.7527298168425;2391.5216956608574;2393.4734358441115;2410.0480310277344;2420.4190994161277;2423.6001059825285;8395.454295470836;8562.657493700244;8573.185547373052;8584.8712269316;8585.484870907703;4270.508891477458;5322.04203243416;5322.1484562470205;5322.893542129135;5332.146856502941;2980.2996295870453;3023.818570885754;3536.982315088408;3613.403788374915;3672.7245456590863;1215.8115492098739;1240.503798480615;1265.2661456355384;1302.2837439408288;1303.9478420863154;11104.111671066375;11106.61126860556;11120.61077862279;11125.332480051224;11139.498722557504;4683.7423941682855;4795.688280261772;4826.734529600835;4847.3698419205275;4849.914536749232;8831.984321803075;8846.380753347205;8852.601632926533;8863.822723545492;8903.976042755037;5263.6578622389425;5269.525742683177;5273.1299335609965;5273.736313184326;5285.471452854684;4191.161767646422;4825.30033145192;4931.778069986859;4960.528749768766;5022.799088036438;3129.8122112673313;3557.5197348358156;3663.7984910829628;3768.5477742671055;3782.224643947984;1177.587844254504;1180.3861991764234;1180.4569897846916;1184.8933595976232;1192.0642295797757;677.34974424552;754.5736658787768;780.1301548773077;806.8345989072226;827.4962060732482;4524.751138687404;5559.777608895599;5744.597878148573;5783.508401785895;5869.65947203964;994.751312171957;998.2962011781676;1013.6097602423121;1014.3812274512542;1042.67677020124;3747.4191500317493;3857.61423857612;3867;3942.3495123304906;3987.182627561343;9839.163671087894;10099.14157296638;10229.28395012342;10229.897701023043;10279.97200279981;10190.796184076426;10194.184465242763;10202.38785672862;10203.38779673222;10242.948785256174;6655.966720166368;7776.572288524186;7779.144294127642;7794.259545343183;7940.483868548526;5550.361708403585;5638.069718496402;5697.658140511582;5788.450097240755;5933.258342707161;8876.289896808368;9258.213051890665;9386.577604007973;9425.670101546413;9468.431894086101;8579.013413457282;9040.457572545669;9250.629974800933;9418.963913969596;9573.760655983657;7758.185390533913;7843.56860372685;7905.090914544901;7924.683012679428;7946;7204.53170543913;7448.47860649771;7453.180150183367;7696.230376962483;7876.330511906552;6843.349881761424;6915.792526224222;7013.964930175316;7062.0466237057335;7132.679029443584;6570.342965703391;6894.24163342022;6954.721811127701;6972.337627925339;7005.929940700732;6463.450606698483;6538.509611779231;6540.50946179048;6543.934560654333;6546.443552298108;4909.189983652657;4945;4949.282354058713;5076.796928122833;5215.921761173509;4803.5916947059895;5030.698158110378;5083.440821509705;5172.275881376686;5175.9741201293755 15:22:29 INFO - PROCESS | 1638 | |4;prototype.html;366.4978978799046;372.48968912589754;377.4451556212368;382.420632741397;382.5218476903872;5426.1046927257;5428.068842824875;5428.511433970942;5477.534409575186;5565.638233514819;4683.274092515657;5049.238317453493;5214.530692237698;5216.921746173811;5343.893122137555;3644.4168932970665;3650.8174591270463;4110.239605672945;4119.384191038682;4177.4569305990335;4135.669146468275;4149.522804877448;4195.85314513992;4197.685173611976;4200.621944025037;3198.7760856740038;4042.009707621622;4054.9391759123637;4130.80206740045;4184.372344148372;3392.6776956189124;4118.361653943643;4141.91716165678;4159.2721273777115;4162.583741625828;3699.167687270343;3709.2025214578725;3727.347714150013;3732.8320225589914;3734.3672710738865;4983.626228032912;5212.270282160501;5236.659617124913;5252.658577192508;5284.497972692588;4795.184818580849;4806.375171227753;4822.807087716487;4841.782119804582;4843.685160464559;4886.9511304886855;5525.198846167284;5538.037150124664;5628.521575666074;5635.887282254332;4112.979435102805;4115.32097203961;4121.7634709587;4135.60711732385;4171.97914010428;5431;5458.124731440642;5520.91718624221;5881.264841894763;5887.675273063526;3869.200821617961;3896.357101078347;3905.1408690088133;3907.316219661548;3908.843646254118;3366.377220214268;3564.9341566253;3978.3833505806647;3981.770208683147;3988;4347.782620866163;4393.846215382447;4438;4438.689291749546;4541.84103556374;5229.006488767122;5422.566194704415;5634.295713035871;5654.6889921054735;5735.447725762079;1155.0825629455233;1284.845818501767;1295.727897141592;1304.2174695182814;1308.9803652945213;705.5978092487336;842.4650347029558;847.5380917400032;858.8153546987428;876.8728534362482;4579.382287992448;4583.656225783013;4802.231642937113;4963.354763880672;4964.702117872939;4656.952185758245;4726.929096063562;5440.91838622421;5474.39781624021;5475.7262136893;4862.902741945141;4879.463259041502;4945.184044632667;4946.5053494650965;5208.5051920067535;2383.678203442548;2695.124084672489;2839.559868220429;2876.985615071953;2896.0443053792196;4734.644901632391;5168.689878607295;5571.025070612708;5731.340895797037;5746.5977381583725;4909.705417674951;5198.948010519846;5251.162093267326;5616.438356164351;5670.7731690732735;4669.486356500782;5271.65734227274;5446.373667028342;5742.31092268922;5745.454181852718;5404;5442.285680010784;5477.370102438112;5482.860440367656;5519.475649813261;5225.216217567396;5697.515711164431;5705.657660540381;5729.997250481232;5736.196932429547;5140.457862641268;5846.742950265713;6000.819975400745;6015.097735339559;6019.428154325332;3769.8680546180753;3904.882853514399;3921.117748506563;3930.213957208627;3939.2380276836125;5362.490563396471;5698.782900653569;5752.223449834386;5757.251557297524;5802.506786923159;4300.913981720286;5635.520980716685;5641.915371269516;5649.519790817662;5653.830385088454;4649.907001860011;5302.8939421212135;5543.695096769717;5596.5242954347705;5654.7842213924205;4278.65770738334;4333.761643109659;5057.165567681292;5267.762950667306;5532.944670553243;4585.541445855388;5494.928488944617;5546.72266386671;5634.718264086861;5692.686902220417;5071.695698258116;5482.506574408322;5511.641743286674;5531.8893622128135;5546.417626149358 15:22:29 INFO - PROCESS | 1638 | |5;yui.html;737.1920315882818;756.8070142113756;790.5533373643891;856.2422256303172;866.2030931542981;15141.167235802026;15758.527244182678;15791.447299344525;15802.288896999635;15874.444394446196;14535.636609084751;14549.92725036376;14676;14684.412623495075;14688.853111468881;706.159669992707;725.7604990353198;874.5321253129576;882.8808110905042;887.6050157679836;722.3931897206346;864.6022829498438;874.4490970688457;883.8188171424842;897.8473659477871;965.0108638645374;965.2760429677742;966.7583104223944;966.8259713251612;966.9991558736709;960.4813400763579;960.500539719349;960.851068084448;960.9903900961041;961.6489981156863;714.2286330762764;714.8534550417152;715.7101373943509;716.2372073741449;716.9533980291317;15384.923075384664;15629.531114066596;15631.98392104521;15742.449014284559;15891.920540397225;13631.977601679913;14733.631659208499;15082.321295541617;15179.544613661608;15386.307616157299;9677.419354838732;10396.480175991246;11569.36368499732;12028.578999735055;12077.15459917806;3728.6830619397383;3876.7867767272787;3880.185161116169;3966.603339666039;4046.3728122141115;68841.65579172072;80930;102492;104104;105618.94381056244;8681;10795.190360722978;11151.052160566443;11161.665150045512;11175.38535380562;22171.113155473602;22175.223867164896;22178.22376216857;22228.444288892908;22487.32538023862;7554.206808285051;7795.259450352208;7852.175521570267;7862.567558784322;8056.8388632227025;4310.612044915973;4322.8703138905885;4406.867793966187;4493;4567.109413664303;3594.946075808865;3654.9817250913575;3674.283514714605;3687.760295580779;3688.4098544232793;657.7369052378991;681.6591704147926;685.6914388525183;687.9484038697118;699.5697645947705;649.1528555235369;670.4904272752743;670.5741853922794;671.4963777167125;688.7589985819592;8188.672453101809;9583.472908989934;9954.153896918699;10102.141317988053;10275.02387273208;643.3116565275204;679.0154276299386;689.4932224814758;689.8199301221365;703.3529153179087;4580.725156490621;4832.782524786393;4833.250846118857;4841.026860466299;4882.926756098661;101483.49258253809;102073.48963255285;102991;103516.44725329126;108460.45769771258;90314.54842725876;90496;91805;93028;93416.53291733497;58867.70566147142;60418;65478.02975732097;78935.0532473374;80506;10733.516991735234;11046.558137674403;11218.439078046229;11302.830457543309;11331.830022549504;46986.76506617445;46992.59022229339;47610.76194619144;47850;48566.75716621536;61089.77820443655;61517.69241153765;63021.05468417886;63153.15810788434;63267.683661581395;13024;13062.673433164247;13129.212247265195;13488.5279015234;13604;14624.34190461453;14733.778993314894;14903.32935017905;14988.100713957198;15103.129728437918;13414;13440.731185376433;13904.72190556163;13925.442982280596;14350.896306328017;13260.2098716672;13804.17174969505;14028.22844743549;14038.78941815853;14044.087134336236;12720.87279127197;13602.984956138594;13604.727905442034;13744.931275343959;13816.723665526833;9369.812603748023;9519.333646644669;9969.850452243367;9982.450965196693;10091.293609447563;10136;10419.322744021614;10645.361278323326;10663.253572249869;10671.452639367404 15:22:29 INFO - PROCESS | 1638 | __end_tp_report 15:22:29 INFO - PROCESS | 1638 | __start_cc_report 15:22:29 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1427 15:22:29 INFO - PROCESS | 1638 | __end_cc_report 15:22:29 INFO - PROCESS | 1638 | __startTimestamp1491603749805__endTimestamp 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | ------- Summary: start ------- 15:22:29 INFO - PROCESS | 1638 | Number of tests: 6 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5867.79 Median:6206.04 stddev:660.94 (10.6%) stddev-sans-first:634.83 15:22:29 INFO - PROCESS | 1638 | Values: 3435.4 3462.4 3463.9 3496.2 3533.5 5844.3 5898.1 5909.7 5912.6 5917.1 5826.9 5875.9 5879.4 5915.1 5919.6 4130.3 4870.4 5275.8 5279.3 5362.1 5232.1 5234.1 5244.0 5369.9 5376.2 5242.3 5285.4 5286.8 5332.1 5365.5 5313.8 5330.5 5340.2 5340.4 5361.6 5158.6 5236.3 5294.5 5323.5 5342.9 4760.8 5711.6 5768.4 5771.3 5772.8 6250.1 6275.2 6288.1 6325.5 6334.4 6277.8 6309.8 6313.4 6325.1 6331.3 6052.8 6061.1 6070.6 6071.7 6077.0 6284.6 6315.3 6335.5 6467.2 6486.4 6262.2 6306.1 6311.2 6314.3 6321.8 6285.3 6319.4 6339.0 6339.9 6360.3 6203.1 6275.8 6303.9 6313.7 6337.3 6254.2 6270.1 6272.8 6272.9 6286.2 5154.1 5155.6 5160.3 5165.1 5184.3 4560.9 4562.5 4576.2 4612.1 4633.4 5775.3 5804.4 5820.5 5858.4 5958.3 6211.9 6233.2 6255.5 6270.6 6346.3 6025.8 6027.8 6047.2 6059.8 6078.5 5476.6 5563.0 5589.8 5594.1 5612.6 6435.6 6438.2 6472.3 6486.6 6574.3 6321.0 6323.5 6346.6 6388.8 6421.3 6500.7 6544.1 6553.9 6564.9 6583.8 6206.0 6234.4 6235.0 6251.1 6267.1 6319.4 6323.9 6333.1 6338.0 6338.8 6263.8 6289.2 6304.7 6307.5 6318.6 6147.0 6213.1 6216.6 6233.3 6236.1 5155.4 6229.1 6236.3 6249.0 6266.5 6282.8 6283.9 6286.1 6301.6 6302.7 6038.2 6123.8 6131.6 6137.4 6249.2 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:72532.92 Median:35683.88 stddev:158857.80 (445.2%) stddev-sans-first:159211.35 15:22:29 INFO - PROCESS | 1638 | Values: 489.9 501.2 526.6 534.4 546.2 31878.7 41430.2 43019.8 43051.4 43148.0 43491.9 44230.3 44623.6 44644.3 44761.3 8800.9 9584.5 9742.1 9756.2 9780.0 8958.8 11674.9 11897.1 11950.1 12086.3 11843.9 11880.5 11881.0 11894.0 11915.2 11915.6 11990.6 11999.8 12006.2 12018.5 11773.7 11850.9 11860.1 11864.1 11866.5 41913.2 42252.0 42321.6 42395.0 42448.9 4032.2 4058.7 4102.1 4103.5 4129.1 25444.5 29545.4 30518.5 31288.2 32396.8 3279.8 3358.3 3358.4 3379.4 3509.1 498878.5 499932.0 502779.0 503159.0 503200.0 60452.4 60827.7 60850.4 60938.1 60987.0 62013.0 62153.8 62230.4 62250.7 62385.7 16557.3 16777.0 16814.7 16847.3 16907.1 11846.8 12229.9 12691.2 12761.5 13052.3 16431.8 18387.1 18555.9 18792.2 18916.0 7849.0 7901.6 7905.0 8041.4 8062.5 792.6 793.2 874.2 887.5 912.8 28539.6 28924.3 30330.7 30567.4 30665.8 992.3 1030.9 1090.4 1130.6 1240.5 15905.1 16151.5 16213.2 16389.2 16488.1 647112.8 654831.0 655241.0 655953.0 657556.0 64213.0 64662.0 64800.0 64819.0 64898.4 1346.0 1402.7 1471.2 1488.2 1512.3 27416.3 29845.9 32603.7 32681.5 33311.8 52214.2 54847.0 56050.7 56310.9 58617.7 611305.0 617413.0 617739.0 617918.0 618492.0 32785.7 35471.3 41964.2 42384.9 42701.4 37534.2 44983.0 45188.3 45667.0 45742.5 30387.8 31020.7 31101.2 31707.2 32237.5 30902.5 30996.8 31002.5 31790.7 32125.4 35896.5 36602.3 37177.8 37231.3 37353.3 30103.8 30647.1 30682.4 31801.5 32065.9 23696.1 24546.8 24590.3 24934.6 25038.7 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:41743.75 Median:29786.90 stddev:117314.58 (393.8%) stddev-sans-first:117602.61 15:22:29 INFO - PROCESS | 1638 | Values: 399.8 406.1 409.1 413.6 431.5 20851.7 20903.8 22126.0 22278.6 22377.8 16504.8 17714.7 21406.0 21632.5 22092.9 5291.0 5930.4 6124.1 6201.5 6203.1 5797.9 5957.0 6021.8 6029.4 6032.7 5977.8 5981.1 5983.7 5986.3 7615.9 7931.2 7963.1 8095.0 8174.3 8179.4 7956.8 8003.1 8115.1 8119.4 8128.7 25417.9 27213.7 28669.7 29516.6 30057.2 3221.4 3327.3 3387.7 3471.7 3573.2 16356.4 16676.8 16685.7 16710.9 16838.9 1743.8 2094.4 2112.0 2124.5 2392.6 161430.0 162031.0 165873.3 170096.0 178057.0 19910.8 20200.6 21840.6 22806.5 24130.6 41558.8 41571.6 42431.8 42442.0 42808.4 8578.6 8765.2 9084.2 9159.6 9210.3 8956.8 8964.9 8972.0 9139.0 9168.8 4808.1 4894.1 4901.3 4965.3 4985.8 1856.6 1989.5 2038.3 2076.5 2086.4 878.3 967.4 1012.7 1051.0 1091.5 19240.9 21092.9 21448.2 21495.2 21807.1 977.8 1051.1 1056.4 1081.0 1084.8 10605.8 10893.0 10958.7 10970.3 10979.5 671956.0 675371.0 695863.0 719268.0 720704.0 152312.0 156483.0 156768.0 159915.0 161347.0 997.0 1012.9 1035.4 1036.1 1040.4 17974.6 18496.8 18691.3 18744.9 18748.0 43303.0 58419.0 58665.0 59230.7 59525.0 73604.0 85904.0 88839.1 89899.1 90578.6 8088.6 8103.9 8191.3 8488.8 8619.4 9351.7 11888.2 12430.4 12832.6 12862.0 10918.7 11086.2 11149.7 11319.7 11352.2 5028.8 7370.6 10265.5 10437.2 10689.9 10953.6 11212.3 11440.9 11441.4 11982.2 8233.3 8328.8 8377.4 8766.6 8772.1 8385.5 11054.1 11071.3 11236.1 11537.9 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5461.95 Median:5127.86 stddev:2975.56 (58.0%) stddev-sans-first:2968.08 15:22:29 INFO - PROCESS | 1638 | Values: 1377.7 1474.1 1477.8 1494.2 1496.0 6780.9 7638.9 7981.6 8532.7 8586.2 8425.2 8496.9 8511.9 8512.1 8513.7 1976.5 2362.0 2402.0 2403.6 2403.9 2140.7 2218.2 2350.9 2422.2 2426.9 2382.8 2410.8 2412.2 2420.3 2429.8 1989.4 2352.0 2366.8 2372.3 2375.8 2391.5 2393.5 2410.0 2420.4 2423.6 8395.5 8562.7 8573.2 8584.9 8585.5 4270.5 5322.0 5322.1 5322.9 5332.1 2980.3 3023.8 3537.0 3613.4 3672.7 1215.8 1240.5 1265.3 1302.3 1303.9 11104.1 11106.6 11120.6 11125.3 11139.5 4683.7 4795.7 4826.7 4847.4 4849.9 8832.0 8846.4 8852.6 8863.8 8904.0 5263.7 5269.5 5273.1 5273.7 5285.5 4191.2 4825.3 4931.8 4960.5 5022.8 3129.8 3557.5 3663.8 3768.5 3782.2 1177.6 1180.4 1180.5 1184.9 1192.1 677.3 754.6 780.1 806.8 827.5 4524.8 5559.8 5744.6 5783.5 5869.7 994.8 998.3 1013.6 1014.4 1042.7 3747.4 3857.6 3867.0 3942.3 3987.2 9839.2 10099.1 10229.3 10229.9 10280.0 10190.8 10194.2 10202.4 10203.4 10242.9 6656.0 7776.6 7779.1 7794.3 7940.5 5550.4 5638.1 5697.7 5788.5 5933.3 8876.3 9258.2 9386.6 9425.7 9468.4 8579.0 9040.5 9250.6 9419.0 9573.8 7758.2 7843.6 7905.1 7924.7 7946.0 7204.5 7448.5 7453.2 7696.2 7876.3 6843.3 6915.8 7014.0 7062.0 7132.7 6570.3 6894.2 6954.7 6972.3 7005.9 6463.5 6538.5 6540.5 6543.9 6546.4 4909.2 4945.0 4949.3 5076.8 5215.9 4803.6 5030.7 5083.4 5172.3 5176.0 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4508.09 Median:4974.16 stddev:1357.56 (27.3%) stddev-sans-first:1325.30 15:22:29 INFO - PROCESS | 1638 | Values: 366.5 372.5 377.4 382.4 382.5 5426.1 5428.1 5428.5 5477.5 5565.6 4683.3 5049.2 5214.5 5216.9 5343.9 3644.4 3650.8 4110.2 4119.4 4177.5 4135.7 4149.5 4195.9 4197.7 4200.6 3198.8 4042.0 4054.9 4130.8 4184.4 3392.7 4118.4 4141.9 4159.3 4162.6 3699.2 3709.2 3727.3 3732.8 3734.4 4983.6 5212.3 5236.7 5252.7 5284.5 4795.2 4806.4 4822.8 4841.8 4843.7 4887.0 5525.2 5538.0 5628.5 5635.9 4113.0 4115.3 4121.8 4135.6 4172.0 5431.0 5458.1 5520.9 5881.3 5887.7 3869.2 3896.4 3905.1 3907.3 3908.8 3366.4 3564.9 3978.4 3981.8 3988.0 4347.8 4393.8 4438.0 4438.7 4541.8 5229.0 5422.6 5634.3 5654.7 5735.4 1155.1 1284.8 1295.7 1304.2 1309.0 705.6 842.5 847.5 858.8 876.9 4579.4 4583.7 4802.2 4963.4 4964.7 4657.0 4726.9 5440.9 5474.4 5475.7 4862.9 4879.5 4945.2 4946.5 5208.5 2383.7 2695.1 2839.6 2877.0 2896.0 4734.6 5168.7 5571.0 5731.3 5746.6 4909.7 5198.9 5251.2 5616.4 5670.8 4669.5 5271.7 5446.4 5742.3 5745.5 5404.0 5442.3 5477.4 5482.9 5519.5 5225.2 5697.5 5705.7 5730.0 5736.2 5140.5 5846.7 6000.8 6015.1 6019.4 3769.9 3904.9 3921.1 3930.2 3939.2 5362.5 5698.8 5752.2 5757.3 5802.5 4300.9 5635.5 5641.9 5649.5 5653.8 4649.9 5302.9 5543.7 5596.5 5654.8 4278.7 4333.8 5057.2 5267.8 5532.9 4585.5 5494.9 5546.7 5634.7 5692.7 5071.7 5482.5 5511.6 5531.9 5546.4 15:22:29 INFO - PROCESS | 1638 | 15:22:29 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:19821.39 Median:4364.87 stddev:27952.08 (640.4%) stddev-sans-first:27993.76 15:22:29 INFO - PROCESS | 1638 | Values: 737.2 756.8 790.6 856.2 866.2 15141.2 15758.5 15791.4 15802.3 15874.4 14535.6 14549.9 14676.0 14684.4 14688.9 706.2 725.8 874.5 882.9 887.6 722.4 864.6 874.4 883.8 897.8 965.0 965.3 966.8 966.8 967.0 960.5 960.5 960.9 961.0 961.6 714.2 714.9 715.7 716.2 717.0 15384.9 15629.5 15632.0 15742.4 15891.9 13632.0 14733.6 15082.3 15179.5 15386.3 9677.4 10396.5 11569.4 12028.6 12077.2 3728.7 3876.8 3880.2 3966.6 4046.4 68841.7 80930.0 102492.0 104104.0 105618.9 8681.0 10795.2 11151.1 11161.7 11175.4 22171.1 22175.2 22178.2 22228.4 22487.3 7554.2 7795.3 7852.2 7862.6 8056.8 4310.6 4322.9 4406.9 4493.0 4567.1 3594.9 3655.0 3674.3 3687.8 3688.4 657.7 681.7 685.7 687.9 699.6 649.2 670.5 670.6 671.5 688.8 8188.7 9583.5 9954.2 10102.1 10275.0 643.3 679.0 689.5 689.8 703.4 4580.7 4832.8 4833.3 4841.0 4882.9 101483.5 102073.5 102991.0 103516.4 108460.5 90314.5 90496.0 91805.0 93028.0 93416.5 58867.7 60418.0 65478.0 78935.1 80506.0 10733.5 11046.6 11218.4 11302.8 11331.8 46986.8 46992.6 47610.8 47850.0 48566.8 61089.8 61517.7 63021.1 63153.2 63267.7 13024.0 13062.7 13129.2 13488.5 13604.0 14624.3 14733.8 14903.3 14988.1 15103.1 13414.0 13440.7 13904.7 13925.4 14350.9 13260.2 13804.2 14028.2 14038.8 14044.1 12720.9 13603.0 13604.7 13744.9 13816.7 9369.8 9519.3 9969.9 9982.5 10091.3 10136.0 10419.3 10645.4 10663.3 10671.5 15:22:29 INFO - PROCESS | 1638 | -------- Summary: end -------- 15:22:29 INFO - PROCESS | 1638 | 15:22:30 INFO - TEST-INFO | 1638: exit 0 15:22:30 INFO - TEST-OK | dromaeo_css | took 1116749ms 15:22:30 INFO - TEST-START | kraken 15:22:30 INFO - operating with platform_type : mac_ 15:22:30 INFO - Initialising browser for kraken test... 15:22:30 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpQIoZcJ/profile http://localhost:49240/getInfo.html) 15:22:32 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 15:22:32 INFO - PROCESS | 1647 | colorDepth:24 15:22:32 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 15:22:32 INFO - PROCESS | 1647 | __metrics 15:22:32 INFO - PROCESS | 1647 | 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" 15:22:32 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:22:33 INFO - TEST-INFO | 1647: exit 0 15:22:33 INFO - Browser initialized. 15:22:33 INFO - Running cycle 1/1 for kraken test... 15:22:33 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpQIoZcJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:45 INFO - PROCESS | 1648 | RSS: Main: 163807232 15:22:45 INFO - PROCESS | 1648 | 15:22:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:49 INFO - PROCESS | 1648 | RSS: Main: 214466560 15:22:49 INFO - PROCESS | 1648 | 15:22:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 15:22:52 INFO - PROCESS | 1648 | RSS: Main: 227237888 15:22:52 INFO - PROCESS | 1648 | 15:22:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 15:22:56 INFO - PROCESS | 1648 | RSS: Main: 324362240 15:22:56 INFO - PROCESS | 1648 | 15:22:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 15:22:58 INFO - PROCESS | 1648 | RSS: Main: 228331520 15:22:58 INFO - PROCESS | 1648 | 15:23:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:23:01 INFO - PROCESS | 1648 | RSS: Main: 230244352 15:23:01 INFO - PROCESS | 1648 | 15:23:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 15:23:04 INFO - PROCESS | 1648 | RSS: Main: 269713408 15:23:04 INFO - PROCESS | 1648 | 15:23:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 15:23:08 INFO - PROCESS | 1648 | RSS: Main: 270630912 15:23:08 INFO - PROCESS | 1648 | 15:23:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 15:23:11 INFO - PROCESS | 1648 | RSS: Main: 267223040 15:23:11 INFO - PROCESS | 1648 | 15:23:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:23:13 INFO - PROCESS | 1648 | RSS: Main: 244408320 15:23:13 INFO - PROCESS | 1648 | 15:23:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:23:16 INFO - PROCESS | 1648 | RSS: Main: 245022720 15:23:16 INFO - PROCESS | 1648 | 15:23:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:23:19 INFO - PROCESS | 1648 | RSS: Main: 255299584 15:23:19 INFO - PROCESS | 1648 | 15:23:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:23:22 INFO - PROCESS | 1648 | RSS: Main: 269553664 15:23:22 INFO - PROCESS | 1648 | 15:23:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:26 INFO - PROCESS | 1648 | RSS: Main: 263249920 15:23:26 INFO - PROCESS | 1648 | 15:23:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 15:23:28 INFO - PROCESS | 1648 | RSS: Main: 307838976 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | __start_tp_report 15:23:28 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 15:23:28 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 15:23:28 INFO - PROCESS | 1648 | |i|pagename|runs| 15:23:28 INFO - PROCESS | 1648 | |0;ai-astar;103;113;112;117;161;169;111;112;113;112 15:23:28 INFO - PROCESS | 1648 | |1;audio-beat-detection;142;107;106;141;106;104;106;105;127;113 15:23:28 INFO - PROCESS | 1648 | |2;audio-dft;184;185;182;183;182;183;182;182;183;183 15:23:28 INFO - PROCESS | 1648 | |3;audio-fft;81;58;59;89;59;59;59;73;96;81 15:23:28 INFO - PROCESS | 1648 | |4;audio-oscillator;84;71;88;69;67;68;80;67;68;81 15:23:28 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;86;89;91;90;86;89;86;88;87 15:23:28 INFO - PROCESS | 1648 | |6;imaging-darkroom;97;98;97;98;97;97;98;98;97;96 15:23:28 INFO - PROCESS | 1648 | |7;imaging-desaturate;80;85;84;84;84;82;82;86;85;86 15:23:28 INFO - PROCESS | 1648 | |8;json-parse-financial;52;50;53;52;54;56;56;54;55;54 15:23:28 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;67;80;72;75;71;68;70;69;69;71 15:23:28 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;81;83;82;82;82;85;87;100;103;83 15:23:28 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;134;132;134;141;143;127;136;131;193;172 15:23:28 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;162;163;162;161;160;162;162;161;162;164 15:23:28 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;65;64;66;64;66;63;63;65;63;63 15:23:28 INFO - PROCESS | 1648 | __end_tp_report 15:23:28 INFO - PROCESS | 1648 | __start_cc_report 15:23:28 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1977 15:23:28 INFO - PROCESS | 1648 | __end_cc_report 15:23:28 INFO - PROCESS | 1648 | __startTimestamp1491603808169__endTimestamp 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | ------- Summary: start ------- 15:23:28 INFO - PROCESS | 1648 | Number of tests: 14 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:122.30 Median:113.00 stddev:22.85 (20.2%) stddev-sans-first:23.14 15:23:28 INFO - PROCESS | 1648 | Values: 103.0 113.0 112.0 117.0 161.0 169.0 111.0 112.0 113.0 112.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:110.00 stddev:15.19 (13.8%) stddev-sans-first:12.78 15:23:28 INFO - PROCESS | 1648 | Values: 142.0 107.0 106.0 141.0 106.0 104.0 106.0 105.0 127.0 113.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:0.99 (0.5%) stddev-sans-first:0.97 15:23:28 INFO - PROCESS | 1648 | Values: 184.0 185.0 182.0 183.0 182.0 183.0 182.0 182.0 183.0 183.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:71.40 Median:77.00 stddev:14.52 (18.9%) stddev-sans-first:14.97 15:23:28 INFO - PROCESS | 1648 | Values: 81.0 58.0 59.0 89.0 59.0 59.0 59.0 73.0 96.0 81.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:75.50 stddev:8.06 (10.7%) stddev-sans-first:7.74 15:23:28 INFO - PROCESS | 1648 | Values: 84.0 71.0 88.0 69.0 67.0 68.0 80.0 67.0 68.0 81.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.50 stddev:1.76 (2.0%) stddev-sans-first:1.87 15:23:28 INFO - PROCESS | 1648 | Values: 88.0 86.0 89.0 91.0 90.0 86.0 89.0 86.0 88.0 87.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:97.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:23:28 INFO - PROCESS | 1648 | Values: 97.0 98.0 97.0 98.0 97.0 97.0 98.0 98.0 97.0 96.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.50 stddev:1.93 (2.3%) stddev-sans-first:1.48 15:23:28 INFO - PROCESS | 1648 | Values: 80.0 85.0 84.0 84.0 84.0 82.0 82.0 86.0 85.0 86.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.90 (3.5%) stddev-sans-first:1.92 15:23:28 INFO - PROCESS | 1648 | Values: 52.0 50.0 53.0 52.0 54.0 56.0 56.0 54.0 55.0 54.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:3.82 (5.4%) stddev-sans-first:3.74 15:23:28 INFO - PROCESS | 1648 | Values: 67.0 80.0 72.0 75.0 71.0 68.0 70.0 69.0 69.0 71.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:82.50 stddev:7.97 (9.7%) stddev-sans-first:8.17 15:23:28 INFO - PROCESS | 1648 | Values: 81.0 83.0 82.0 82.0 82.0 85.0 87.0 100.0 103.0 83.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:138.50 stddev:21.24 (15.3%) stddev-sans-first:22.20 15:23:28 INFO - PROCESS | 1648 | Values: 134.0 132.0 134.0 141.0 143.0 127.0 136.0 131.0 193.0 172.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 15:23:28 INFO - PROCESS | 1648 | Values: 162.0 163.0 162.0 161.0 160.0 162.0 162.0 161.0 162.0 164.0 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.23 (1.9%) stddev-sans-first:1.27 15:23:28 INFO - PROCESS | 1648 | Values: 65.0 64.0 66.0 64.0 66.0 63.0 63.0 65.0 63.0 63.0 15:23:28 INFO - PROCESS | 1648 | -------- Summary: end -------- 15:23:28 INFO - PROCESS | 1648 | 15:23:28 INFO - TEST-INFO | 1648: exit 0 15:23:29 INFO - TEST-OK | kraken | took 58595ms 15:23:29 INFO - SUITE-END | took 1175s 15:23:29 INFO - Completed test suite (00:19:35) 15:23:29 INFO - javascript benchmark 15:23:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3435.415979283522, 3462.4460086386184, 3463.948040779387, 3496.1958749487603, 3533.5406397168363, 5844.26946631671, 5898.056310990242, 5909.704514774266, 5912.645241285526, 5917.0828521579115, 5826.883462330761, 5875.8531036724, 5879.382664820197, 5915.112733090039, 5919.556033297509, 4130.277201489727, 4870.366852309195, 5275.815346462875, 5279.260903473507, 5362.115250983583, 5232.084385232588, 5234.110201265775, 5244.003639308538, 5369.865753356178, 5376.247325374431, 5242.292290540767, 5285.365756109272, 5286.788528458857, 5332.120200166968, 5365.490278423563, 5313.787448502056, 5330.493603107699, 5340.225667278261, 5340.385855626614, 5361.571074314045, 5158.613104017214, 5236.319278493809, 5294.549963253128, 5323.467653234684, 5342.866428339323, 4760.833370832039, 5711.600187986843, 5768.3654797972185, 5771.278590176228, 5772.826815195509, 6250.124982502453, 6275.18422605063, 6288.088227207075, 6325.525585581054, 6334.4299013088585, 6277.780277690259, 6309.779157729457, 6313.43179113882, 6325.114483972247, 6331.303556608769, 6052.788152414689, 6061.121137435091, 6070.57505974582, 6071.666058366833, 6076.99729544629, 6284.591501552384, 6315.336889626615, 6335.479484923678, 6467.223933128054, 6486.35136486357, 6262.2172228471445, 6306.054091886253, 6311.179546658905, 6314.305426403092, 6321.778737744157, 6285.277193122758, 6319.368063193644, 6339.017452294902, 6339.936600633934, 6360.300366959631, 6203.100550420164, 6275.780347687901, 6303.905441418382, 6313.715882785285, 6337.271213810379, 6254.186955695731, 6270.059491076375, 6272.780452684134, 6272.937270627235, 6286.151369565142, 5154.098032844237, 5155.587552995751, 5160.277561141444, 5165.1219292720325, 5184.300119483897, 4560.88597785058, 4562.498125206224, 4576.244919588297, 4612.0545288215835, 4633.4208223972, 5775.306963164448, 5804.448577385142, 5820.476157145792, 5858.443447872445, 5958.344582095966, 6211.9068213976825, 6233.158523599347, 6255.499560035186, 6270.59241149333, 6346.333634968262, 6025.78909738157, 6027.758889644453, 6047.15339852421, 6059.757609695563, 6078.54410919174, 5476.58925580583, 5562.972185139049, 5589.832305030855, 5594.0769772987005, 5612.579056570692, 6435.646039467781, 6438.227412710411, 6472.288048314776, 6486.578372405778, 6574.342565743387, 6320.968395157995, 6323.4625056868845, 6346.587471814318, 6388.8083357499345, 6421.293657697556, 6500.689497239454, 6544.116544266463, 6553.901691474727, 6564.901526477011, 6583.769568065095, 6206.038064100072, 6234.407731265523, 6235.0, 6251.062340648939, 6267.059941008885, 6319.431251187415, 6323.905141422974, 6333.113364129118, 6338.0, 6338.778142764981, 6263.78076767311, 6289.213848268966, 6304.684765761602, 6307.495400367868, 6318.589291696025, 6147.047207682637, 6213.130161777445, 6216.595921265103, 6233.283172435228, 6236.126942228001, 5155.407128180307, 6229.0967809668255, 6236.282827474898, 6249.031400132987, 6266.530010249341, 6282.780102696383, 6283.8580709645175, 6286.057091436322, 6301.558890877778, 6302.747890084529, 6038.215032045806, 6123.84690382744, 6131.601445906002, 6137.355577664281, 6249.187605611423], "value": 5825.83930080588, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.9216125419932, 501.2206019639459, 526.5655833937003, 534.401470353204, 546.1643685161702, 31878.68121318789, 41430.171396572085, 43019.78490107549, 43051.35422968658, 43148.0, 43491.91270218238, 44230.33654495185, 44623.55376446235, 44644.33033504492, 44761.32858007133, 8800.911990880106, 9584.472853993046, 9742.123208911196, 9756.170725488306, 9779.973102824208, 8958.776030599221, 11674.941625291862, 11897.107716921266, 11950.103742219324, 12086.274823510574, 11843.881561184407, 11880.524779008872, 11881.0, 11894.048476121932, 11915.2255103418, 11915.642530724092, 11990.580329688419, 11999.820002699878, 12006.21959572625, 12018.459169337313, 11773.705657358549, 11850.881491185064, 11860.11049171307, 11864.110191735654, 11866.52533898643, 41913.161736765396, 42252.0, 42321.57678423207, 42395.0, 42448.93877653052, 4032.213718324928, 4058.6753059755147, 4102.056526998807, 4103.4870641169855, 4129.112240868228, 25444.491110177692, 29545.40909181826, 30518.542221866468, 31288.21779455509, 32396.83801580977, 3279.8196099214774, 3358.2947581008016, 3358.4458564336855, 3379.3748156590864, 3509.0525558099425, 498878.50560747326, 499932.00067998853, 502779.0, 503158.9684103149, 503199.99999999633, 60452.39547604468, 60827.695861520406, 60850.39149608536, 60938.0859287111, 60987.0, 62013.0, 62153.75692486125, 62230.37769622336, 62250.68874655688, 62385.68807155935, 16557.337706491846, 16777.0, 16814.663706725798, 16847.326106955585, 16907.07011114376, 11846.822297665542, 12229.899309062228, 12691.238525688488, 12761.489540418279, 13052.34738263083, 16431.835681643268, 18387.08064596765, 18555.886646801235, 18792.154353054146, 18916.0, 7849.0, 7901.565413902291, 7905.0, 8041.437099402986, 8062.516249025077, 792.6274650914061, 793.2266040610359, 874.191372979991, 887.5296093070683, 912.7991841794794, 28539.57302134885, 28924.276893077422, 30330.696693033227, 30567.38865222683, 30665.84667076695, 992.3153024413132, 1030.8814486334018, 1090.4057288777635, 1130.6042884990352, 1240.5409998300506, 15905.125218113115, 16151.515454536382, 16213.189340532927, 16389.205248823968, 16488.0931548766, 647112.7644361842, 654831.0, 655241.0, 655953.0, 657556.0, 64213.0, 64662.0, 64800.0, 64819.0, 64898.351016490175, 1345.9663508412368, 1402.691407890242, 1471.1687896338535, 1488.151753500516, 1512.3194562446943, 27416.314592135357, 29845.85077074601, 32603.673963260062, 32681.509777352883, 33311.83408580688, 52214.21678674899, 54847.0, 56050.71974640101, 56310.87378252494, 58617.70691146517, 611305.0, 617413.0, 617739.0, 617918.0, 618492.0, 32785.672143278265, 35471.29057418889, 41964.16071678611, 42384.940376490835, 42701.35947960721, 37534.249315013, 44983.0, 45188.322175166744, 45667.0, 45742.542574573825, 30387.848060759556, 31020.689793102683, 31101.222469438446, 31707.20731981719, 32237.51643725299, 30902.53646195354, 30996.845015774776, 31002.534961976038, 31790.682093178773, 32125.35749285048, 35896.46155307725, 36602.26795464129, 37177.81411092927, 37231.25537489289, 37353.252934941695, 30103.84948075333, 30647.080587582408, 30682.386352273275, 31801.5229771549, 32065.869460886148, 23696.05215791349, 24546.754532454448, 24590.262292131265, 24934.625980609944, 25038.74961250364], "value": 20704.54064465079, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.80259123923855, 406.12074857932566, 409.104062103992, 413.56988731719, 431.5210116770384, 20851.687224691625, 20903.790962090374, 22126.0, 22278.55442891145, 22377.776222237793, 16504.75242871355, 17714.734278985794, 21406.0, 21632.512261089978, 22092.8895355523, 5291.0, 5930.436608522184, 6124.133541515404, 6201.534884883652, 6203.131561581382, 5797.884042319151, 5956.97021514894, 6021.849453763669, 6029.427204415573, 6032.728527216286, 5977.790777322794, 5981.072933695263, 5983.700814959257, 5986.311574168961, 7615.923840761577, 7931.167227441093, 7963.084245311777, 8095.02859656842, 8174.34605231583, 8179.386546009073, 7956.801079972989, 8003.079645840745, 8115.14790946948, 8119.350451963829, 8128.715494957648, 25417.872910635513, 27213.727862721316, 28669.713302866912, 29516.557251641243, 30057.248568785737, 3221.371832492665, 3327.317899830529, 3387.7120444762227, 3471.6701913318193, 3573.160307327776, 16356.427525036686, 16676.83323166765, 16685.66628667432, 16710.916445417817, 16838.915805421017, 1743.755874177616, 2094.392626138433, 2111.9788802111934, 2124.511362386644, 2392.5812982727953, 161430.0, 162031.0, 165873.341266587, 170096.0, 178057.0, 19910.805351678944, 20200.58595898273, 21840.563188736138, 22806.543869122524, 24130.638040429407, 41558.79220603938, 41571.584284157376, 42431.7878410606, 42442.0, 42808.3578746319, 8578.613962371708, 8765.211130998241, 9084.183163367354, 9159.633614655339, 9210.309226808016, 8956.820863582692, 8964.907107048059, 8971.955140224387, 9139.0, 9168.81662366749, 4808.0624278266105, 4894.11905856942, 4901.289313049588, 4965.255211718271, 4985.800567977313, 1856.5637075287298, 1989.4979290635476, 2038.2967876082728, 2076.4705000224844, 2086.35323049855, 878.3412440669371, 967.3905439573165, 1012.696191142669, 1050.9579616815395, 1091.5470079916904, 19240.903795481212, 21092.894535527223, 21448.24931127403, 21495.191851848318, 21807.127714891227, 977.8484334928097, 1051.0960573906586, 1056.392574269798, 1080.9729756756144, 1084.772197838447, 10605.84091238632, 10892.997287926797, 10958.726031849108, 10970.341779493256, 10979.451027448597, 671956.0, 675371.0, 695863.0, 719268.0, 720704.0, 152312.0, 156483.0, 156768.0, 159915.0, 161347.0, 996.9860881020443, 1012.9442880641489, 1035.409816404642, 1036.103770238738, 1040.422565476168, 17974.5506362342, 18496.797708148926, 18691.252349906394, 18744.906275468536, 18748.0, 43303.0, 58419.0, 58665.0, 59230.70384648222, 59525.0, 73604.0, 85904.0, 88839.11160888567, 89899.1010089917, 90578.64132038156, 8088.595570221348, 8103.87844182326, 8191.262786349257, 8488.830223395375, 8619.353548484014, 9351.672691455766, 11888.227265227733, 12430.440630171483, 12832.55086071983, 12862.0, 10918.72703182395, 11086.168537359892, 11149.665510034712, 11319.660410187707, 11352.205345625727, 5028.798848046037, 7370.562740265596, 10265.538050787583, 10437.217208709226, 10689.9465502672, 10953.616623418142, 11212.327260364404, 11440.913113254228, 11441.42792860337, 11982.221155624857, 8233.34133269325, 8328.750137495885, 8377.371697122619, 8766.561671916506, 8772.122787721177, 8385.454945428528, 11054.060404865677, 11071.280366776135, 11236.101111910864, 11537.88462115368], "value": 10940.714840356359, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.6762460821699, 1474.1302631447443, 1477.8300495443025, 1494.2304713072765, 1495.970080598388, 6780.8982865257, 7638.885416718754, 7981.600919954001, 8532.744017679464, 8586.184312490303, 8425.241728244457, 8496.872546911802, 8511.936007999, 8512.10622884596, 8513.702020429286, 1976.505873531617, 2362.0197617988515, 2402.0, 2403.5553422616786, 2403.9158629447975, 2140.67889816528, 2218.2125345502354, 2350.8707021113833, 2422.200673777658, 2426.8786560671897, 2382.8093752499844, 2410.7950824179966, 2412.1798588479915, 2420.3102115896972, 2429.8177636677233, 1989.3634037108131, 2352.0121548949483, 2366.751491093436, 2372.3238876919995, 2375.7527298168425, 2391.5216956608574, 2393.4734358441115, 2410.0480310277344, 2420.4190994161277, 2423.6001059825285, 8395.454295470836, 8562.657493700244, 8573.185547373052, 8584.8712269316, 8585.484870907703, 4270.508891477458, 5322.04203243416, 5322.1484562470205, 5322.893542129135, 5332.146856502941, 2980.2996295870453, 3023.818570885754, 3536.982315088408, 3613.403788374915, 3672.7245456590863, 1215.8115492098739, 1240.503798480615, 1265.2661456355384, 1302.2837439408288, 1303.9478420863154, 11104.111671066375, 11106.61126860556, 11120.61077862279, 11125.332480051224, 11139.498722557504, 4683.7423941682855, 4795.688280261772, 4826.734529600835, 4847.3698419205275, 4849.914536749232, 8831.984321803075, 8846.380753347205, 8852.601632926533, 8863.822723545492, 8903.976042755037, 5263.6578622389425, 5269.525742683177, 5273.1299335609965, 5273.736313184326, 5285.471452854684, 4191.161767646422, 4825.30033145192, 4931.778069986859, 4960.528749768766, 5022.799088036438, 3129.8122112673313, 3557.5197348358156, 3663.7984910829628, 3768.5477742671055, 3782.224643947984, 1177.587844254504, 1180.3861991764234, 1180.4569897846916, 1184.8933595976232, 1192.0642295797757, 677.34974424552, 754.5736658787768, 780.1301548773077, 806.8345989072226, 827.4962060732482, 4524.751138687404, 5559.777608895599, 5744.597878148573, 5783.508401785895, 5869.65947203964, 994.751312171957, 998.2962011781676, 1013.6097602423121, 1014.3812274512542, 1042.67677020124, 3747.4191500317493, 3857.61423857612, 3867.0, 3942.3495123304906, 3987.182627561343, 9839.163671087894, 10099.14157296638, 10229.28395012342, 10229.897701023043, 10279.97200279981, 10190.796184076426, 10194.184465242763, 10202.38785672862, 10203.38779673222, 10242.948785256174, 6655.966720166368, 7776.572288524186, 7779.144294127642, 7794.259545343183, 7940.483868548526, 5550.361708403585, 5638.069718496402, 5697.658140511582, 5788.450097240755, 5933.258342707161, 8876.289896808368, 9258.213051890665, 9386.577604007973, 9425.670101546413, 9468.431894086101, 8579.013413457282, 9040.457572545669, 9250.629974800933, 9418.963913969596, 9573.760655983657, 7758.185390533913, 7843.56860372685, 7905.090914544901, 7924.683012679428, 7946.0, 7204.53170543913, 7448.47860649771, 7453.180150183367, 7696.230376962483, 7876.330511906552, 6843.349881761424, 6915.792526224222, 7013.964930175316, 7062.0466237057335, 7132.679029443584, 6570.342965703391, 6894.24163342022, 6954.721811127701, 6972.337627925339, 7005.929940700732, 6463.450606698483, 6538.509611779231, 6540.50946179048, 6543.934560654333, 6546.443552298108, 4909.189983652657, 4945.0, 4949.282354058713, 5076.796928122833, 5215.921761173509, 4803.5916947059895, 5030.698158110378, 5083.440821509705, 5172.275881376686, 5175.9741201293755], "value": 4437.249477126144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.4978978799046, 372.48968912589754, 377.4451556212368, 382.420632741397, 382.5218476903872, 5426.1046927257, 5428.068842824875, 5428.511433970942, 5477.534409575186, 5565.638233514819, 4683.274092515657, 5049.238317453493, 5214.530692237698, 5216.921746173811, 5343.893122137555, 3644.4168932970665, 3650.8174591270463, 4110.239605672945, 4119.384191038682, 4177.4569305990335, 4135.669146468275, 4149.522804877448, 4195.85314513992, 4197.685173611976, 4200.621944025037, 3198.7760856740038, 4042.009707621622, 4054.9391759123637, 4130.80206740045, 4184.372344148372, 3392.6776956189124, 4118.361653943643, 4141.91716165678, 4159.2721273777115, 4162.583741625828, 3699.167687270343, 3709.2025214578725, 3727.347714150013, 3732.8320225589914, 3734.3672710738865, 4983.626228032912, 5212.270282160501, 5236.659617124913, 5252.658577192508, 5284.497972692588, 4795.184818580849, 4806.375171227753, 4822.807087716487, 4841.782119804582, 4843.685160464559, 4886.9511304886855, 5525.198846167284, 5538.037150124664, 5628.521575666074, 5635.887282254332, 4112.979435102805, 4115.32097203961, 4121.7634709587, 4135.60711732385, 4171.97914010428, 5431.0, 5458.124731440642, 5520.91718624221, 5881.264841894763, 5887.675273063526, 3869.200821617961, 3896.357101078347, 3905.1408690088133, 3907.316219661548, 3908.843646254118, 3366.377220214268, 3564.9341566253, 3978.3833505806647, 3981.770208683147, 3988.0, 4347.782620866163, 4393.846215382447, 4438.0, 4438.689291749546, 4541.84103556374, 5229.006488767122, 5422.566194704415, 5634.295713035871, 5654.6889921054735, 5735.447725762079, 1155.0825629455233, 1284.845818501767, 1295.727897141592, 1304.2174695182814, 1308.9803652945213, 705.5978092487336, 842.4650347029558, 847.5380917400032, 858.8153546987428, 876.8728534362482, 4579.382287992448, 4583.656225783013, 4802.231642937113, 4963.354763880672, 4964.702117872939, 4656.952185758245, 4726.929096063562, 5440.91838622421, 5474.39781624021, 5475.7262136893, 4862.902741945141, 4879.463259041502, 4945.184044632667, 4946.5053494650965, 5208.5051920067535, 2383.678203442548, 2695.124084672489, 2839.559868220429, 2876.985615071953, 2896.0443053792196, 4734.644901632391, 5168.689878607295, 5571.025070612708, 5731.340895797037, 5746.5977381583725, 4909.705417674951, 5198.948010519846, 5251.162093267326, 5616.438356164351, 5670.7731690732735, 4669.486356500782, 5271.65734227274, 5446.373667028342, 5742.31092268922, 5745.454181852718, 5404.0, 5442.285680010784, 5477.370102438112, 5482.860440367656, 5519.475649813261, 5225.216217567396, 5697.515711164431, 5705.657660540381, 5729.997250481232, 5736.196932429547, 5140.457862641268, 5846.742950265713, 6000.819975400745, 6015.097735339559, 6019.428154325332, 3769.8680546180753, 3904.882853514399, 3921.117748506563, 3930.213957208627, 3939.2380276836125, 5362.490563396471, 5698.782900653569, 5752.223449834386, 5757.251557297524, 5802.506786923159, 4300.913981720286, 5635.520980716685, 5641.915371269516, 5649.519790817662, 5653.830385088454, 4649.907001860011, 5302.8939421212135, 5543.695096769717, 5596.5242954347705, 5654.7842213924205, 4278.65770738334, 4333.761643109659, 5057.165567681292, 5267.762950667306, 5532.944670553243, 4585.541445855388, 5494.928488944617, 5546.72266386671, 5634.718264086861, 5692.686902220417, 5071.695698258116, 5482.506574408322, 5511.641743286674, 5531.8893622128135, 5546.417626149358], "value": 4086.3323564888774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.1920315882818, 756.8070142113756, 790.5533373643891, 856.2422256303172, 866.2030931542981, 15141.167235802026, 15758.527244182678, 15791.447299344525, 15802.288896999635, 15874.444394446196, 14535.636609084751, 14549.92725036376, 14676.0, 14684.412623495075, 14688.853111468881, 706.159669992707, 725.7604990353198, 874.5321253129576, 882.8808110905042, 887.6050157679836, 722.3931897206346, 864.6022829498438, 874.4490970688457, 883.8188171424842, 897.8473659477871, 965.0108638645374, 965.2760429677742, 966.7583104223944, 966.8259713251612, 966.9991558736709, 960.4813400763579, 960.500539719349, 960.851068084448, 960.9903900961041, 961.6489981156863, 714.2286330762764, 714.8534550417152, 715.7101373943509, 716.2372073741449, 716.9533980291317, 15384.923075384664, 15629.531114066596, 15631.98392104521, 15742.449014284559, 15891.920540397225, 13631.977601679913, 14733.631659208499, 15082.321295541617, 15179.544613661608, 15386.307616157299, 9677.419354838732, 10396.480175991246, 11569.36368499732, 12028.578999735055, 12077.15459917806, 3728.6830619397383, 3876.7867767272787, 3880.185161116169, 3966.603339666039, 4046.3728122141115, 68841.65579172072, 80930.0, 102492.0, 104104.0, 105618.94381056244, 8681.0, 10795.190360722978, 11151.052160566443, 11161.665150045512, 11175.38535380562, 22171.113155473602, 22175.223867164896, 22178.22376216857, 22228.444288892908, 22487.32538023862, 7554.206808285051, 7795.259450352208, 7852.175521570267, 7862.567558784322, 8056.8388632227025, 4310.612044915973, 4322.8703138905885, 4406.867793966187, 4493.0, 4567.109413664303, 3594.946075808865, 3654.9817250913575, 3674.283514714605, 3687.760295580779, 3688.4098544232793, 657.7369052378991, 681.6591704147926, 685.6914388525183, 687.9484038697118, 699.5697645947705, 649.1528555235369, 670.4904272752743, 670.5741853922794, 671.4963777167125, 688.7589985819592, 8188.672453101809, 9583.472908989934, 9954.153896918699, 10102.141317988053, 10275.02387273208, 643.3116565275204, 679.0154276299386, 689.4932224814758, 689.8199301221365, 703.3529153179087, 4580.725156490621, 4832.782524786393, 4833.250846118857, 4841.026860466299, 4882.926756098661, 101483.49258253809, 102073.48963255285, 102991.0, 103516.44725329126, 108460.45769771258, 90314.54842725876, 90496.0, 91805.0, 93028.0, 93416.53291733497, 58867.70566147142, 60418.0, 65478.02975732097, 78935.0532473374, 80506.0, 10733.516991735234, 11046.558137674403, 11218.439078046229, 11302.830457543309, 11331.830022549504, 46986.76506617445, 46992.59022229339, 47610.76194619144, 47850.0, 48566.75716621536, 61089.77820443655, 61517.69241153765, 63021.05468417886, 63153.15810788434, 63267.683661581395, 13024.0, 13062.673433164247, 13129.212247265195, 13488.5279015234, 13604.0, 14624.34190461453, 14733.778993314894, 14903.32935017905, 14988.100713957198, 15103.129728437918, 13414.0, 13440.731185376433, 13904.72190556163, 13925.442982280596, 14350.896306328017, 13260.2098716672, 13804.17174969505, 14028.22844743549, 14038.78941815853, 14044.087134336236, 12720.87279127197, 13602.984956138594, 13604.727905442034, 13744.931275343959, 13816.723665526833, 9369.812603748023, 9519.333646644669, 9969.850452243367, 9982.450965196693, 10091.293609447563, 10136.0, 10419.322744021614, 10645.361278323326, 10663.253572249869, 10671.452639367404], "value": 7540.202794341026, "unit": "score"}], "name": "dromaeo_css", "value": 7517.24051826718, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 117.0, 161.0, 169.0, 111.0, 112.0, 113.0, 112.0], "value": 122.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 106.0, 141.0, 106.0, 104.0, 106.0, 105.0, 127.0, 113.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 182.0, 183.0, 182.0, 183.0, 182.0, 182.0, 183.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 89.0, 59.0, 59.0, 59.0, 73.0, 96.0, 81.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 88.0, 69.0, 67.0, 68.0, 80.0, 67.0, 68.0, 81.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 91.0, 90.0, 86.0, 89.0, 86.0, 88.0, 87.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 98.0, 97.0, 97.0, 98.0, 98.0, 97.0, 96.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 84.0, 84.0, 84.0, 82.0, 82.0, 86.0, 85.0, 86.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 53.0, 52.0, 54.0, 56.0, 56.0, 54.0, 55.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 80.0, 72.0, 75.0, 71.0, 68.0, 70.0, 69.0, 69.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 82.0, 82.0, 85.0, 87.0, 100.0, 103.0, 83.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 134.0, 141.0, 143.0, 127.0, 136.0, 131.0, 193.0, 172.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 160.0, 162.0, 162.0, 161.0, 162.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 66.0, 63.0, 63.0, 65.0, 63.0, 63.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1417.7, "alertThreshold": 2.0}]} 15:23:29 INFO - Return code: 0 15:23:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:23:29 INFO - # TBPL SUCCESS # 15:23:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:23:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:23:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:23:29 INFO - 2017-04-07 15:23:29.498 screenresolution[1652:9892] starting screenresolution argv=screenresolution get 15:23:29 INFO - 2017-04-07 15:23:29.500 screenresolution[1652:9892] Display 0: 1600x1200x32@60 15:23:29 INFO - 2017-04-07 15:23:29.506 screenresolution[1653:9895] starting screenresolution argv=screenresolution list 15:23:29 INFO - Available Modes on Display 0 15:23:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:23:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:23:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:23:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:23:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:23:29 INFO - Intel Iris: 15:23:29 INFO - Chipset Model: Intel Iris 15:23:29 INFO - Type: GPU 15:23:29 INFO - Bus: Built-In 15:23:29 INFO - VRAM (Dynamic, Max): 1536 MB 15:23:29 INFO - Vendor: Intel (0x8086) 15:23:29 INFO - Device ID: 0x0a2e 15:23:29 INFO - Revision ID: 0x0009 15:23:29 INFO - Displays: 15:23:29 INFO - Display: 15:23:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:23:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:23:29 INFO - Display Serial Number: 1600x1200 60 15:23:29 INFO - Main Display: Yes 15:23:29 INFO - Mirror: Off 15:23:29 INFO - Online: Yes 15:23:29 INFO - Rotation: Supported 15:23:29 INFO - Return code: 0 15:23:29 INFO - Running post-action listener: _resource_record_post_action 15:23:29 INFO - [mozharness: 2017-04-07 22:23:29.741128Z] Finished run-tests step (success) 15:23:29 INFO - Running post-run listener: _resource_record_post_run 15:23:29 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 38388736; Write bytes: 420614656; Read time: 246; Write time: 1363 15:23:29 INFO - TinderboxPrint: CPU usage
53.4% 15:23:29 INFO - TinderboxPrint: I/O read bytes / time
38,388,736 / 246 15:23:29 INFO - TinderboxPrint: I/O write bytes / time
420,614,656 / 1,363 15:23:29 INFO - TinderboxPrint: CPU idle
2,218.7 (46.6%) 15:23:29 INFO - TinderboxPrint: CPU system
947.9 (19.9%) 15:23:29 INFO - TinderboxPrint: CPU user
1,599.1 (33.6%) 15:23:29 INFO - TinderboxPrint: Swap in / out
159,830,016 / 0 15:23:29 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121494016; Write bytes: 113795072; Read time: 11141; Write time: 240 15:23:29 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35046400; Write bytes: 296706560; Read time: 223; Write time: 1087 15:23:30 INFO - Running post-run listener: _upload_blobber_files 15:23:30 INFO - Blob upload gear active. 15:23:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:23:30 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 15:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:23:30 INFO - (blobuploader) - INFO - Open directory for files ... 15:23:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:23:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:23:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:31 INFO - (blobuploader) - INFO - Done attempting. 15:23:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:23:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:23:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:32 INFO - (blobuploader) - INFO - Done attempting. 15:23:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:23:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:23:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:33 INFO - (blobuploader) - INFO - Done attempting. 15:23:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:23:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:23:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:35 INFO - (blobuploader) - INFO - Done attempting. 15:23:35 INFO - (blobuploader) - INFO - Iteration through files over. 15:23:35 INFO - Return code: 0 15:23:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:23:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:23:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be2e719b38275c894877108d378c644fd75a8bb492841361708478e3156fc3a40a3203700a6d781a652660859f438d1b69c301539cd6e04dbe2006d8de02928d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e331bc489b0c8f47d352643ac5ae809ad56261aaa2faeb42b776a538f26673e9df88b31584a77619ffaf5ad9bb5da42dabde592e64da51e998adfae9f45b864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e031e19b67f4e23523d89ac5c7858bafaddfb9beb88c680d10b9b9272fd7ff4ab0eac32c6e650c6015509118d0d12d1f9225567e4c1d250822e9425ed244e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bcda009b26eee029ee5f610d5cde200b3e02d51270dfb0c65f145a347abce5f98e82db02f017ca65168ad2eb20a1750decc8da7e39450b32c6fe142db45dc6f"} 15:23:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:23:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:23:35 INFO - Contents: 15:23:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be2e719b38275c894877108d378c644fd75a8bb492841361708478e3156fc3a40a3203700a6d781a652660859f438d1b69c301539cd6e04dbe2006d8de02928d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e331bc489b0c8f47d352643ac5ae809ad56261aaa2faeb42b776a538f26673e9df88b31584a77619ffaf5ad9bb5da42dabde592e64da51e998adfae9f45b864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e031e19b67f4e23523d89ac5c7858bafaddfb9beb88c680d10b9b9272fd7ff4ab0eac32c6e650c6015509118d0d12d1f9225567e4c1d250822e9425ed244e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bcda009b26eee029ee5f610d5cde200b3e02d51270dfb0c65f145a347abce5f98e82db02f017ca65168ad2eb20a1750decc8da7e39450b32c6fe142db45dc6f"} 15:23:35 INFO - Running post-run listener: copy_logs_to_upload_dir 15:23:35 INFO - Copying logs to upload dir... 15:23:35 INFO - mkdir: /builds/slave/test/build/upload/logs 15:23:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.681485 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-07 15:23:35.989566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 15:23:35.993331) ========= 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.6P5QY4zZXF/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.iazIMu56Cq/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be2e719b38275c894877108d378c644fd75a8bb492841361708478e3156fc3a40a3203700a6d781a652660859f438d1b69c301539cd6e04dbe2006d8de02928d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e331bc489b0c8f47d352643ac5ae809ad56261aaa2faeb42b776a538f26673e9df88b31584a77619ffaf5ad9bb5da42dabde592e64da51e998adfae9f45b864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e031e19b67f4e23523d89ac5c7858bafaddfb9beb88c680d10b9b9272fd7ff4ab0eac32c6e650c6015509118d0d12d1f9225567e4c1d250822e9425ed244e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bcda009b26eee029ee5f610d5cde200b3e02d51270dfb0c65f145a347abce5f98e82db02f017ca65168ad2eb20a1750decc8da7e39450b32c6fe142db45dc6f"} build_url:https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/SUnQggl9RM-GeGKA9Aiplw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be2e719b38275c894877108d378c644fd75a8bb492841361708478e3156fc3a40a3203700a6d781a652660859f438d1b69c301539cd6e04dbe2006d8de02928d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e331bc489b0c8f47d352643ac5ae809ad56261aaa2faeb42b776a538f26673e9df88b31584a77619ffaf5ad9bb5da42dabde592e64da51e998adfae9f45b864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e031e19b67f4e23523d89ac5c7858bafaddfb9beb88c680d10b9b9272fd7ff4ab0eac32c6e650c6015509118d0d12d1f9225567e4c1d250822e9425ed244e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bcda009b26eee029ee5f610d5cde200b3e02d51270dfb0c65f145a347abce5f98e82db02f017ca65168ad2eb20a1750decc8da7e39450b32c6fe142db45dc6f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 15:23:36.027754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:23:36.028103) ========= 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.6P5QY4zZXF/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.iazIMu56Cq/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.005131 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:23:36.076784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 15:23:36.077136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 15:23:36.077445) ========= ========= Total master_lag: 0.29 =========