builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0016 starttime: 1490184717.37 results: success (0) buildid: 20170322033504 builduid: bf5713e466154e92b78fe95d255167ac revision: d01bf6283507b6820bd0961173426d6c21ebfc50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.375147) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.375576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.375872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.402738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.403147) ========= 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.jDShKiITR6/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.fL83F8fzoe/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-22 05:11:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.1M=0.001s 2017-03-22 05:11:57 (22.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124004 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.551443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.551755) ========= 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.jDShKiITR6/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.fL83F8fzoe/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.038044 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.611903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:57.612254) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d01bf6283507b6820bd0961173426d6c21ebfc50 --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 d01bf6283507b6820bd0961173426d6c21ebfc50 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jDShKiITR6/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.fL83F8fzoe/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-22 05:11:57,720 truncating revision to first 12 chars 2017-03-22 05:11:57,720 Setting DEBUG logging. 2017-03-22 05:11:57,720 attempt 1/10 2017-03-22 05:11:57,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d01bf6283507?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 05:11:58,396 unpacking tar archive at: mozilla-beta-d01bf6283507/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:58.573919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:58.574238) ========= script_repo_revision: d01bf6283507b6820bd0961173426d6c21ebfc50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:58.574645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:58.574928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 05:11:58.594857) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-22 05:11:58.595249) ========= /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.jDShKiITR6/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.fL83F8fzoe/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:11:58 INFO - MultiFileLogger online at 20170322 05:11:58 in /builds/slave/test 05:11:58 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 05:11:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:58 INFO - {'append_to_log': False, 05:11:58 INFO - 'base_work_dir': '/builds/slave/test', 05:11:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:11:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:58 INFO - 'branch': 'Mozilla-Beta', 05:11:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:58 INFO - 'config_files': ('talos/mac_config.py',), 05:11:58 INFO - 'default_actions': ('clobber', 05:11:58 INFO - 'read-buildbot-config', 05:11:58 INFO - 'download-and-extract', 05:11:58 INFO - 'populate-webroot', 05:11:58 INFO - 'create-virtualenv', 05:11:58 INFO - 'install', 05:11:58 INFO - 'run-tests'), 05:11:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:58 INFO - 'download_minidump_stackwalk': True, 05:11:58 INFO - 'download_symbols': 'ondemand', 05:11:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:58 INFO - 'installer_path': 'installer.exe', 05:11:58 INFO - 'log_level': 'info', 05:11:58 INFO - 'log_name': 'talos', 05:11:58 INFO - 'log_to_console': True, 05:11:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:11:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:11:58 INFO - 'opt_config_files': (), 05:11:58 INFO - 'pip_index': False, 05:11:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:11:58 INFO - 'cmd': ('bash', 05:11:58 INFO - '-c', 05:11:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:11:58 INFO - 'enabled': True, 05:11:58 INFO - 'halt_on_failure': False, 05:11:58 INFO - 'name': 'check_screen_resolution'},), 05:11:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:11:58 INFO - 'cmd': ('bash', 05:11:58 INFO - '-c', 05:11:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:11:58 INFO - 'enabled': True, 05:11:58 INFO - 'halt_on_failure': False, 05:11:58 INFO - 'name': 'check_screen_resolution'},), 05:11:58 INFO - 'run_cmd_checks_enabled': True, 05:11:58 INFO - 'sps_profile': False, 05:11:58 INFO - 'sps_profile_interval': 0, 05:11:58 INFO - 'suite': 'dromaeojs', 05:11:58 INFO - 'system_bits': '32', 05:11:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:58 INFO - 'title': 't-yosemite-r7-0016', 05:11:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:58 INFO - 'use_talos_json': True, 05:11:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:58 INFO - 'work_dir': 'build'} 05:11:58 INFO - [mozharness: 2017-03-22 12:11:58.816330Z] Running clobber step. 05:11:58 INFO - Running pre-action listener: _resource_record_pre_action 05:11:58 INFO - Running main action method: clobber 05:11:58 INFO - rmtree: /builds/slave/test/build 05:11:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:01 INFO - Running post-action listener: _resource_record_post_action 05:12:01 INFO - [mozharness: 2017-03-22 12:12:01.420207Z] Finished clobber step (success) 05:12:01 INFO - [mozharness: 2017-03-22 12:12:01.420451Z] Running read-buildbot-config step. 05:12:01 INFO - Running pre-action listener: _resource_record_pre_action 05:12:01 INFO - Running main action method: read_buildbot_config 05:12:01 INFO - Using buildbot properties: 05:12:01 INFO - { 05:12:01 INFO - "project": "", 05:12:01 INFO - "product": "firefox", 05:12:01 INFO - "script_repo_revision": "production", 05:12:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:12:01 INFO - "repository": "", 05:12:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:12:01 INFO - "buildid": "20170322033504", 05:12:01 INFO - "pgo_build": "False", 05:12:01 INFO - "basedir": "/builds/slave/test", 05:12:01 INFO - "buildnumber": 3, 05:12:01 INFO - "slavename": "t-yosemite-r7-0016", 05:12:01 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:12:01 INFO - "platform": "yosemite_r7", 05:12:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:12:01 INFO - "branch": "mozilla-beta", 05:12:01 INFO - "repo_path": "releases/mozilla-beta", 05:12:01 INFO - "revision": "d01bf6283507b6820bd0961173426d6c21ebfc50", 05:12:01 INFO - "stage_platform": "macosx64", 05:12:01 INFO - "builduid": "bf5713e466154e92b78fe95d255167ac", 05:12:01 INFO - "slavebuilddir": "test" 05:12:01 INFO - } 05:12:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 05:12:01 INFO - Running post-action listener: _resource_record_post_action 05:12:01 INFO - [mozharness: 2017-03-22 12:12:01.426190Z] Finished read-buildbot-config step (success) 05:12:01 INFO - [mozharness: 2017-03-22 12:12:01.426348Z] Running download-and-extract step. 05:12:01 INFO - Running pre-action listener: _resource_record_pre_action 05:12:01 INFO - Running main action method: download_and_extract 05:12:01 INFO - mkdir: /builds/slave/test/build/tests 05:12:01 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')]} 05:12:01 INFO - trying https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 05:12:01 INFO - Downloading https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/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 05:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/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 05:12:02 INFO - Downloaded 1165 bytes. 05:12:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:12:02 INFO - Using the following test package requirements: 05:12:02 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:12:02 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:12:02 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 05:12:02 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:12:02 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 05:12:02 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:12:02 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:12:02 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 05:12:02 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:12:02 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:12:02 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 05:12:02 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:12:02 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 05:12:02 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:12:02 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 05:12:02 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:12:02 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 05:12:02 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 05:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:12:03 INFO - Expected file size: 16108244 05:12:03 INFO - Obtained file size: 16108244 05:12:10 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 05:12:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:12:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:12:10 INFO - Fetch https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:12:11 INFO - Expected file size: 16108244 05:12:11 INFO - Obtained file size: 16108244 05:12:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 05:12:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 05:12:17 INFO - Fetch https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 05:12:18 INFO - Expected file size: 14403663 05:12:18 INFO - Obtained file size: 14403663 05:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:19 INFO - trying https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:12:19 INFO - Downloading https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 05:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/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 05:12:20 INFO - Downloaded 58762004 bytes. 05:12:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:12:20 INFO - mkdir: /builds/slave/test/properties 05:12:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:12:20 INFO - Writing to file /builds/slave/test/properties/build_url 05:12:20 INFO - Contents: 05:12:20 INFO - build_url:https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:12:21 INFO - Running post-action listener: _resource_record_post_action 05:12:21 INFO - Running post-action listener: set_extra_try_arguments 05:12:21 INFO - [mozharness: 2017-03-22 12:12:21.550922Z] Finished download-and-extract step (success) 05:12:21 INFO - [mozharness: 2017-03-22 12:12:21.551044Z] Running populate-webroot step. 05:12:21 INFO - Running pre-action listener: _resource_record_pre_action 05:12:21 INFO - Running main action method: populate_webroot 05:12:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:12:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:12:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:12:21 INFO - '--tppagecycles', 05:12:21 INFO - '7'], 05:12:21 INFO - 'tests': ['tsvgm']}}, 05:12:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:12:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:12:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:12:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:12:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:12:21 INFO - 'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:12:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:12:21 INFO - 'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['damp', 'tps']}, 05:12:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:12:21 INFO - 'tests': ['damp', 'tps']}, 05:12:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['dromaeo_dom']}, 05:12:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:12:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['basic_compositor_video']}, 05:12:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:12:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['a11yr', 05:12:21 INFO - 'ts_paint', 05:12:21 INFO - 'tpaint', 05:12:21 INFO - 'sessionrestore', 05:12:21 INFO - 'sessionrestore_no_auto_restore', 05:12:21 INFO - 'tabpaint']}, 05:12:21 INFO - 'other-e10s': {'tests': ['a11yr', 05:12:21 INFO - 'ts_paint', 05:12:21 INFO - 'tpaint', 05:12:21 INFO - 'sessionrestore', 05:12:21 INFO - 'sessionrestore_no_auto_restore', 05:12:21 INFO - 'tabpaint']}, 05:12:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:12:21 INFO - 'ts_paint', 05:12:21 INFO - 'tpaint', 05:12:21 INFO - 'sessionrestore', 05:12:21 INFO - 'sessionrestore_no_auto_restore', 05:12:21 INFO - 'tabpaint']}, 05:12:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:12:21 INFO - 'ts_paint', 05:12:21 INFO - 'tpaint', 05:12:21 INFO - 'sessionrestore', 05:12:21 INFO - 'sessionrestore_no_auto_restore', 05:12:21 INFO - 'tabpaint']}, 05:12:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['a11yr', 05:12:21 INFO - 'ts_paint', 05:12:21 INFO - 'tpaint', 05:12:21 INFO - 'sessionrestore', 05:12:21 INFO - 'sessionrestore_no_auto_restore', 05:12:21 INFO - 'tabpaint']}, 05:12:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['a11yr', 05:12:21 INFO - 'ts_paint', 05:12:21 INFO - 'tpaint', 05:12:21 INFO - 'sessionrestore', 05:12:21 INFO - 'sessionrestore_no_auto_restore', 05:12:21 INFO - 'tabpaint']}, 05:12:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['tsvgx', 05:12:21 INFO - 'tsvgr_opacity', 05:12:21 INFO - 'tart', 05:12:21 INFO - 'tscrollx', 05:12:21 INFO - 'cart', 05:12:21 INFO - 'tsvg_static']}, 05:12:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:12:21 INFO - 'tsvgr_opacity', 05:12:21 INFO - 'tart', 05:12:21 INFO - 'tscrollx', 05:12:21 INFO - 'cart', 05:12:21 INFO - 'tsvg_static']}, 05:12:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:12:21 INFO - 'talos_options': ['--disable-e10s'], 05:12:21 INFO - 'tests': ['tp5o']}, 05:12:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:12:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:12:21 INFO - 'talos_options': ['--disable-e10s', 05:12:21 INFO - '--xperf_path', 05:12:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:21 INFO - 'tests': ['tp5n']}, 05:12:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:12:21 INFO - 'talos_options': ['--xperf_path', 05:12:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:21 INFO - 'tests': ['tp5n']}}, 05:12:21 INFO - 'talos.zip': {'path': '', 05:12:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:12:21 INFO - Running post-action listener: _resource_record_post_action 05:12:21 INFO - [mozharness: 2017-03-22 12:12:21.569766Z] Finished populate-webroot step (success) 05:12:21 INFO - [mozharness: 2017-03-22 12:12:21.569894Z] Running create-virtualenv step. 05:12:21 INFO - Running pre-action listener: _resource_record_pre_action 05:12:21 INFO - Running main action method: create_virtualenv 05:12:21 INFO - Creating virtualenv /builds/slave/test/build/venv 05:12:21 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 05:12:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:12:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:12:21 INFO - Using real prefix '/tools/python27' 05:12:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:12:22 INFO - Installing distribute.............................................................................................................................................................................................done. 05:12:25 INFO - Installing pip.................done. 05:12:25 INFO - Return code: 0 05:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:12:25 INFO - Reading from file tmpfile_stdout 05:12:25 INFO - Output received: 05:12:25 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) 05:12:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:12:25 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')]} 05:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:25 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')]} 05:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:25 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:25 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 05:12:25 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 05:12:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:25 INFO - 'HOME': '/Users/cltbld', 05:12:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:25 INFO - 'LOGNAME': 'cltbld', 05:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:25 INFO - 'MOZ_NO_REMOTE': '1', 05:12:25 INFO - 'NO_EM_RESTART': '1', 05:12:25 INFO - 'PAGER': '/bin/cat', 05:12:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:25 INFO - 'PWD': '/builds/slave/test', 05:12:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:25 INFO - 'SHELL': '/bin/bash', 05:12:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:25 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:25 INFO - 'USER': 'cltbld', 05:12:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:25 INFO - 'XPC_FLAGS': '0x0', 05:12:25 INFO - 'XPC_SERVICE_NAME': '0', 05:12:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:25 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 05:12:25 INFO - Cleaning up... 05:12:25 INFO - Return code: 0 05:12:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:12:25 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')]} 05:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:25 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')]} 05:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:25 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:25 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 05:12:25 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 05:12:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:25 INFO - 'HOME': '/Users/cltbld', 05:12:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:25 INFO - 'LOGNAME': 'cltbld', 05:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:25 INFO - 'MOZ_NO_REMOTE': '1', 05:12:25 INFO - 'NO_EM_RESTART': '1', 05:12:25 INFO - 'PAGER': '/bin/cat', 05:12:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:25 INFO - 'PWD': '/builds/slave/test', 05:12:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:25 INFO - 'SHELL': '/bin/bash', 05:12:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:25 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:25 INFO - 'USER': 'cltbld', 05:12:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:25 INFO - 'XPC_FLAGS': '0x0', 05:12:25 INFO - 'XPC_SERVICE_NAME': '0', 05:12:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:26 INFO - Downloading/unpacking psutil>=3.1.1 05:12:26 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 05:12:26 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 05:12:26 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 05:12:26 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 05:12:26 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 05:12:26 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 05:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:29 INFO - Installing collected packages: psutil 05:12:29 INFO - Running setup.py install for psutil 05:12:29 INFO - building 'psutil._psutil_osx' extension 05:12:29 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 05:12:30 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 05:12:30 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 05:12:30 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 05:12:30 INFO - building 'psutil._psutil_posix' extension 05:12:30 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 05:12:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:12:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:12:30 INFO - ^ 05:12:30 INFO - 1 warning generated. 05:12:30 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 05:12:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:30 INFO - Successfully installed psutil 05:12:30 INFO - Cleaning up... 05:12:30 INFO - Return code: 0 05:12:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:12:30 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')]} 05:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:30 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')]} 05:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:30 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:30 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 05:12:30 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 05:12:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:30 INFO - 'HOME': '/Users/cltbld', 05:12:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:30 INFO - 'LOGNAME': 'cltbld', 05:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:30 INFO - 'MOZ_NO_REMOTE': '1', 05:12:30 INFO - 'NO_EM_RESTART': '1', 05:12:30 INFO - 'PAGER': '/bin/cat', 05:12:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:30 INFO - 'PWD': '/builds/slave/test', 05:12:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:30 INFO - 'SHELL': '/bin/bash', 05:12:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:30 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:30 INFO - 'USER': 'cltbld', 05:12:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:30 INFO - 'XPC_FLAGS': '0x0', 05:12:30 INFO - 'XPC_SERVICE_NAME': '0', 05:12:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:12:33 INFO - Installing collected packages: mozsystemmonitor 05:12:33 INFO - Running setup.py install for mozsystemmonitor 05:12:34 INFO - Successfully installed mozsystemmonitor 05:12:34 INFO - Cleaning up... 05:12:34 INFO - Return code: 0 05:12:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:12:34 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')]} 05:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:34 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')]} 05:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:34 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:34 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 05:12:34 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 05:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:34 INFO - 'HOME': '/Users/cltbld', 05:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:34 INFO - 'LOGNAME': 'cltbld', 05:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:34 INFO - 'MOZ_NO_REMOTE': '1', 05:12:34 INFO - 'NO_EM_RESTART': '1', 05:12:34 INFO - 'PAGER': '/bin/cat', 05:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:34 INFO - 'PWD': '/builds/slave/test', 05:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:34 INFO - 'SHELL': '/bin/bash', 05:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:34 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:34 INFO - 'USER': 'cltbld', 05:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:34 INFO - 'XPC_FLAGS': '0x0', 05:12:34 INFO - 'XPC_SERVICE_NAME': '0', 05:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:34 INFO - Downloading/unpacking jsonschema==2.5.1 05:12:34 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 05:12:34 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 05:12:34 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 05:12:34 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 05:12:34 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 05:12:34 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 05:12:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:37 INFO - warning: no files found matching '*.txt' 05:12:37 INFO - no previously-included directories found matching 'build' 05:12:37 INFO - no previously-included directories found matching 'dist' 05:12:37 INFO - no previously-included directories found matching '.git*' 05:12:37 INFO - Installing collected packages: jsonschema, functools32 05:12:37 INFO - Running setup.py install for functools32 05:12:37 INFO - warning: no files found matching '*.txt' 05:12:37 INFO - no previously-included directories found matching 'build' 05:12:37 INFO - no previously-included directories found matching 'dist' 05:12:37 INFO - no previously-included directories found matching '.git*' 05:12:37 INFO - Successfully installed jsonschema functools32 05:12:37 INFO - Cleaning up... 05:12:37 INFO - Return code: 0 05:12:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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', '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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:12: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 functools32==3.2.3-2 05:12:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:37 INFO - 'HOME': '/Users/cltbld', 05:12:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:37 INFO - 'LOGNAME': 'cltbld', 05:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:37 INFO - 'MOZ_NO_REMOTE': '1', 05:12:37 INFO - 'NO_EM_RESTART': '1', 05:12:37 INFO - 'PAGER': '/bin/cat', 05:12:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:37 INFO - 'PWD': '/builds/slave/test', 05:12:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:37 INFO - 'SHELL': '/bin/bash', 05:12:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:37 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:37 INFO - 'USER': 'cltbld', 05:12:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:37 INFO - 'XPC_FLAGS': '0x0', 05:12:37 INFO - 'XPC_SERVICE_NAME': '0', 05:12:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:12:38 INFO - Cleaning up... 05:12:38 INFO - Return code: 0 05:12:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:12:38 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')]} 05:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:38 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')]} 05:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:38 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:38 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 05:12:38 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 05:12:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:38 INFO - 'HOME': '/Users/cltbld', 05:12:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:38 INFO - 'LOGNAME': 'cltbld', 05:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:38 INFO - 'MOZ_NO_REMOTE': '1', 05:12:38 INFO - 'NO_EM_RESTART': '1', 05:12:38 INFO - 'PAGER': '/bin/cat', 05:12:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:38 INFO - 'PWD': '/builds/slave/test', 05:12:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:38 INFO - 'SHELL': '/bin/bash', 05:12:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:38 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:38 INFO - 'USER': 'cltbld', 05:12:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:38 INFO - 'XPC_FLAGS': '0x0', 05:12:38 INFO - 'XPC_SERVICE_NAME': '0', 05:12:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:12:38 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 05:12:38 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 05:12:38 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 05:12:38 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 05:12:38 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 05:12:38 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 05:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:41 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 05:12:41 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 05:12:41 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 05:12:41 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 05:12:41 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 05:12:41 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 05:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:41 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 05:12:41 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 05:12:41 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 05:12:41 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 05:12:41 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 05:12:41 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 05:12:42 INFO - Downloading docopt-0.6.1.tar.gz 05:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:42 INFO - Running setup.py install for blobuploader 05:12:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:42 INFO - Running setup.py install for requests 05:12:42 INFO - Running setup.py install for docopt 05:12:43 INFO - Successfully installed blobuploader requests docopt 05:12:43 INFO - Cleaning up... 05:12:43 INFO - Return code: 0 05:12:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:43 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 05:12:43 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 05:12:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:43 INFO - 'HOME': '/Users/cltbld', 05:12:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:43 INFO - 'LOGNAME': 'cltbld', 05:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:43 INFO - 'MOZ_NO_REMOTE': '1', 05:12:43 INFO - 'NO_EM_RESTART': '1', 05:12:43 INFO - 'PAGER': '/bin/cat', 05:12:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:43 INFO - 'PWD': '/builds/slave/test', 05:12:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:43 INFO - 'SHELL': '/bin/bash', 05:12:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:43 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:43 INFO - 'USER': 'cltbld', 05:12:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:43 INFO - 'XPC_FLAGS': '0x0', 05:12:43 INFO - 'XPC_SERVICE_NAME': '0', 05:12:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:43 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-158uIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:43 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-PJTXtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:43 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-AaptkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:43 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-KaPLIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:43 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-dM2wap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-cAn_d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-t77Gi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-r_KQfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-lhiwd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-wdT1VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-MBKRNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-7ml83D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-nk2RFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-vMcp3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-6fpZPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-lw8fZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-LsNo1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:45 INFO - Running setup.py install for manifestparser 05:12:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:45 INFO - Running setup.py install for mozcrash 05:12:45 INFO - Running setup.py install for mozdebug 05:12:45 INFO - Running setup.py install for mozdevice 05:12:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:45 INFO - Running setup.py install for mozfile 05:12:46 INFO - Running setup.py install for mozhttpd 05:12:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Running setup.py install for mozinfo 05:12:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Running setup.py install for mozInstall 05:12:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Running setup.py install for mozleak 05:12:46 INFO - Running setup.py install for mozlog 05:12:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Running setup.py install for moznetwork 05:12:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:46 INFO - Running setup.py install for mozprocess 05:12:47 INFO - Running setup.py install for mozprofile 05:12:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:47 INFO - Running setup.py install for mozrunner 05:12:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:47 INFO - Running setup.py install for mozscreenshot 05:12:47 INFO - Running setup.py install for moztest 05:12:47 INFO - Running setup.py install for mozversion 05:12:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:47 INFO - Cleaning up... 05:12:47 INFO - Return code: 0 05:12:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:47 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:47 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 05:12:47 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 05:12:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:47 INFO - 'HOME': '/Users/cltbld', 05:12:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:47 INFO - 'LOGNAME': 'cltbld', 05:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:47 INFO - 'MOZ_NO_REMOTE': '1', 05:12:47 INFO - 'NO_EM_RESTART': '1', 05:12:47 INFO - 'PAGER': '/bin/cat', 05:12:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:47 INFO - 'PWD': '/builds/slave/test', 05:12:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:47 INFO - 'SHELL': '/bin/bash', 05:12:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:47 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:47 INFO - 'USER': 'cltbld', 05:12:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:47 INFO - 'XPC_FLAGS': '0x0', 05:12:47 INFO - 'XPC_SERVICE_NAME': '0', 05:12:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-aioTIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Yh4dEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-c3DTO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-HhATno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-xD0E2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-61_sFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-DgzyIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-rkYUB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:48 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)) 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-xH20Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-z9Mumi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-JezGi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-2B53Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-2lyrVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-3BWPGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-CYauM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-gLE1RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:49 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)) 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-_nKVvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:49 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)) 05:12:49 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)) 05:12:49 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)) 05:12:49 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)) 05:12:49 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)) 05:12:49 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)) 05:12:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:52 INFO - Downloading blessings-1.6.tar.gz 05:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:52 INFO - Installing collected packages: blessings 05:12:52 INFO - Running setup.py install for blessings 05:12:52 INFO - Successfully installed blessings 05:12:52 INFO - Cleaning up... 05:12:53 INFO - Return code: 0 05:12:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:53 INFO - Reading from file tmpfile_stdout 05:12:53 INFO - Current package versions: 05:12:53 INFO - blessings == 1.6 05:12:53 INFO - blobuploader == 1.2.4 05:12:53 INFO - docopt == 0.6.1 05:12:53 INFO - functools32 == 3.2.3-2 05:12:53 INFO - jsonschema == 2.5.1 05:12:53 INFO - manifestparser == 1.1 05:12:53 INFO - mozInstall == 1.12 05:12:53 INFO - mozcrash == 1.0 05:12:53 INFO - mozdebug == 0.1 05:12:53 INFO - mozdevice == 0.49 05:12:53 INFO - mozfile == 1.2 05:12:53 INFO - mozhttpd == 0.7 05:12:53 INFO - mozinfo == 0.9 05:12:53 INFO - mozleak == 0.1 05:12:53 INFO - mozlog == 3.4 05:12:53 INFO - moznetwork == 0.27 05:12:53 INFO - mozprocess == 0.24 05:12:53 INFO - mozprofile == 0.28 05:12:53 INFO - mozrunner == 6.13 05:12:53 INFO - mozscreenshot == 0.1 05:12:53 INFO - mozsystemmonitor == 0.3 05:12:53 INFO - moztest == 0.8 05:12:53 INFO - mozversion == 1.4 05:12:53 INFO - psutil == 3.1.1 05:12:53 INFO - requests == 1.2.3 05:12:53 INFO - wsgiref == 0.1.2 05:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:54 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 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:54 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 05:12:54 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 05:12:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:54 INFO - 'HOME': '/Users/cltbld', 05:12:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:54 INFO - 'LOGNAME': 'cltbld', 05:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:54 INFO - 'MOZ_NO_REMOTE': '1', 05:12:54 INFO - 'NO_EM_RESTART': '1', 05:12:54 INFO - 'PAGER': '/bin/cat', 05:12:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:54 INFO - 'PWD': '/builds/slave/test', 05:12:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:54 INFO - 'SHELL': '/bin/bash', 05:12:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:54 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:54 INFO - 'USER': 'cltbld', 05:12:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:54 INFO - 'XPC_FLAGS': '0x0', 05:12:54 INFO - 'XPC_SERVICE_NAME': '0', 05:12:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 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)) 05:12:54 INFO - Cleaning up... 05:12:54 INFO - Return code: 0 05:12:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:54 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')]} 05:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:54 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')]} 05:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10531bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc51c99260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, '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.jDShKiITR6/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.fL83F8fzoe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 05:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:55 INFO - 'HOME': '/Users/cltbld', 05:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:55 INFO - 'LOGNAME': 'cltbld', 05:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:55 INFO - 'MOZ_NO_REMOTE': '1', 05:12:55 INFO - 'NO_EM_RESTART': '1', 05:12:55 INFO - 'PAGER': '/bin/cat', 05:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:55 INFO - 'PWD': '/builds/slave/test', 05:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:55 INFO - 'SHELL': '/bin/bash', 05:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:12:55 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:55 INFO - 'USER': 'cltbld', 05:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:55 INFO - 'XPC_FLAGS': '0x0', 05:12:55 INFO - 'XPC_SERVICE_NAME': '0', 05:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:12:55 INFO - Cleaning up... 05:12:55 INFO - Return code: 0 05:12:55 INFO - Running post-action listener: _resource_record_post_action 05:12:55 INFO - Running post-action listener: _start_resource_monitoring 05:12:55 INFO - Starting resource monitoring. 05:12:55 INFO - [mozharness: 2017-03-22 12:12:55.384357Z] Finished create-virtualenv step (success) 05:12:55 INFO - [mozharness: 2017-03-22 12:12:55.385286Z] Running install step. 05:12:55 INFO - Running pre-action listener: _resource_record_pre_action 05:12:55 INFO - Running main action method: install 05:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:55 INFO - Reading from file tmpfile_stdout 05:12:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:55 INFO - Reading from file tmpfile_stdout 05:12:55 INFO - Output received: 05:12:55 INFO - Usage: mozinstall [options] installer 05:12:55 INFO - Options: 05:12:55 INFO - -h, --help show this help message and exit 05:12:55 INFO - -d DEST, --destination=DEST 05:12:55 INFO - Directory to install application into. [default: 05:12:55 INFO - "/builds/slave/test"] 05:12:55 INFO - --app=APP Application being installed. [default: firefox] 05:12:55 INFO - mkdir: /builds/slave/test/build/application 05:12:55 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'] 05:12:55 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 05:13:10 INFO - Reading from file tmpfile_stdout 05:13:10 INFO - Output received: 05:13:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:13:10 INFO - Running post-action listener: _resource_record_post_action 05:13:10 INFO - [mozharness: 2017-03-22 12:13:10.449072Z] Finished install step (success) 05:13:10 INFO - [mozharness: 2017-03-22 12:13:10.449244Z] Running run-tests step. 05:13:10 INFO - Running pre-action listener: _resource_record_pre_action 05:13:10 INFO - Running main action method: run_tests 05:13:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:10 INFO - 2017-03-22 05:13:10.463 screenresolution[1621:7501] starting screenresolution argv=screenresolution get 05:13:10 INFO - 2017-03-22 05:13:10.466 screenresolution[1621:7501] Display 0: 1600x1200x32@60 05:13:10 INFO - 2017-03-22 05:13:10.472 screenresolution[1622:7503] starting screenresolution argv=screenresolution list 05:13:10 INFO - Available Modes on Display 0 05:13:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:10 INFO - Intel Iris: 05:13:10 INFO - Chipset Model: Intel Iris 05:13:10 INFO - Type: GPU 05:13:10 INFO - Bus: Built-In 05:13:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:10 INFO - Vendor: Intel (0x8086) 05:13:10 INFO - Device ID: 0x0a2e 05:13:10 INFO - Revision ID: 0x0009 05:13:10 INFO - Displays: 05:13:10 INFO - Display: 05:13:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:10 INFO - Display Serial Number: 1600x1200 60 05:13:10 INFO - Main Display: Yes 05:13:10 INFO - Mirror: Off 05:13:10 INFO - Online: Yes 05:13:10 INFO - Rotation: Supported 05:13:10 INFO - Return code: 0 05:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:13:10 INFO - Python 2.7.3 05:13:10 INFO - Return code: 0 05:13:10 INFO - grabbing minidump binary from tooltool 05:13:10 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')]} 05:13:10 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 0x1050f9d30>, '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 0x105020db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050eebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:13:10 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 05:13:10 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 05:13:10 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 05:13:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:13:10 INFO - Return code: 0 05:13:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:13:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:13:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:13:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:13:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:13:10 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/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 05:13:10 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/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --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 05:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jDShKiITR6/Render', 05:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:10 INFO - 'HOME': '/Users/cltbld', 05:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:10 INFO - 'LOGNAME': 'cltbld', 05:13:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:13:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:10 INFO - 'MOZ_NO_REMOTE': '1', 05:13:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:13:10 INFO - 'NO_EM_RESTART': '1', 05:13:10 INFO - 'PAGER': '/bin/cat', 05:13:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:10 INFO - 'PWD': '/builds/slave/test', 05:13:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:10 INFO - 'SHELL': '/bin/bash', 05:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fL83F8fzoe/Listeners', 05:13:10 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 05:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:10 INFO - 'USER': 'cltbld', 05:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:10 INFO - 'XPC_FLAGS': '0x0', 05:13:10 INFO - 'XPC_SERVICE_NAME': '0', 05:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:10 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/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 05:13:11 INFO - mozversion application_buildid: 20170322033504 05:13:11 INFO - mozversion application_changeset: d01bf6283507b6820bd0961173426d6c21ebfc50 05:13:11 INFO - mozversion application_display_name: Firefox 05:13:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:13:11 INFO - mozversion application_name: Firefox 05:13:11 INFO - mozversion application_remotingname: firefox 05:13:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:13:11 INFO - mozversion application_vendor: Mozilla 05:13:11 INFO - mozversion application_version: 53.0 05:13:11 INFO - mozversion platform_buildid: 20170322033504 05:13:11 INFO - mozversion platform_changeset: d01bf6283507b6820bd0961173426d6c21ebfc50 05:13:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:13:11 INFO - mozversion platform_version: 53.0 05:13:11 INFO - using testdate: 1490184791 05:13:11 INFO - actual date: 1490184791 05:13:11 INFO - starting webserver on 'localhost:49240' 05:13:11 INFO - SUITE-START | Running 2 tests 05:13:11 INFO - TEST-START | dromaeo_css 05:13:11 INFO - operating with platform_type : mac_ 05:13:11 INFO - Initialising browser for dromaeo_css test... 05:13:11 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmphIwBwq/profile http://localhost:49240/getInfo.html) 05:13:13 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 05:13:13 INFO - PROCESS | 1632 | colorDepth:24 05:13:13 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 05:13:13 INFO - PROCESS | 1632 | __metrics 05:13:13 INFO - PROCESS | 1632 | 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" 05:13:13 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:14 INFO - TEST-INFO | 1632: exit 0 05:13:14 INFO - Browser initialized. 05:13:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:13:14 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmphIwBwq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:26 INFO - PROCESS | 1635 | RSS: Main: 167526400 05:13:26 INFO - PROCESS | 1635 | 05:16:29 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 05:16:30 INFO - PROCESS | 1635 | RSS: Main: 282542080 05:16:30 INFO - PROCESS | 1635 | 05:19:33 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 05:19:34 INFO - PROCESS | 1635 | RSS: Main: 307503104 05:19:34 INFO - PROCESS | 1635 | 05:22:36 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 05:22:37 INFO - PROCESS | 1635 | RSS: Main: 277790720 05:22:37 INFO - PROCESS | 1635 | 05:25:39 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 05:25:40 INFO - PROCESS | 1635 | RSS: Main: 285978624 05:25:40 INFO - PROCESS | 1635 | 05:28:43 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 05:28:43 INFO - PROCESS | 1635 | RSS: Main: 272441344 05:28:43 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 05:31:47 INFO - PROCESS | 1635 | RSS: Main: 308826112 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | __start_tp_report 05:31:47 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 05:31:47 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 05:31:47 INFO - PROCESS | 1635 | |i|pagename|runs| 05:31:47 INFO - PROCESS | 1635 | |0;dojo.html;2953.3502629421523;3443.6384179661136;3447.0520606833124;3451.8791842285523;3506.824658767061;5749.712514374285;5774.422557744224;5775.797847075353;5796.478316951474;5821;4727.692699974499;5708.571857110723;5744.33940096889;5801.593888427812;5808.1287806829;5277.604179686539;5298.602604804636;5309.177077552986;5312.389075256357;5344.331958505187;5248.291480650101;5248.947510524903;5262.342207224097;5387.622866399353;5387.703676297802;4413.271810151337;5219.686818790866;5234;5298.4436634153435;5309.495597918191;5355.973220133913;5367.677939323634;5383;5387.865303367408;5393.19102134681;5143.434222235551;5231.058409486291;5298.602604804655;5308.362996440452;5356.9732151339385;5622.606417550773;5674.120511320752;5692.9146062809095;5706.315242170925;5713.171590119451;6218.595791273553;6245.188125543696;6264.749410023594;6320.810375688737;6323.114763933053;6233.252009758858;6285.277193122758;6304.684765761694;6310.87378252437;6334.556581039329;5715.342735585461;5827.271591051119;5900.852478688067;5907.940920590782;5917.467427931507;6267.185265915402;6275.215598050244;6277.403646653652;6278.6860656966965;6284.371562843679;6111.96944015277;6131.376666649982;6142.468080853527;6144.648177401054;6150;6206.317305096436;6279.183706118175;6290.433860952537;6291.150694656254;6350.269718982377;6234.096056071935;6245;6247.875042499125;6250.656213908188;6260.561760676709;6158.829822333742;6200.286966998853;6215.223097112861;6279.0267508535335;6289.779857704958;4970.2793095001025;5002.89994200114;5021.322121513622;5028.522290382408;5071.568916642127;4421.894526368408;4466.441694788152;4469.351943968171;4476.955230447719;4506.639468842484;5917.905187540318;5935.792247271324;5936.7922122725495;5938.910916336258;5952.375000624958;6205.937940620626;6259.561830671809;6270.655113968775;6279.215098112736;6298.622082675054;5903.881922361528;5904.1734157218025;5905.291365036223;5922.644641321534;5947.583669143119;5354.839354819362;5514.117741161475;5519.806806761824;5544.112941929272;5555.722213889289;6350.587211831216;6374.266959299554;6401.519886008475;6401.839954001187;6413.839654008594;6203.286622038523;6235.3452887446165;6246.843828904132;6254.8123556293385;6256.9988801793315;6279.905801413074;6363.395477429637;6374.840628984312;6423.261324947691;6434.420902118832;6244.2819075806865;6262.279837818709;6274.403931626488;6309.716062777278;6320.08358787964;5297.629165958346;6161.168242287413;6256.061590761422;6269.5611307208055;6299.307076221704;5061.645684802029;6040.516758659209;6122.489639783254;6130.122981477994;6252.5935814171935;6129.295131059986;6218.844528886633;6240.251169859646;6253.7185826637;6254.061890716429;5842.094475356326;5893.44012318829;6066.4540191382985;6073.210482637229;6082.209312789486;5030.647854650139;6093.75624974996;6125.917766158295;6157.568970172224;6223.315435302023;6035.288735056094;6114.023656277781;6125.601835880653;6127.0062805303205;6131.743695906945 05:31:47 INFO - PROCESS | 1635 | |1;ext.html;446.8101057050753;498.9575886049686;518.2304278146952;536.4715754981343;589.631480324797;31315.530267045982;33652.66347336526;33705.32589348215;33711.32577348452;33821;42356.57643423565;43821;43906.780466097705;45490;45582.54417455824;9464.574094165779;9649.324547281693;9650.08324209199;9651.131398174162;9662.227021838236;8988.68539601114;9508.904910950905;9585.52072396381;9607.66373176939;9621.711348659552;9103.590338434786;11619.883801162006;11842.230255033439;11846.881531184707;12007.939960300186;11454.198206125575;11532.538698452052;11559;11623.825642615368;11671.1830171888;11549.191556591042;11632.883671163348;11637.767244655059;11642.417879106095;11654.30074195551;33525.6647433525;41659.95850103772;41743;41744.79127604373;41838.95402614929;3488.494168345576;4065.3292206785845;4067.959320406788;4078;4120.835166593332;30503;30876.69123308783;31708.365832683216;31725.682743172736;31882.768206225574;2724.4006318609872;2829.518981773083;3262.787918785295;3287.6876696713775;3309.851056702454;488742;489130;490120;491505;492738.9999999964;51978;64063.35936640667;64205;64284;64291.67854160793;67018.99471507932;67182.64860729851;67212.32787672158;67244.6637766808;67312.3268767306;17219;17444.127793610267;17444.738328925076;17458.039807810692;17523.299068037137;13283.535076272285;13378.531751388655;13380.19718816874;13380.933095334462;13389;14276.214808185441;14910.403583856742;14928.552143435714;15282.617934551725;16763.497095086925;7612.7922902357695;8277.461964972257;8788.209061184523;8919.063498332582;8976.820463590691;886.6985225023523;889.8976617688919;892.2772554231094;920.4753290624279;924.856647219682;30575.847120764254;31064.91272805441;31075.844620776752;31562;31866.20334491656;907.9682211122579;1081.6160263106483;1089.1286970423787;1112.6328311657296;1259.5339724302066;11966.82049769254;16151.838481615034;16598;16613.83386166147;16833.074180920168;675056;677535;681206;682377;684096;49723.50276497189;55744.163837542466;61351.466213345026;62333.065004024975;63286;1451.9128852268898;1478.3199728124969;1481.8369979302483;1495.6410461489381;1496.3790027138616;30869;31911.6808831918;31990.84004579962;32007.359852803278;32355.19112022218;52583;53184.73407632937;53268;53280;53427;610953;859845;866648;873183;879091;27410.72589274082;27648.032318868743;27696.307592310353;27713.445731085667;27719;46189.76905115453;46228;46639.53360466487;47104.7644761774;48127.75936120297;36215;37726.43410348902;37805.62194378021;37860.24279514449;38104.428433574074;37842.088862729935;38118.618813812616;38908;39419.2116157681;39606.40590391204;36558.63441365552;36850.8157459211;37269.627303726615;37683.43474847825;38282.42576361413;31925.20186995344;34368.312633747686;34403.82798085993;34434;34569;24600.876995614908;25166.49667006613;25232.74767252304;25421.983120674966;25720.61419078678 05:31:47 INFO - PROCESS | 1635 | |2;jquery.html;399.63034193371124;405.3959600195708;406.8596334264681;413.8592878421336;432.4637449562541;20913.268035618756;21166;21528.677069843925;21748.565028699417;21862.344129676116;22101.447463813412;22168.11327546896;22519.662205066936;22811.201607943724;23007.539849203007;5969.283685957691;6280.560360774748;6284.8743025139465;6291;6295.716692748837;5960.761569537213;6147.0164773636225;6161.322254551996;6222.191115155046;6227.314995350531;6174.876502469948;6174.876502469948;6181.041938499539;6184;6202.4417802397775;5963.284405871302;6145.231846019247;6208.4722798561725;6218.036204388327;6220.004799232146;5119.283300337918;5324.627276090675;5326.840194794162;5332.413434522199;5442.12925931849;26751;26822.463550728877;26838.92644294226;26851.597226041624;27098;2843.5023870822524;2866.1831378057364;2911.8252904825567;2918;2924.985375073132;10104.292699511037;15322.923385383001;16388.75416868748;16698.248578813982;16828.411005614867;1617.3773097357484;1652.3060314667869;1661.7092008898394;1665.7834481517325;1707.5218938697185;140993.59006409906;144424;150710;152365;153454.23272883677;11945.88054119465;12069.491313585802;12177.939110304393;12191.268523888595;12300.876991229974;15713.528594142193;16005.879588428697;16257.837421625869;16285.348586056425;16318.102504362136;7882.975213222359;8874.467531948103;8942.552872356486;9182.449053056838;9333.719988400358;8610.397272191012;8833.779155521035;8967.789348438007;9005.234555062762;9189.678361257324;3954.62431069048;4018.7588744674827;4852.296417019513;4919.2867034279825;5009.849704508871;1996.9800301997084;2040.6326861165132;2048.3445297504654;2060.0746939346163;2061.4228016155503;884.5046773806689;912.7854954085784;1021.8007488539663;1051.747580580655;1070.1492313610697;19019.334323298895;21984.01071951766;22219.77780222177;22527.662085068736;22615.321540353816;1047.7747284333905;1055.0082922053246;1058.8200005999;1070.673444599389;1093.4095588382343;10238;10981.505832237568;11435;11533.538658453568;11547;639727;764068;766702;782162;783265;162474;163796;165165;168620;169339;1042.6298663974333;1067.8344856547249;1077.6120596585224;1089.7929393415225;1103.0844399148687;19522.092198405695;20595.382138535868;20749.68875466839;20968.47578810542;21003.57992840165;56755.71622141863;61617;61813.69093154685;62104.44738881564;63032;78833;84748.57625711831;88365.11634883568;89397;94569.5271523638;7582.241775822595;8422.410431269753;8446.873296900429;8460.830783384175;8838.646454141763;9462.384944978554;11364.431778411212;13436;13744.075829383693;14148.372937112365;9749.707508774749;11628.244164129304;11673.12451566119;11839.052875769745;11856.17006809515;9759.56081976327;11751.588694395656;12014.098942579167;12173.87826121763;12204.206726562745;10695.94652026735;10856.13150947938;10999.945000274947;11031.22781405294;11531;8705.173008564176;8732;8958.731238062868;8966.417182883091;9015.368924175245;6779.525433219627;10097.596096156072;11797.410129493663;11887.227330223854;12183.634490965285 05:31:47 INFO - PROCESS | 1635 | |3;mootools.html;1283.5571727753922;1362.7819548872183;1371.8148050013247;1467.449706360115;1493.9626509337268;7519.586422746746;7979.720709775159;8411.285040771527;8487.78780530487;8509.404341696083;8480.812686223933;8557.101504342048;8580.270676992448;8589.527575983318;8597.828043439127;2377.869217193054;2423.0307876849224;2427;2428.6842710447618;2432.3189506937997;2162.426956856434;2233.229535810143;2378.8453750506246;2461.0770960889668;2463.6427717980882;2416.4683769570756;2426.2478631624163;2428.732839387666;2429.101232543961;2432.3675844280438;2379.32189326043;2403.5793736096202;2403.771641694054;2409.9998500622396;2413.0589070262613;2351.5179388225374;2367.7750613691674;2423.7939775119135;2425.345156807652;2439.524292762912;8516.74449766508;8604.139586041409;8608.870866937;8609.096044915257;8616.48301101936;5173.870653233662;5269.920951185735;5319.867003324909;5359.062164121302;5366.8926621467745;3169.31859650174;3330.084226837615;3391.1352605085544;3521.0845180253064;3532.2405682778067;1190.857097148339;1261.829652996843;1263.444084602781;1308.9672758181027;1314.3165553912008;10912.945435272852;11086.279391839586;11087;11098.44507774608;11105.278156919774;4566.383538222364;4713.787879545429;4799.592034677022;4811.663183577116;4820.132376172322;9637.566309516089;9655.710328690151;9663.9033609663;9675.274354423447;9682.031796820262;5397.8110766123;5398.541124004503;5399.163129714901;5400.270963419888;5403.7838486460105;4127.731697439657;4255.255330317182;4874.341963834908;4907.312976183337;4917.844306587949;3668.926621467556;3783.45139954705;3944.6647035001774;4019.598040195957;4027.778472184058;1241.4351470081272;1258.3267951645826;1271.192792576702;1273.6370134511806;1273.7388835288743;914.7392992997097;919.1451949686856;930.8836395450569;938.3947353956796;989.5942663508071;5595.4124816894455;5604.523615492729;5800.332961709373;5835.708214589254;5951.226340575784;999.9900001000043;1005.0100800415219;1017.2878984710732;1033.540074666781;1075.2526993739275;3612;3840;3862.478565393692;3946.605339466088;3961.168154687548;9933.503324833873;10067.949660251652;10158;10253.7436564085;10275.177985761122;10010.249231307682;10100.949495252476;10182.745431364276;10185.236107291983;10187.643432479976;7879.842403151905;7904.367650587939;7942.563159026194;8056.355491560661;8081.757547273473;5569.610127291051;5584.357798853184;5654.123610840326;5682.971585142048;5843.474087331991;9145.405548639317;9180.6786762463;9209.355345125778;9319.30105242096;9446.149846513847;7888.526688398714;9329.11373419524;9466.668666596635;9583.089606487372;9620.230381569598;7213.422926165999;7296.343329100407;7301.269873012656;7306.4885458017425;7309.086364204474;7382.335589796944;7390.408767298711;7935.642896069575;8046.0344758629335;8207.71273005442;7410.925890741024;7426.665800038903;7431.739889103856;7441.255874412732;7514.47398682087;6132.47873930703;7323.011393461815;7362.079740032496;7438.776836694908;7456.440766942393;6359.96820015897;6466.805995820133;6546.869062618625;6548.901766473602;6564.212294524687;5000.624953128603;5056.140456122394;5073.213651883964;5119.436861945258;5126.051680439131;4356.302991521341;4983.875403114951;5119.820806271762;5190.740462976912;5257.2902658140665 05:31:47 INFO - PROCESS | 1635 | |4;prototype.html;370.7627118644068;371.9516462859828;381.544054854449;388.2254901471563;388.59391935427476;4412.249917514022;5165.5092766187245;5324.227986941891;5331.653442526233;5343.1718083697;4539.8662628564525;4698.718076915387;4997.850064498062;5153.1706244283305;5304.124819404794;3270.3132342208164;4188.4136220929095;4218.873433796991;4219.451471308726;4260.403543503897;4192.140611174702;4203.264428724976;4226.640735537483;4237.279662457389;4269.573042695737;3998.1004274038255;4195.930037840347;4196.790160491963;4222;4225.661947044245;4214.894627634303;4224.936625950582;4225.478827622053;4225.619694227519;4249.978750106246;3298.087109476498;3730.608286129944;3760.417135344026;3772.320982223199;3817.770933743984;4844.5882100021545;5153.896922061538;5170.715610641413;5219.295395121686;5247.003069416837;4440.245158323093;4759.571638552547;4844.539768721966;4844.95833395818;4863.1732605457155;5180.896382072375;5297.8477805705925;5368.973155134199;5657;5676.687782171979;4025.939610905839;4119.196756632457;4130.070734084807;4132.690048246393;4132.938005929914;5828.737706803204;5834.6790926499025;5850.736716847752;5898.380670029628;5948.524118070544;4177.644900183518;4188.246115699142;4197.685173611931;4217.325227963511;4257.382679511516;4101.523451557497;4287.421198138274;4298.527162012176;4318.58973397533;4369.781510924505;3970.2803579548104;4039.899002524902;4232.809523571446;4749.121412538691;4816.975915120402;5548.889022219533;5549.390676703711;5584.804531841447;5720.456556627114;5730.484256416942;1393.2824595333411;1395.3651088754796;1405.7118290750373;1406.881529184301;1416.6175132714109;802.8033131882726;830.7175560309523;835.3275613131366;861.8147098373754;886.8581027035643;4941.110600091946;4944.258361245842;4966.013594562204;4968.583953573287;5011.747063234191;4405.017742016105;4673.626109911199;4854.635902307341;5187.766550505236;5395.244665746799;4144.5026596807975;4267.701260911706;4390.648748100144;4414.165422040027;4622.59011001641;2492.800575953919;2853.2595116978628;2854.9000784972427;2855.386091990232;2872.31064544512;4555.498895121534;5001.474845141208;5568.053430916754;5658.472212502684;5689.317281926195;4588.541145885385;5187.559057480081;5488;5556.666600004012;5580.944190558123;4644.674872758942;4799.592034677022;5577.9442205577425;5664.773409063674;5763.510101641324;4872.975635121802;5062.265971434195;5383.542398895981;5386.461353864583;5398.866238090045;4646.535346465326;4932.186189278729;5334.333208348957;5347.973260133675;5357.517823395913;4868.050730107595;4994.350734404504;5151.665141765773;5224.350328207822;5588.77644894216;3332.100332910149;3454.4472884338384;3565.23347480293;3571.0536707771944;3636.254567813539;4713.505081966344;5232.869178270574;5258.474152584864;5750.159948816338;5751.1373294006235;5569.275994120739;5574.498295153294;5588.580856435865;5601.215829783915;5621.381648018796;4659.4122525654375;5248.402040989582;5574.024545704567;5585.609007369445;5668.886622267614;4740.336352910665;5327.467253274796;5410.540104091197;5420.783168673209;5461.371942226695;4941.654084214214;5037.949620503748;5199.48005199477;5290.59799153217;5562.554995600423;4419.547151330914;5029.497050295087;5038.345015148007;5432.701201433959;5491.697956612425 05:31:47 INFO - PROCESS | 1635 | |5;yui.html;742.6027075514601;771.0901136658744;792.2592376128317;872.7076429396152;883.416944816421;11374.146938979567;12090.576829810958;13978.09142405743;14208.07647502913;15973.840261597381;14537;14682.339294731735;14723.411063557445;14759.926200368984;16052.11713355765;864.9870251946226;900.0459512916296;903.3405613901856;903.6204793986509;907.686848037426;611.2054329371821;714.2999860137069;870;887.9334049946248;889.4840992224495;945.981080378392;953.9570719317647;954.4798085043668;955.6320816485634;956.8803899512561;948.0235357581702;948.2603569216022;948.743839163422;949.1030975727905;951.7668171298008;709.8260926073093;710.7015053677417;710.9182444018952;710.9608971506565;713.5076797010047;15768.68462630741;15999.840001599952;16035.679286414206;16169.110698911556;16413.83586164135;14602;14674.633134171625;14885.627859303495;14946.626334341729;15352.002119862173;11898.286102833858;11918.484047206095;11974.820377694341;12229.449674764568;12483.56307529232;3741.7754934704003;3838.7504812187117;3841.78870162141;4000;4000.179963107556;120466.39766801198;124334;125567;125843;126386.36806816;11230.382328971822;11305.434728263554;11402.144839137098;11490.597829076109;11678.824817627743;23475.882620586788;23729.88135059348;23874.88062559676;24568.877155614107;24604.507909841705;7985;8011.959940200261;8014.679412823421;8043.316318112909;8200.220979006985;4331.675124365685;4414.1171765647;4500.842470513517;4570.657200709894;4589.541045895384;3625.619309972468;3725.776453412804;3729.030452082478;3730.8880733578035;3737.8131093445763;677.9796606101825;697.8429853282971;709.7125664106045;712.0021081626629;718.5257729898346;715.5885365914515;722.7759394587695;732.4396836420143;751.9849603008018;768.2394429514852;10534.631287904887;10556.947215264028;10669.89330106689;10854.945725271482;10922.836157457645;677.8136012596575;684.685044879361;707.7593618169847;720.8954701568348;727.6652739739673;5028.798848046037;5105.489451054865;5113;5127.359080114986;5184.14461613837;110711.44644276726;110918.89081109247;111273.88726112635;114572;114886;96125;96261.5186924075;96576;98685;99110.5044474773;67087.66456167786;71830.28169718236;86203.56898215594;86666;88230.67653985195;9048.276137909083;11045.502952367002;11100.722481938015;11356.545738170711;11530.94234528822;49295.75352123217;49636.751816240685;50697.493025070755;51651.74174129105;53013.20480192723;65379.01931470937;69202.26994325183;72790.27209727834;73236.63381683058;73598.89601656086;12882.806757898452;13295.534656286984;13368.732625347633;13454.596362109152;13524.797128043285;11975.64073077809;14586;14694.485693001121;14973.775393368891;15669;13537.729245415234;13556.796648050089;13812.585622431343;14030.649233769238;14184.290785460893;13189.934050329686;14101.012929094864;14102.506412275521;14413.087608964132;14545.85454145445;13738.793918091036;13742.862571374159;14012.929935350257;14173.929130354281;14197.077189982618;11083.889161108285;11134.3876086816;11169.218154729091;11292.322460652387;11804.291742495478;6869.141357330333;9025.232855207381;9350;9626.63965712527;9732.80534389294 05:31:47 INFO - PROCESS | 1635 | __end_tp_report 05:31:47 INFO - PROCESS | 1635 | __start_cc_report 05:31:47 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1592 05:31:47 INFO - PROCESS | 1635 | __end_cc_report 05:31:47 INFO - PROCESS | 1635 | __startTimestamp1490185907474__endTimestamp 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | ------- Summary: start ------- 05:31:47 INFO - PROCESS | 1635 | Number of tests: 6 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5786.11 Median:6066.45 stddev:654.30 (10.8%) stddev-sans-first:617.41 05:31:47 INFO - PROCESS | 1635 | Values: 2953.4 3443.6 3447.1 3451.9 3506.8 5749.7 5774.4 5775.8 5796.5 5821.0 4727.7 5708.6 5744.3 5801.6 5808.1 5277.6 5298.6 5309.2 5312.4 5344.3 5248.3 5248.9 5262.3 5387.6 5387.7 4413.3 5219.7 5234.0 5298.4 5309.5 5356.0 5367.7 5383.0 5387.9 5393.2 5143.4 5231.1 5298.6 5308.4 5357.0 5622.6 5674.1 5692.9 5706.3 5713.2 6218.6 6245.2 6264.7 6320.8 6323.1 6233.3 6285.3 6304.7 6310.9 6334.6 5715.3 5827.3 5900.9 5907.9 5917.5 6267.2 6275.2 6277.4 6278.7 6284.4 6112.0 6131.4 6142.5 6144.6 6150.0 6206.3 6279.2 6290.4 6291.2 6350.3 6234.1 6245.0 6247.9 6250.7 6260.6 6158.8 6200.3 6215.2 6279.0 6289.8 4970.3 5002.9 5021.3 5028.5 5071.6 4421.9 4466.4 4469.4 4477.0 4506.6 5917.9 5935.8 5936.8 5938.9 5952.4 6205.9 6259.6 6270.7 6279.2 6298.6 5903.9 5904.2 5905.3 5922.6 5947.6 5354.8 5514.1 5519.8 5544.1 5555.7 6350.6 6374.3 6401.5 6401.8 6413.8 6203.3 6235.3 6246.8 6254.8 6257.0 6279.9 6363.4 6374.8 6423.3 6434.4 6244.3 6262.3 6274.4 6309.7 6320.1 5297.6 6161.2 6256.1 6269.6 6299.3 5061.6 6040.5 6122.5 6130.1 6252.6 6129.3 6218.8 6240.3 6253.7 6254.1 5842.1 5893.4 6066.5 6073.2 6082.2 5030.6 6093.8 6125.9 6157.6 6223.3 6035.3 6114.0 6125.6 6127.0 6131.7 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:78418.80 Median:37766.03 stddev:182656.48 (483.7%) stddev-sans-first:183075.06 05:31:47 INFO - PROCESS | 1635 | Values: 446.8 499.0 518.2 536.5 589.6 31315.5 33652.7 33705.3 33711.3 33821.0 42356.6 43821.0 43906.8 45490.0 45582.5 9464.6 9649.3 9650.1 9651.1 9662.2 8988.7 9508.9 9585.5 9607.7 9621.7 9103.6 11619.9 11842.2 11846.9 12007.9 11454.2 11532.5 11559.0 11623.8 11671.2 11549.2 11632.9 11637.8 11642.4 11654.3 33525.7 41660.0 41743.0 41744.8 41839.0 3488.5 4065.3 4068.0 4078.0 4120.8 30503.0 30876.7 31708.4 31725.7 31882.8 2724.4 2829.5 3262.8 3287.7 3309.9 488742.0 489130.0 490120.0 491505.0 492739.0 51978.0 64063.4 64205.0 64284.0 64291.7 67019.0 67182.6 67212.3 67244.7 67312.3 17219.0 17444.1 17444.7 17458.0 17523.3 13283.5 13378.5 13380.2 13380.9 13389.0 14276.2 14910.4 14928.6 15282.6 16763.5 7612.8 8277.5 8788.2 8919.1 8976.8 886.7 889.9 892.3 920.5 924.9 30575.8 31064.9 31075.8 31562.0 31866.2 908.0 1081.6 1089.1 1112.6 1259.5 11966.8 16151.8 16598.0 16613.8 16833.1 675056.0 677535.0 681206.0 682377.0 684096.0 49723.5 55744.2 61351.5 62333.1 63286.0 1451.9 1478.3 1481.8 1495.6 1496.4 30869.0 31911.7 31990.8 32007.4 32355.2 52583.0 53184.7 53268.0 53280.0 53427.0 610953.0 859845.0 866648.0 873183.0 879091.0 27410.7 27648.0 27696.3 27713.4 27719.0 46189.8 46228.0 46639.5 47104.8 48127.8 36215.0 37726.4 37805.6 37860.2 38104.4 37842.1 38118.6 38908.0 39419.2 39606.4 36558.6 36850.8 37269.6 37683.4 38282.4 31925.2 34368.3 34403.8 34434.0 34569.0 24600.9 25166.5 25232.7 25422.0 25720.6 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:42051.94 Median:22571.49 stddev:125408.27 (555.6%) stddev-sans-first:125721.08 05:31:47 INFO - PROCESS | 1635 | Values: 399.6 405.4 406.9 413.9 432.5 20913.3 21166.0 21528.7 21748.6 21862.3 22101.4 22168.1 22519.7 22811.2 23007.5 5969.3 6280.6 6284.9 6291.0 6295.7 5960.8 6147.0 6161.3 6222.2 6227.3 6174.9 6174.9 6181.0 6184.0 6202.4 5963.3 6145.2 6208.5 6218.0 6220.0 5119.3 5324.6 5326.8 5332.4 5442.1 26751.0 26822.5 26838.9 26851.6 27098.0 2843.5 2866.2 2911.8 2918.0 2925.0 10104.3 15322.9 16388.8 16698.2 16828.4 1617.4 1652.3 1661.7 1665.8 1707.5 140993.6 144424.0 150710.0 152365.0 153454.2 11945.9 12069.5 12177.9 12191.3 12300.9 15713.5 16005.9 16257.8 16285.3 16318.1 7883.0 8874.5 8942.6 9182.4 9333.7 8610.4 8833.8 8967.8 9005.2 9189.7 3954.6 4018.8 4852.3 4919.3 5009.8 1997.0 2040.6 2048.3 2060.1 2061.4 884.5 912.8 1021.8 1051.7 1070.1 19019.3 21984.0 22219.8 22527.7 22615.3 1047.8 1055.0 1058.8 1070.7 1093.4 10238.0 10981.5 11435.0 11533.5 11547.0 639727.0 764068.0 766702.0 782162.0 783265.0 162474.0 163796.0 165165.0 168620.0 169339.0 1042.6 1067.8 1077.6 1089.8 1103.1 19522.1 20595.4 20749.7 20968.5 21003.6 56755.7 61617.0 61813.7 62104.4 63032.0 78833.0 84748.6 88365.1 89397.0 94569.5 7582.2 8422.4 8446.9 8460.8 8838.6 9462.4 11364.4 13436.0 13744.1 14148.4 9749.7 11628.2 11673.1 11839.1 11856.2 9759.6 11751.6 12014.1 12173.9 12204.2 10695.9 10856.1 10999.9 11031.2 11531.0 8705.2 8732.0 8958.7 8966.4 9015.4 6779.5 10097.6 11797.4 11887.2 12183.6 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5539.97 Median:5149.96 stddev:2997.69 (58.2%) stddev-sans-first:2989.03 05:31:47 INFO - PROCESS | 1635 | Values: 1283.6 1362.8 1371.8 1467.4 1494.0 7519.6 7979.7 8411.3 8487.8 8509.4 8480.8 8557.1 8580.3 8589.5 8597.8 2377.9 2423.0 2427.0 2428.7 2432.3 2162.4 2233.2 2378.8 2461.1 2463.6 2416.5 2426.2 2428.7 2429.1 2432.4 2379.3 2403.6 2403.8 2410.0 2413.1 2351.5 2367.8 2423.8 2425.3 2439.5 8516.7 8604.1 8608.9 8609.1 8616.5 5173.9 5269.9 5319.9 5359.1 5366.9 3169.3 3330.1 3391.1 3521.1 3532.2 1190.9 1261.8 1263.4 1309.0 1314.3 10912.9 11086.3 11087.0 11098.4 11105.3 4566.4 4713.8 4799.6 4811.7 4820.1 9637.6 9655.7 9663.9 9675.3 9682.0 5397.8 5398.5 5399.2 5400.3 5403.8 4127.7 4255.3 4874.3 4907.3 4917.8 3668.9 3783.5 3944.7 4019.6 4027.8 1241.4 1258.3 1271.2 1273.6 1273.7 914.7 919.1 930.9 938.4 989.6 5595.4 5604.5 5800.3 5835.7 5951.2 1000.0 1005.0 1017.3 1033.5 1075.3 3612.0 3840.0 3862.5 3946.6 3961.2 9933.5 10067.9 10158.0 10253.7 10275.2 10010.2 10100.9 10182.7 10185.2 10187.6 7879.8 7904.4 7942.6 8056.4 8081.8 5569.6 5584.4 5654.1 5683.0 5843.5 9145.4 9180.7 9209.4 9319.3 9446.1 7888.5 9329.1 9466.7 9583.1 9620.2 7213.4 7296.3 7301.3 7306.5 7309.1 7382.3 7390.4 7935.6 8046.0 8207.7 7410.9 7426.7 7431.7 7441.3 7514.5 6132.5 7323.0 7362.1 7438.8 7456.4 6360.0 6466.8 6546.9 6548.9 6564.2 5000.6 5056.1 5073.2 5119.4 5126.1 4356.3 4983.9 5119.8 5190.7 5257.3 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4459.07 Median:4865.61 stddev:1295.57 (26.6%) stddev-sans-first:1262.34 05:31:47 INFO - PROCESS | 1635 | Values: 370.8 372.0 381.5 388.2 388.6 4412.2 5165.5 5324.2 5331.7 5343.2 4539.9 4698.7 4997.9 5153.2 5304.1 3270.3 4188.4 4218.9 4219.5 4260.4 4192.1 4203.3 4226.6 4237.3 4269.6 3998.1 4195.9 4196.8 4222.0 4225.7 4214.9 4224.9 4225.5 4225.6 4250.0 3298.1 3730.6 3760.4 3772.3 3817.8 4844.6 5153.9 5170.7 5219.3 5247.0 4440.2 4759.6 4844.5 4845.0 4863.2 5180.9 5297.8 5369.0 5657.0 5676.7 4025.9 4119.2 4130.1 4132.7 4132.9 5828.7 5834.7 5850.7 5898.4 5948.5 4177.6 4188.2 4197.7 4217.3 4257.4 4101.5 4287.4 4298.5 4318.6 4369.8 3970.3 4039.9 4232.8 4749.1 4817.0 5548.9 5549.4 5584.8 5720.5 5730.5 1393.3 1395.4 1405.7 1406.9 1416.6 802.8 830.7 835.3 861.8 886.9 4941.1 4944.3 4966.0 4968.6 5011.7 4405.0 4673.6 4854.6 5187.8 5395.2 4144.5 4267.7 4390.6 4414.2 4622.6 2492.8 2853.3 2854.9 2855.4 2872.3 4555.5 5001.5 5568.1 5658.5 5689.3 4588.5 5187.6 5488.0 5556.7 5580.9 4644.7 4799.6 5577.9 5664.8 5763.5 4873.0 5062.3 5383.5 5386.5 5398.9 4646.5 4932.2 5334.3 5348.0 5357.5 4868.1 4994.4 5151.7 5224.4 5588.8 3332.1 3454.4 3565.2 3571.1 3636.3 4713.5 5232.9 5258.5 5750.2 5751.1 5569.3 5574.5 5588.6 5601.2 5621.4 4659.4 5248.4 5574.0 5585.6 5668.9 4740.3 5327.5 5410.5 5420.8 5461.4 4941.7 5037.9 5199.5 5290.6 5562.6 4419.5 5029.5 5038.3 5432.7 5491.7 05:31:47 INFO - PROCESS | 1635 | 05:31:47 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:21857.26 Median:3840.27 stddev:32511.30 (846.6%) stddev-sans-first:32563.85 05:31:47 INFO - PROCESS | 1635 | Values: 742.6 771.1 792.3 872.7 883.4 11374.1 12090.6 13978.1 14208.1 15973.8 14537.0 14682.3 14723.4 14759.9 16052.1 865.0 900.0 903.3 903.6 907.7 611.2 714.3 870.0 887.9 889.5 946.0 954.0 954.5 955.6 956.9 948.0 948.3 948.7 949.1 951.8 709.8 710.7 710.9 711.0 713.5 15768.7 15999.8 16035.7 16169.1 16413.8 14602.0 14674.6 14885.6 14946.6 15352.0 11898.3 11918.5 11974.8 12229.4 12483.6 3741.8 3838.8 3841.8 4000.0 4000.2 120466.4 124334.0 125567.0 125843.0 126386.4 11230.4 11305.4 11402.1 11490.6 11678.8 23475.9 23729.9 23874.9 24568.9 24604.5 7985.0 8012.0 8014.7 8043.3 8200.2 4331.7 4414.1 4500.8 4570.7 4589.5 3625.6 3725.8 3729.0 3730.9 3737.8 678.0 697.8 709.7 712.0 718.5 715.6 722.8 732.4 752.0 768.2 10534.6 10556.9 10669.9 10854.9 10922.8 677.8 684.7 707.8 720.9 727.7 5028.8 5105.5 5113.0 5127.4 5184.1 110711.4 110918.9 111273.9 114572.0 114886.0 96125.0 96261.5 96576.0 98685.0 99110.5 67087.7 71830.3 86203.6 86666.0 88230.7 9048.3 11045.5 11100.7 11356.5 11530.9 49295.8 49636.8 50697.5 51651.7 53013.2 65379.0 69202.3 72790.3 73236.6 73598.9 12882.8 13295.5 13368.7 13454.6 13524.8 11975.6 14586.0 14694.5 14973.8 15669.0 13537.7 13556.8 13812.6 14030.6 14184.3 13189.9 14101.0 14102.5 14413.1 14545.9 13738.8 13742.9 14012.9 14173.9 14197.1 11083.9 11134.4 11169.2 11292.3 11804.3 6869.1 9025.2 9350.0 9626.6 9732.8 05:31:47 INFO - PROCESS | 1635 | -------- Summary: end -------- 05:31:47 INFO - PROCESS | 1635 | 05:31:48 INFO - TEST-INFO | 1635: exit 0 05:31:48 INFO - TEST-OK | dromaeo_css | took 1117022ms 05:31:48 INFO - TEST-START | kraken 05:31:48 INFO - operating with platform_type : mac_ 05:31:48 INFO - Initialising browser for kraken test... 05:31:48 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpVWX9qe/profile http://localhost:49240/getInfo.html) 05:31:50 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 05:31:50 INFO - PROCESS | 1645 | colorDepth:24 05:31:50 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 05:31:50 INFO - PROCESS | 1645 | __metrics 05:31:50 INFO - PROCESS | 1645 | 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" 05:31:50 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:51 INFO - TEST-INFO | 1645: exit 0 05:31:51 INFO - Browser initialized. 05:31:51 INFO - Running cycle 1/1 for kraken test... 05:31:51 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpVWX9qe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:03 INFO - PROCESS | 1647 | RSS: Main: 167194624 05:32:03 INFO - PROCESS | 1647 | 05:32:05 INFO - PROCESS | 1647 | 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) 05:32:06 INFO - PROCESS | 1647 | RSS: Main: 216010752 05:32:06 INFO - PROCESS | 1647 | 05:32:09 INFO - PROCESS | 1647 | 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) 05:32:09 INFO - PROCESS | 1647 | RSS: Main: 229969920 05:32:09 INFO - PROCESS | 1647 | 05:32:12 INFO - PROCESS | 1647 | 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) 05:32:13 INFO - PROCESS | 1647 | RSS: Main: 326471680 05:32:13 INFO - PROCESS | 1647 | 05:32:15 INFO - PROCESS | 1647 | 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) 05:32:16 INFO - PROCESS | 1647 | RSS: Main: 228614144 05:32:16 INFO - PROCESS | 1647 | 05:32:18 INFO - PROCESS | 1647 | 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) 05:32:18 INFO - PROCESS | 1647 | RSS: Main: 228933632 05:32:18 INFO - PROCESS | 1647 | 05:32:21 INFO - PROCESS | 1647 | 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) 05:32:22 INFO - PROCESS | 1647 | RSS: Main: 268283904 05:32:22 INFO - PROCESS | 1647 | 05:32:24 INFO - PROCESS | 1647 | 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) 05:32:25 INFO - PROCESS | 1647 | RSS: Main: 271151104 05:32:25 INFO - PROCESS | 1647 | 05:32:28 INFO - PROCESS | 1647 | 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) 05:32:29 INFO - PROCESS | 1647 | RSS: Main: 266563584 05:32:29 INFO - PROCESS | 1647 | 05:32:30 INFO - PROCESS | 1647 | 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) 05:32:31 INFO - PROCESS | 1647 | RSS: Main: 246571008 05:32:31 INFO - PROCESS | 1647 | 05:32:33 INFO - PROCESS | 1647 | 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) 05:32:33 INFO - PROCESS | 1647 | RSS: Main: 247705600 05:32:33 INFO - PROCESS | 1647 | 05:32:35 INFO - PROCESS | 1647 | 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) 05:32:36 INFO - PROCESS | 1647 | RSS: Main: 256913408 05:32:36 INFO - PROCESS | 1647 | 05:32:39 INFO - PROCESS | 1647 | 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) 05:32:40 INFO - PROCESS | 1647 | RSS: Main: 272044032 05:32:40 INFO - PROCESS | 1647 | 05:32:43 INFO - PROCESS | 1647 | 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) 05:32:43 INFO - PROCESS | 1647 | RSS: Main: 266240000 05:32:43 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | 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) 05:32:45 INFO - PROCESS | 1647 | RSS: Main: 310853632 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | __start_tp_report 05:32:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 05:32:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 05:32:45 INFO - PROCESS | 1647 | |i|pagename|runs| 05:32:45 INFO - PROCESS | 1647 | |0;ai-astar;112;113;114;112;113;113;113;113;113;114 05:32:45 INFO - PROCESS | 1647 | |1;audio-beat-detection;141;106;108;139;109;108;107;103;126;107 05:32:45 INFO - PROCESS | 1647 | |2;audio-dft;185;187;183;182;187;185;184;182;185;184 05:32:45 INFO - PROCESS | 1647 | |3;audio-fft;78;58;58;87;54;59;58;59;73;58 05:32:45 INFO - PROCESS | 1647 | |4;audio-oscillator;87;72;87;70;68;70;81;67;69;82 05:32:45 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;88;86;89;86;88;89;134;87;89;84 05:32:45 INFO - PROCESS | 1647 | |6;imaging-darkroom;97;103;96;97;97;97;96;97;96;97 05:32:45 INFO - PROCESS | 1647 | |7;imaging-desaturate;86;92;78;123;134;129;86;85;88;84 05:32:45 INFO - PROCESS | 1647 | |8;json-parse-financial;55;53;50;55;55;56;55;58;58;57 05:32:45 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;68;71;79;71;71;68;69;68;68;69 05:32:45 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;81;82;84;84;84;80;80;87;82;88 05:32:45 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;136;133;134;135;138;138;139;148;195;168 05:32:45 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;211;191;181;164;163;161;162;165;165;225 05:32:45 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;65;65;64;64;64;65;62;63;64;63 05:32:45 INFO - PROCESS | 1647 | __end_tp_report 05:32:45 INFO - PROCESS | 1647 | __start_cc_report 05:32:45 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1996 05:32:45 INFO - PROCESS | 1647 | __end_cc_report 05:32:45 INFO - PROCESS | 1647 | __startTimestamp1490185965735__endTimestamp 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | ------- Summary: start ------- 05:32:45 INFO - PROCESS | 1647 | Number of tests: 14 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 05:32:45 INFO - PROCESS | 1647 | Values: 112.0 113.0 114.0 112.0 113.0 113.0 113.0 113.0 113.0 114.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:108.50 stddev:14.37 (13.2%) stddev-sans-first:11.89 05:32:45 INFO - PROCESS | 1647 | Values: 141.0 106.0 108.0 139.0 109.0 108.0 107.0 103.0 126.0 107.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.78 (1.0%) stddev-sans-first:1.87 05:32:45 INFO - PROCESS | 1647 | Values: 185.0 187.0 183.0 182.0 187.0 185.0 184.0 182.0 185.0 184.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:64.20 Median:59.00 stddev:11.05 (18.7%) stddev-sans-first:10.54 05:32:45 INFO - PROCESS | 1647 | Values: 78.0 58.0 58.0 87.0 54.0 59.0 58.0 59.0 73.0 58.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.50 stddev:8.03 (10.5%) stddev-sans-first:7.31 05:32:45 INFO - PROCESS | 1647 | Values: 87.0 72.0 87.0 70.0 68.0 70.0 81.0 67.0 69.0 82.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:88.00 stddev:14.85 (16.9%) stddev-sans-first:15.68 05:32:45 INFO - PROCESS | 1647 | Values: 88.0 86.0 89.0 86.0 88.0 89.0 134.0 87.0 89.0 84.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:97.00 stddev:2.06 (2.1%) stddev-sans-first:2.18 05:32:45 INFO - PROCESS | 1647 | Values: 97.0 103.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 97.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:98.50 Median:85.50 stddev:21.26 (24.9%) stddev-sans-first:22.06 05:32:45 INFO - PROCESS | 1647 | Values: 86.0 92.0 78.0 123.0 134.0 129.0 86.0 85.0 88.0 84.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:2.39 (4.3%) stddev-sans-first:2.54 05:32:45 INFO - PROCESS | 1647 | Values: 55.0 53.0 50.0 55.0 55.0 56.0 55.0 58.0 58.0 57.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:3.36 (4.8%) stddev-sans-first:3.47 05:32:45 INFO - PROCESS | 1647 | Values: 68.0 71.0 79.0 71.0 71.0 68.0 69.0 68.0 68.0 69.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:2.74 (3.3%) stddev-sans-first:2.79 05:32:45 INFO - PROCESS | 1647 | Values: 81.0 82.0 84.0 84.0 84.0 80.0 80.0 87.0 82.0 88.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:138.50 stddev:20.00 (14.4%) stddev-sans-first:20.85 05:32:45 INFO - PROCESS | 1647 | Values: 136.0 133.0 134.0 135.0 138.0 138.0 139.0 148.0 195.0 168.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:173.00 stddev:23.03 (13.3%) stddev-sans-first:21.28 05:32:45 INFO - PROCESS | 1647 | Values: 211.0 191.0 181.0 164.0 163.0 161.0 162.0 165.0 165.0 225.0 05:32:45 INFO - PROCESS | 1647 | 05:32:45 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 05:32:45 INFO - PROCESS | 1647 | Values: 65.0 65.0 64.0 64.0 64.0 65.0 62.0 63.0 64.0 63.0 05:32:45 INFO - PROCESS | 1647 | -------- Summary: end -------- 05:32:45 INFO - PROCESS | 1647 | 05:32:46 INFO - TEST-INFO | 1647: exit 0 05:32:46 INFO - TEST-OK | kraken | took 58555ms 05:32:46 INFO - SUITE-END | took 1175s 05:32:46 INFO - Completed test suite (00:19:35) 05:32:46 INFO - javascript benchmark 05:32:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2953.3502629421523, 3443.6384179661136, 3447.0520606833124, 3451.8791842285523, 3506.824658767061, 5749.712514374285, 5774.422557744224, 5775.797847075353, 5796.478316951474, 5821.0, 4727.692699974499, 5708.571857110723, 5744.33940096889, 5801.593888427812, 5808.1287806829, 5277.604179686539, 5298.602604804636, 5309.177077552986, 5312.389075256357, 5344.331958505187, 5248.291480650101, 5248.947510524903, 5262.342207224097, 5387.622866399353, 5387.703676297802, 4413.271810151337, 5219.686818790866, 5234.0, 5298.4436634153435, 5309.495597918191, 5355.973220133913, 5367.677939323634, 5383.0, 5387.865303367408, 5393.19102134681, 5143.434222235551, 5231.058409486291, 5298.602604804655, 5308.362996440452, 5356.9732151339385, 5622.606417550773, 5674.120511320752, 5692.9146062809095, 5706.315242170925, 5713.171590119451, 6218.595791273553, 6245.188125543696, 6264.749410023594, 6320.810375688737, 6323.114763933053, 6233.252009758858, 6285.277193122758, 6304.684765761694, 6310.87378252437, 6334.556581039329, 5715.342735585461, 5827.271591051119, 5900.852478688067, 5907.940920590782, 5917.467427931507, 6267.185265915402, 6275.215598050244, 6277.403646653652, 6278.6860656966965, 6284.371562843679, 6111.96944015277, 6131.376666649982, 6142.468080853527, 6144.648177401054, 6150.0, 6206.317305096436, 6279.183706118175, 6290.433860952537, 6291.150694656254, 6350.269718982377, 6234.096056071935, 6245.0, 6247.875042499125, 6250.656213908188, 6260.561760676709, 6158.829822333742, 6200.286966998853, 6215.223097112861, 6279.0267508535335, 6289.779857704958, 4970.2793095001025, 5002.89994200114, 5021.322121513622, 5028.522290382408, 5071.568916642127, 4421.894526368408, 4466.441694788152, 4469.351943968171, 4476.955230447719, 4506.639468842484, 5917.905187540318, 5935.792247271324, 5936.7922122725495, 5938.910916336258, 5952.375000624958, 6205.937940620626, 6259.561830671809, 6270.655113968775, 6279.215098112736, 6298.622082675054, 5903.881922361528, 5904.1734157218025, 5905.291365036223, 5922.644641321534, 5947.583669143119, 5354.839354819362, 5514.117741161475, 5519.806806761824, 5544.112941929272, 5555.722213889289, 6350.587211831216, 6374.266959299554, 6401.519886008475, 6401.839954001187, 6413.839654008594, 6203.286622038523, 6235.3452887446165, 6246.843828904132, 6254.8123556293385, 6256.9988801793315, 6279.905801413074, 6363.395477429637, 6374.840628984312, 6423.261324947691, 6434.420902118832, 6244.2819075806865, 6262.279837818709, 6274.403931626488, 6309.716062777278, 6320.08358787964, 5297.629165958346, 6161.168242287413, 6256.061590761422, 6269.5611307208055, 6299.307076221704, 5061.645684802029, 6040.516758659209, 6122.489639783254, 6130.122981477994, 6252.5935814171935, 6129.295131059986, 6218.844528886633, 6240.251169859646, 6253.7185826637, 6254.061890716429, 5842.094475356326, 5893.44012318829, 6066.4540191382985, 6073.210482637229, 6082.209312789486, 5030.647854650139, 6093.75624974996, 6125.917766158295, 6157.568970172224, 6223.315435302023, 6035.288735056094, 6114.023656277781, 6125.601835880653, 6127.0062805303205, 6131.743695906945], "value": 5744.773226551113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.8101057050753, 498.9575886049686, 518.2304278146952, 536.4715754981343, 589.631480324797, 31315.530267045982, 33652.66347336526, 33705.32589348215, 33711.32577348452, 33821.0, 42356.57643423565, 43821.0, 43906.780466097705, 45490.0, 45582.54417455824, 9464.574094165779, 9649.324547281693, 9650.08324209199, 9651.131398174162, 9662.227021838236, 8988.68539601114, 9508.904910950905, 9585.52072396381, 9607.66373176939, 9621.711348659552, 9103.590338434786, 11619.883801162006, 11842.230255033439, 11846.881531184707, 12007.939960300186, 11454.198206125575, 11532.538698452052, 11559.0, 11623.825642615368, 11671.1830171888, 11549.191556591042, 11632.883671163348, 11637.767244655059, 11642.417879106095, 11654.30074195551, 33525.6647433525, 41659.95850103772, 41743.0, 41744.79127604373, 41838.95402614929, 3488.494168345576, 4065.3292206785845, 4067.959320406788, 4078.0, 4120.835166593332, 30503.0, 30876.69123308783, 31708.365832683216, 31725.682743172736, 31882.768206225574, 2724.4006318609872, 2829.518981773083, 3262.787918785295, 3287.6876696713775, 3309.851056702454, 488742.0, 489130.0, 490120.0, 491505.0, 492738.9999999964, 51978.0, 64063.35936640667, 64205.0, 64284.0, 64291.67854160793, 67018.99471507932, 67182.64860729851, 67212.32787672158, 67244.6637766808, 67312.3268767306, 17219.0, 17444.127793610267, 17444.738328925076, 17458.039807810692, 17523.299068037137, 13283.535076272285, 13378.531751388655, 13380.19718816874, 13380.933095334462, 13389.0, 14276.214808185441, 14910.403583856742, 14928.552143435714, 15282.617934551725, 16763.497095086925, 7612.7922902357695, 8277.461964972257, 8788.209061184523, 8919.063498332582, 8976.820463590691, 886.6985225023523, 889.8976617688919, 892.2772554231094, 920.4753290624279, 924.856647219682, 30575.847120764254, 31064.91272805441, 31075.844620776752, 31562.0, 31866.20334491656, 907.9682211122579, 1081.6160263106483, 1089.1286970423787, 1112.6328311657296, 1259.5339724302066, 11966.82049769254, 16151.838481615034, 16598.0, 16613.83386166147, 16833.074180920168, 675056.0, 677535.0, 681206.0, 682377.0, 684096.0, 49723.50276497189, 55744.163837542466, 61351.466213345026, 62333.065004024975, 63286.0, 1451.9128852268898, 1478.3199728124969, 1481.8369979302483, 1495.6410461489381, 1496.3790027138616, 30869.0, 31911.6808831918, 31990.84004579962, 32007.359852803278, 32355.19112022218, 52583.0, 53184.73407632937, 53268.0, 53280.0, 53427.0, 610953.0, 859845.0, 866648.0, 873183.0, 879091.0, 27410.72589274082, 27648.032318868743, 27696.307592310353, 27713.445731085667, 27719.0, 46189.76905115453, 46228.0, 46639.53360466487, 47104.7644761774, 48127.75936120297, 36215.0, 37726.43410348902, 37805.62194378021, 37860.24279514449, 38104.428433574074, 37842.088862729935, 38118.618813812616, 38908.0, 39419.2116157681, 39606.40590391204, 36558.63441365552, 36850.8157459211, 37269.627303726615, 37683.43474847825, 38282.42576361413, 31925.20186995344, 34368.312633747686, 34403.82798085993, 34434.0, 34569.0, 24600.876995614908, 25166.49667006613, 25232.74767252304, 25421.983120674966, 25720.61419078678], "value": 20695.550779406185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.63034193371124, 405.3959600195708, 406.8596334264681, 413.8592878421336, 432.4637449562541, 20913.268035618756, 21166.0, 21528.677069843925, 21748.565028699417, 21862.344129676116, 22101.447463813412, 22168.11327546896, 22519.662205066936, 22811.201607943724, 23007.539849203007, 5969.283685957691, 6280.560360774748, 6284.8743025139465, 6291.0, 6295.716692748837, 5960.761569537213, 6147.0164773636225, 6161.322254551996, 6222.191115155046, 6227.314995350531, 6174.876502469948, 6174.876502469948, 6181.041938499539, 6184.0, 6202.4417802397775, 5963.284405871302, 6145.231846019247, 6208.4722798561725, 6218.036204388327, 6220.004799232146, 5119.283300337918, 5324.627276090675, 5326.840194794162, 5332.413434522199, 5442.12925931849, 26751.0, 26822.463550728877, 26838.92644294226, 26851.597226041624, 27098.0, 2843.5023870822524, 2866.1831378057364, 2911.8252904825567, 2918.0, 2924.985375073132, 10104.292699511037, 15322.923385383001, 16388.75416868748, 16698.248578813982, 16828.411005614867, 1617.3773097357484, 1652.3060314667869, 1661.7092008898394, 1665.7834481517325, 1707.5218938697185, 140993.59006409906, 144424.0, 150710.0, 152365.0, 153454.23272883677, 11945.88054119465, 12069.491313585802, 12177.939110304393, 12191.268523888595, 12300.876991229974, 15713.528594142193, 16005.879588428697, 16257.837421625869, 16285.348586056425, 16318.102504362136, 7882.975213222359, 8874.467531948103, 8942.552872356486, 9182.449053056838, 9333.719988400358, 8610.397272191012, 8833.779155521035, 8967.789348438007, 9005.234555062762, 9189.678361257324, 3954.62431069048, 4018.7588744674827, 4852.296417019513, 4919.2867034279825, 5009.849704508871, 1996.9800301997084, 2040.6326861165132, 2048.3445297504654, 2060.0746939346163, 2061.4228016155503, 884.5046773806689, 912.7854954085784, 1021.8007488539663, 1051.747580580655, 1070.1492313610697, 19019.334323298895, 21984.01071951766, 22219.77780222177, 22527.662085068736, 22615.321540353816, 1047.7747284333905, 1055.0082922053246, 1058.8200005999, 1070.673444599389, 1093.4095588382343, 10238.0, 10981.505832237568, 11435.0, 11533.538658453568, 11547.0, 639727.0, 764068.0, 766702.0, 782162.0, 783265.0, 162474.0, 163796.0, 165165.0, 168620.0, 169339.0, 1042.6298663974333, 1067.8344856547249, 1077.6120596585224, 1089.7929393415225, 1103.0844399148687, 19522.092198405695, 20595.382138535868, 20749.68875466839, 20968.47578810542, 21003.57992840165, 56755.71622141863, 61617.0, 61813.69093154685, 62104.44738881564, 63032.0, 78833.0, 84748.57625711831, 88365.11634883568, 89397.0, 94569.5271523638, 7582.241775822595, 8422.410431269753, 8446.873296900429, 8460.830783384175, 8838.646454141763, 9462.384944978554, 11364.431778411212, 13436.0, 13744.075829383693, 14148.372937112365, 9749.707508774749, 11628.244164129304, 11673.12451566119, 11839.052875769745, 11856.17006809515, 9759.56081976327, 11751.588694395656, 12014.098942579167, 12173.87826121763, 12204.206726562745, 10695.94652026735, 10856.13150947938, 10999.945000274947, 11031.22781405294, 11531.0, 8705.173008564176, 8732.0, 8958.731238062868, 8966.417182883091, 9015.368924175245, 6779.525433219627, 10097.596096156072, 11797.410129493663, 11887.227330223854, 12183.634490965285], "value": 10340.859109962308, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.5571727753922, 1362.7819548872183, 1371.8148050013247, 1467.449706360115, 1493.9626509337268, 7519.586422746746, 7979.720709775159, 8411.285040771527, 8487.78780530487, 8509.404341696083, 8480.812686223933, 8557.101504342048, 8580.270676992448, 8589.527575983318, 8597.828043439127, 2377.869217193054, 2423.0307876849224, 2427.0, 2428.6842710447618, 2432.3189506937997, 2162.426956856434, 2233.229535810143, 2378.8453750506246, 2461.0770960889668, 2463.6427717980882, 2416.4683769570756, 2426.2478631624163, 2428.732839387666, 2429.101232543961, 2432.3675844280438, 2379.32189326043, 2403.5793736096202, 2403.771641694054, 2409.9998500622396, 2413.0589070262613, 2351.5179388225374, 2367.7750613691674, 2423.7939775119135, 2425.345156807652, 2439.524292762912, 8516.74449766508, 8604.139586041409, 8608.870866937, 8609.096044915257, 8616.48301101936, 5173.870653233662, 5269.920951185735, 5319.867003324909, 5359.062164121302, 5366.8926621467745, 3169.31859650174, 3330.084226837615, 3391.1352605085544, 3521.0845180253064, 3532.2405682778067, 1190.857097148339, 1261.829652996843, 1263.444084602781, 1308.9672758181027, 1314.3165553912008, 10912.945435272852, 11086.279391839586, 11087.0, 11098.44507774608, 11105.278156919774, 4566.383538222364, 4713.787879545429, 4799.592034677022, 4811.663183577116, 4820.132376172322, 9637.566309516089, 9655.710328690151, 9663.9033609663, 9675.274354423447, 9682.031796820262, 5397.8110766123, 5398.541124004503, 5399.163129714901, 5400.270963419888, 5403.7838486460105, 4127.731697439657, 4255.255330317182, 4874.341963834908, 4907.312976183337, 4917.844306587949, 3668.926621467556, 3783.45139954705, 3944.6647035001774, 4019.598040195957, 4027.778472184058, 1241.4351470081272, 1258.3267951645826, 1271.192792576702, 1273.6370134511806, 1273.7388835288743, 914.7392992997097, 919.1451949686856, 930.8836395450569, 938.3947353956796, 989.5942663508071, 5595.4124816894455, 5604.523615492729, 5800.332961709373, 5835.708214589254, 5951.226340575784, 999.9900001000043, 1005.0100800415219, 1017.2878984710732, 1033.540074666781, 1075.2526993739275, 3612.0, 3840.0, 3862.478565393692, 3946.605339466088, 3961.168154687548, 9933.503324833873, 10067.949660251652, 10158.0, 10253.7436564085, 10275.177985761122, 10010.249231307682, 10100.949495252476, 10182.745431364276, 10185.236107291983, 10187.643432479976, 7879.842403151905, 7904.367650587939, 7942.563159026194, 8056.355491560661, 8081.757547273473, 5569.610127291051, 5584.357798853184, 5654.123610840326, 5682.971585142048, 5843.474087331991, 9145.405548639317, 9180.6786762463, 9209.355345125778, 9319.30105242096, 9446.149846513847, 7888.526688398714, 9329.11373419524, 9466.668666596635, 9583.089606487372, 9620.230381569598, 7213.422926165999, 7296.343329100407, 7301.269873012656, 7306.4885458017425, 7309.086364204474, 7382.335589796944, 7390.408767298711, 7935.642896069575, 8046.0344758629335, 8207.71273005442, 7410.925890741024, 7426.665800038903, 7431.739889103856, 7441.255874412732, 7514.47398682087, 6132.47873930703, 7323.011393461815, 7362.079740032496, 7438.776836694908, 7456.440766942393, 6359.96820015897, 6466.805995820133, 6546.869062618625, 6548.901766473602, 6564.212294524687, 5000.624953128603, 5056.140456122394, 5073.213651883964, 5119.436861945258, 5126.051680439131, 4356.302991521341, 4983.875403114951, 5119.820806271762, 5190.740462976912, 5257.2902658140665], "value": 4522.716363878473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.7627118644068, 371.9516462859828, 381.544054854449, 388.2254901471563, 388.59391935427476, 4412.249917514022, 5165.5092766187245, 5324.227986941891, 5331.653442526233, 5343.1718083697, 4539.8662628564525, 4698.718076915387, 4997.850064498062, 5153.1706244283305, 5304.124819404794, 3270.3132342208164, 4188.4136220929095, 4218.873433796991, 4219.451471308726, 4260.403543503897, 4192.140611174702, 4203.264428724976, 4226.640735537483, 4237.279662457389, 4269.573042695737, 3998.1004274038255, 4195.930037840347, 4196.790160491963, 4222.0, 4225.661947044245, 4214.894627634303, 4224.936625950582, 4225.478827622053, 4225.619694227519, 4249.978750106246, 3298.087109476498, 3730.608286129944, 3760.417135344026, 3772.320982223199, 3817.770933743984, 4844.5882100021545, 5153.896922061538, 5170.715610641413, 5219.295395121686, 5247.003069416837, 4440.245158323093, 4759.571638552547, 4844.539768721966, 4844.95833395818, 4863.1732605457155, 5180.896382072375, 5297.8477805705925, 5368.973155134199, 5657.0, 5676.687782171979, 4025.939610905839, 4119.196756632457, 4130.070734084807, 4132.690048246393, 4132.938005929914, 5828.737706803204, 5834.6790926499025, 5850.736716847752, 5898.380670029628, 5948.524118070544, 4177.644900183518, 4188.246115699142, 4197.685173611931, 4217.325227963511, 4257.382679511516, 4101.523451557497, 4287.421198138274, 4298.527162012176, 4318.58973397533, 4369.781510924505, 3970.2803579548104, 4039.899002524902, 4232.809523571446, 4749.121412538691, 4816.975915120402, 5548.889022219533, 5549.390676703711, 5584.804531841447, 5720.456556627114, 5730.484256416942, 1393.2824595333411, 1395.3651088754796, 1405.7118290750373, 1406.881529184301, 1416.6175132714109, 802.8033131882726, 830.7175560309523, 835.3275613131366, 861.8147098373754, 886.8581027035643, 4941.110600091946, 4944.258361245842, 4966.013594562204, 4968.583953573287, 5011.747063234191, 4405.017742016105, 4673.626109911199, 4854.635902307341, 5187.766550505236, 5395.244665746799, 4144.5026596807975, 4267.701260911706, 4390.648748100144, 4414.165422040027, 4622.59011001641, 2492.800575953919, 2853.2595116978628, 2854.9000784972427, 2855.386091990232, 2872.31064544512, 4555.498895121534, 5001.474845141208, 5568.053430916754, 5658.472212502684, 5689.317281926195, 4588.541145885385, 5187.559057480081, 5488.0, 5556.666600004012, 5580.944190558123, 4644.674872758942, 4799.592034677022, 5577.9442205577425, 5664.773409063674, 5763.510101641324, 4872.975635121802, 5062.265971434195, 5383.542398895981, 5386.461353864583, 5398.866238090045, 4646.535346465326, 4932.186189278729, 5334.333208348957, 5347.973260133675, 5357.517823395913, 4868.050730107595, 4994.350734404504, 5151.665141765773, 5224.350328207822, 5588.77644894216, 3332.100332910149, 3454.4472884338384, 3565.23347480293, 3571.0536707771944, 3636.254567813539, 4713.505081966344, 5232.869178270574, 5258.474152584864, 5750.159948816338, 5751.1373294006235, 5569.275994120739, 5574.498295153294, 5588.580856435865, 5601.215829783915, 5621.381648018796, 4659.4122525654375, 5248.402040989582, 5574.024545704567, 5585.609007369445, 5668.886622267614, 4740.336352910665, 5327.467253274796, 5410.540104091197, 5420.783168673209, 5461.371942226695, 4941.654084214214, 5037.949620503748, 5199.48005199477, 5290.59799153217, 5562.554995600423, 4419.547151330914, 5029.497050295087, 5038.345015148007, 5432.701201433959, 5491.697956612425], "value": 4064.590386003246, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6027075514601, 771.0901136658744, 792.2592376128317, 872.7076429396152, 883.416944816421, 11374.146938979567, 12090.576829810958, 13978.09142405743, 14208.07647502913, 15973.840261597381, 14537.0, 14682.339294731735, 14723.411063557445, 14759.926200368984, 16052.11713355765, 864.9870251946226, 900.0459512916296, 903.3405613901856, 903.6204793986509, 907.686848037426, 611.2054329371821, 714.2999860137069, 870.0, 887.9334049946248, 889.4840992224495, 945.981080378392, 953.9570719317647, 954.4798085043668, 955.6320816485634, 956.8803899512561, 948.0235357581702, 948.2603569216022, 948.743839163422, 949.1030975727905, 951.7668171298008, 709.8260926073093, 710.7015053677417, 710.9182444018952, 710.9608971506565, 713.5076797010047, 15768.68462630741, 15999.840001599952, 16035.679286414206, 16169.110698911556, 16413.83586164135, 14602.0, 14674.633134171625, 14885.627859303495, 14946.626334341729, 15352.002119862173, 11898.286102833858, 11918.484047206095, 11974.820377694341, 12229.449674764568, 12483.56307529232, 3741.7754934704003, 3838.7504812187117, 3841.78870162141, 4000.0, 4000.179963107556, 120466.39766801198, 124334.0, 125567.0, 125843.0, 126386.36806816, 11230.382328971822, 11305.434728263554, 11402.144839137098, 11490.597829076109, 11678.824817627743, 23475.882620586788, 23729.88135059348, 23874.88062559676, 24568.877155614107, 24604.507909841705, 7985.0, 8011.959940200261, 8014.679412823421, 8043.316318112909, 8200.220979006985, 4331.675124365685, 4414.1171765647, 4500.842470513517, 4570.657200709894, 4589.541045895384, 3625.619309972468, 3725.776453412804, 3729.030452082478, 3730.8880733578035, 3737.8131093445763, 677.9796606101825, 697.8429853282971, 709.7125664106045, 712.0021081626629, 718.5257729898346, 715.5885365914515, 722.7759394587695, 732.4396836420143, 751.9849603008018, 768.2394429514852, 10534.631287904887, 10556.947215264028, 10669.89330106689, 10854.945725271482, 10922.836157457645, 677.8136012596575, 684.685044879361, 707.7593618169847, 720.8954701568348, 727.6652739739673, 5028.798848046037, 5105.489451054865, 5113.0, 5127.359080114986, 5184.14461613837, 110711.44644276726, 110918.89081109247, 111273.88726112635, 114572.0, 114886.0, 96125.0, 96261.5186924075, 96576.0, 98685.0, 99110.5044474773, 67087.66456167786, 71830.28169718236, 86203.56898215594, 86666.0, 88230.67653985195, 9048.276137909083, 11045.502952367002, 11100.722481938015, 11356.545738170711, 11530.94234528822, 49295.75352123217, 49636.751816240685, 50697.493025070755, 51651.74174129105, 53013.20480192723, 65379.01931470937, 69202.26994325183, 72790.27209727834, 73236.63381683058, 73598.89601656086, 12882.806757898452, 13295.534656286984, 13368.732625347633, 13454.596362109152, 13524.797128043285, 11975.64073077809, 14586.0, 14694.485693001121, 14973.775393368891, 15669.0, 13537.729245415234, 13556.796648050089, 13812.585622431343, 14030.649233769238, 14184.290785460893, 13189.934050329686, 14101.012929094864, 14102.506412275521, 14413.087608964132, 14545.85454145445, 13738.793918091036, 13742.862571374159, 14012.929935350257, 14173.929130354281, 14197.077189982618, 11083.889161108285, 11134.3876086816, 11169.218154729091, 11292.322460652387, 11804.291742495478, 6869.141357330333, 9025.232855207381, 9350.0, 9626.63965712527, 9732.80534389294], "value": 7815.355291924716, "unit": "score"}], "name": "dromaeo_css", "value": 7490.659988441713, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 108.0, 139.0, 109.0, 108.0, 107.0, 103.0, 126.0, 107.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 183.0, 182.0, 187.0, 185.0, 184.0, 182.0, 185.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 58.0, 87.0, 54.0, 59.0, 58.0, 59.0, 73.0, 58.0], "value": 64.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 87.0, 70.0, 68.0, 70.0, 81.0, 67.0, 69.0, 82.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 88.0, 89.0, 134.0, 87.0, 89.0, 84.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 103.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 78.0, 123.0, 134.0, 129.0, 86.0, 85.0, 88.0, 84.0], "value": 98.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 50.0, 55.0, 55.0, 56.0, 55.0, 58.0, 58.0, 57.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 79.0, 71.0, 71.0, 68.0, 69.0, 68.0, 68.0, 69.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 84.0, 84.0, 84.0, 80.0, 80.0, 87.0, 82.0, 88.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 134.0, 135.0, 138.0, 138.0, 139.0, 148.0, 195.0, 168.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 191.0, 181.0, 164.0, 163.0, 161.0, 162.0, 165.0, 165.0, 225.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 62.0, 63.0, 64.0, 63.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1437.8000000000002, "alertThreshold": 2.0}]} 05:32:46 INFO - Return code: 0 05:32:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:32:47 INFO - # TBPL SUCCESS # 05:32:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:32:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:32:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:32:47 INFO - 2017-03-22 05:32:47.055 screenresolution[1651:9807] starting screenresolution argv=screenresolution get 05:32:47 INFO - 2017-03-22 05:32:47.058 screenresolution[1651:9807] Display 0: 1600x1200x32@60 05:32:47 INFO - 2017-03-22 05:32:47.064 screenresolution[1652:9810] starting screenresolution argv=screenresolution list 05:32:47 INFO - Available Modes on Display 0 05:32:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:32:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:32:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:32:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:32:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:32:47 INFO - Intel Iris: 05:32:47 INFO - Chipset Model: Intel Iris 05:32:47 INFO - Type: GPU 05:32:47 INFO - Bus: Built-In 05:32:47 INFO - VRAM (Dynamic, Max): 1536 MB 05:32:47 INFO - Vendor: Intel (0x8086) 05:32:47 INFO - Device ID: 0x0a2e 05:32:47 INFO - Revision ID: 0x0009 05:32:47 INFO - Displays: 05:32:47 INFO - Display: 05:32:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:32:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:32:47 INFO - Display Serial Number: 1600x1200 60 05:32:47 INFO - Main Display: Yes 05:32:47 INFO - Mirror: Off 05:32:47 INFO - Online: Yes 05:32:47 INFO - Rotation: Supported 05:32:47 INFO - Return code: 0 05:32:47 INFO - Running post-action listener: _resource_record_post_action 05:32:47 INFO - [mozharness: 2017-03-22 12:32:47.299418Z] Finished run-tests step (success) 05:32:47 INFO - Running post-run listener: _resource_record_post_run 05:32:47 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 40371200; Write bytes: 421531648; Read time: 400; Write time: 1775 05:32:47 INFO - TinderboxPrint: CPU usage
53.6% 05:32:47 INFO - TinderboxPrint: I/O read bytes / time
40,371,200 / 400 05:32:47 INFO - TinderboxPrint: I/O write bytes / time
421,531,648 / 1,775 05:32:47 INFO - TinderboxPrint: CPU idle
2,211.6 (46.4%) 05:32:47 INFO - TinderboxPrint: CPU system
947.6 (19.9%) 05:32:47 INFO - TinderboxPrint: CPU user
1,606.4 (33.7%) 05:32:47 INFO - TinderboxPrint: Swap in / out
161,415,168 / 0 05:32:47 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123068928; Write bytes: 124610560; Read time: 11134; Write time: 346 05:32:47 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35402752; Write bytes: 295540736; Read time: 365; Write time: 1425 05:32:47 INFO - Running post-run listener: _upload_blobber_files 05:32:47 INFO - Blob upload gear active. 05:32:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:32:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:32:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:48 INFO - (blobuploader) - INFO - Done attempting. 05:32:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:50 INFO - (blobuploader) - INFO - Done attempting. 05:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:51 INFO - (blobuploader) - INFO - Done attempting. 05:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:52 INFO - (blobuploader) - INFO - Done attempting. 05:32:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:52 INFO - Return code: 0 05:32:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b13877db1f6a6c09a28d3f38f6fca596f1b11aa4c0a8727b5e705f6ab9d7bcec56110b1ee99eb5217c7b4191b1d4ba9426448140ae943d58516e9d75f67bd0ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cc67770afabdab92dbbf302980fd56936b7272bbb379c6bc22160e33cb78edfbe5d5ae1a4fc7ef46a55bf386c4b3661b5a3729d3d652faa1d89c93f362f434b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa4a846cd9bed7ac3c75ca80def18b1885fc9ba67e24ed62692b19536817ca0d43a59c8420b3bcf85db4eb255444a1d4dfcff44d0bda0ab6622985da9253d54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9ba44451a13197d6649a32fe14021aadc6322457d415da9b9af1e011a1cd2c7d1cf96c16d6da873c72431b7c5f94763a8fbc5965ee7bad3ba1cf02911117fe"} 05:32:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:52 INFO - Contents: 05:32:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b13877db1f6a6c09a28d3f38f6fca596f1b11aa4c0a8727b5e705f6ab9d7bcec56110b1ee99eb5217c7b4191b1d4ba9426448140ae943d58516e9d75f67bd0ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cc67770afabdab92dbbf302980fd56936b7272bbb379c6bc22160e33cb78edfbe5d5ae1a4fc7ef46a55bf386c4b3661b5a3729d3d652faa1d89c93f362f434b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa4a846cd9bed7ac3c75ca80def18b1885fc9ba67e24ed62692b19536817ca0d43a59c8420b3bcf85db4eb255444a1d4dfcff44d0bda0ab6622985da9253d54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9ba44451a13197d6649a32fe14021aadc6322457d415da9b9af1e011a1cd2c7d1cf96c16d6da873c72431b7c5f94763a8fbc5965ee7bad3ba1cf02911117fe"} 05:32:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:52 INFO - Copying logs to upload dir... 05:32:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.398761 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-22 05:32:53.033179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 05:32:53.036310) ========= 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.jDShKiITR6/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.fL83F8fzoe/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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/b13877db1f6a6c09a28d3f38f6fca596f1b11aa4c0a8727b5e705f6ab9d7bcec56110b1ee99eb5217c7b4191b1d4ba9426448140ae943d58516e9d75f67bd0ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cc67770afabdab92dbbf302980fd56936b7272bbb379c6bc22160e33cb78edfbe5d5ae1a4fc7ef46a55bf386c4b3661b5a3729d3d652faa1d89c93f362f434b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa4a846cd9bed7ac3c75ca80def18b1885fc9ba67e24ed62692b19536817ca0d43a59c8420b3bcf85db4eb255444a1d4dfcff44d0bda0ab6622985da9253d54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9ba44451a13197d6649a32fe14021aadc6322457d415da9b9af1e011a1cd2c7d1cf96c16d6da873c72431b7c5f94763a8fbc5965ee7bad3ba1cf02911117fe"} build_url:https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011055 build_url: 'https://queue.taskcluster.net/v1/task/BVLkoNrMTdStZ1d5-a730Q/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/b13877db1f6a6c09a28d3f38f6fca596f1b11aa4c0a8727b5e705f6ab9d7bcec56110b1ee99eb5217c7b4191b1d4ba9426448140ae943d58516e9d75f67bd0ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cc67770afabdab92dbbf302980fd56936b7272bbb379c6bc22160e33cb78edfbe5d5ae1a4fc7ef46a55bf386c4b3661b5a3729d3d652faa1d89c93f362f434b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa4a846cd9bed7ac3c75ca80def18b1885fc9ba67e24ed62692b19536817ca0d43a59c8420b3bcf85db4eb255444a1d4dfcff44d0bda0ab6622985da9253d54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9ba44451a13197d6649a32fe14021aadc6322457d415da9b9af1e011a1cd2c7d1cf96c16d6da873c72431b7c5f94763a8fbc5965ee7bad3ba1cf02911117fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 05:32:53.070669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:32:53.071032) ========= 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.jDShKiITR6/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.fL83F8fzoe/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005242 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:32:53.119870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 05:32:53.120176) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 05:32:53.120514) ========= ========= Total master_lag: 0.18 =========