builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0382 starttime: 1474461321.23 results: success (0) buildid: 20160921032308 builduid: 0d4a10fd008f476190533cadd80efea6 revision: 9ef3676a12ff3ce0489acfc180e8e77d0d3717f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.233902) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.234405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.234691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.259153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.259582) ========= 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.dr441w4wzE/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.4MptEcL7lX/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-21 05:35:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-09-21 05:35:21 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.406544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.406864) ========= 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.dr441w4wzE/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.4MptEcL7lX/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.019832 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:21.455889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 05:35:21.456261) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9ef3676a12ff3ce0489acfc180e8e77d0d3717f6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 9ef3676a12ff3ce0489acfc180e8e77d0d3717f6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dr441w4wzE/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.4MptEcL7lX/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-21 05:35:21,536 truncating revision to first 12 chars 2016-09-21 05:35:21,536 Setting DEBUG logging. 2016-09-21 05:35:21,536 attempt 1/10 2016-09-21 05:35:21,536 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9ef3676a12ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 05:35:22,519 unpacking tar archive at: autoland-9ef3676a12ff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251150 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 05:35:22.730063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:22.730410) ========= script_repo_revision: 9ef3676a12ff3ce0489acfc180e8e77d0d3717f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:22.730806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:22.731098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 05:35:22.749686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 05:35:22.750062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dr441w4wzE/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.4MptEcL7lX/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:35:22 INFO - MultiFileLogger online at 20160921 05:35:22 in /builds/slave/test 05:35:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 05:35:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:22 INFO - {'append_to_log': False, 05:35:22 INFO - 'base_work_dir': '/builds/slave/test', 05:35:22 INFO - 'blob_upload_branch': 'Autoland', 05:35:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:22 INFO - 'branch': 'Autoland', 05:35:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:22 INFO - 'config_files': ('talos/mac_config.py',), 05:35:22 INFO - 'default_actions': ('clobber', 05:35:22 INFO - 'read-buildbot-config', 05:35:22 INFO - 'download-and-extract', 05:35:22 INFO - 'populate-webroot', 05:35:22 INFO - 'create-virtualenv', 05:35:22 INFO - 'install', 05:35:22 INFO - 'run-tests'), 05:35:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:22 INFO - 'download_minidump_stackwalk': True, 05:35:22 INFO - 'download_symbols': 'ondemand', 05:35:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:22 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:22 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:22 INFO - 'installer_path': 'installer.exe', 05:35:22 INFO - 'log_level': 'info', 05:35:22 INFO - 'log_name': 'talos', 05:35:22 INFO - 'log_to_console': True, 05:35:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:35:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:35:22 INFO - 'opt_config_files': (), 05:35:22 INFO - 'pip_index': False, 05:35:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:22 INFO - 'cmd': ('bash', 05:35:22 INFO - '-c', 05:35:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:22 INFO - 'enabled': True, 05:35:22 INFO - 'halt_on_failure': False, 05:35:22 INFO - 'name': 'check_screen_resolution'},), 05:35:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:22 INFO - 'cmd': ('bash', 05:35:22 INFO - '-c', 05:35:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:22 INFO - 'enabled': True, 05:35:22 INFO - 'halt_on_failure': False, 05:35:22 INFO - 'name': 'check_screen_resolution'},), 05:35:22 INFO - 'run_cmd_checks_enabled': True, 05:35:22 INFO - 'sps_profile': False, 05:35:22 INFO - 'sps_profile_interval': 0, 05:35:22 INFO - 'suite': 'dromaeojs', 05:35:22 INFO - 'system_bits': '32', 05:35:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:22 INFO - 'title': 't-yosemite-r7-0382', 05:35:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:22 INFO - 'use_talos_json': True, 05:35:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:22 INFO - 'work_dir': 'build'} 05:35:22 INFO - [mozharness: 2016-09-21 12:35:22.960667Z] Running clobber step. 05:35:22 INFO - Running pre-action listener: _resource_record_pre_action 05:35:22 INFO - Running main action method: clobber 05:35:22 INFO - rmtree: /builds/slave/test/build 05:35:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:23 INFO - Running post-action listener: _resource_record_post_action 05:35:23 INFO - [mozharness: 2016-09-21 12:35:23.181764Z] Finished clobber step (success) 05:35:23 INFO - [mozharness: 2016-09-21 12:35:23.181887Z] Running read-buildbot-config step. 05:35:23 INFO - Running pre-action listener: _resource_record_pre_action 05:35:23 INFO - Running main action method: read_buildbot_config 05:35:23 INFO - Using buildbot properties: 05:35:23 INFO - { 05:35:23 INFO - "project": "", 05:35:23 INFO - "product": "firefox", 05:35:23 INFO - "script_repo_revision": "production", 05:35:23 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 05:35:23 INFO - "repository": "", 05:35:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 05:35:23 INFO - "buildid": "20160921032308", 05:35:23 INFO - "pgo_build": "False", 05:35:23 INFO - "basedir": "/builds/slave/test", 05:35:23 INFO - "buildnumber": 201, 05:35:23 INFO - "slavename": "t-yosemite-r7-0382", 05:35:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:35:23 INFO - "platform": "yosemite_r7", 05:35:23 INFO - "scheduler": "tests-autoland-macosx64-talos", 05:35:23 INFO - "branch": "autoland", 05:35:23 INFO - "repo_path": "integration/autoland", 05:35:23 INFO - "revision": "9ef3676a12ff3ce0489acfc180e8e77d0d3717f6", 05:35:23 INFO - "stage_platform": "macosx64", 05:35:23 INFO - "builduid": "0d4a10fd008f476190533cadd80efea6", 05:35:23 INFO - "slavebuilddir": "test" 05:35:23 INFO - } 05:35:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:35:23 INFO - Running post-action listener: _resource_record_post_action 05:35:23 INFO - [mozharness: 2016-09-21 12:35:23.185302Z] Finished read-buildbot-config step (success) 05:35:23 INFO - [mozharness: 2016-09-21 12:35:23.185433Z] Running download-and-extract step. 05:35:23 INFO - Running pre-action listener: _resource_record_pre_action 05:35:23 INFO - Running main action method: download_and_extract 05:35:23 INFO - mkdir: /builds/slave/test/build/tests 05:35:23 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:35:23 INFO - trying https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:35:23 INFO - Downloading https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:35:24 INFO - Downloaded 1199 bytes. 05:35:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:35:24 INFO - Using the following test package requirements: 05:35:24 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:35:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:35:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:35:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'jsshell-mac.zip'], 05:35:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:35:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:35:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:35:24 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:35:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:35:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:35:24 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:35:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:35:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:35:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:24 INFO - Fetch https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:35:24 INFO - Expected file size: 16432567 05:35:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:35:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:35:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:31 INFO - Fetch https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:35:31 INFO - Expected file size: 16432567 05:35:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:35:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:35:38 INFO - Fetch https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:35:39 INFO - Expected file size: 14414059 05:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:39 INFO - trying https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:35:39 INFO - Downloading https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:35:42 INFO - Downloaded 111314241 bytes. 05:35:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:35:42 INFO - mkdir: /builds/slave/test/properties 05:35:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:42 INFO - Contents: 05:35:42 INFO - build_url:https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:35:43 INFO - Running post-action listener: _resource_record_post_action 05:35:43 INFO - Running post-action listener: set_extra_try_arguments 05:35:43 INFO - [mozharness: 2016-09-21 12:35:43.232318Z] Finished download-and-extract step (success) 05:35:43 INFO - [mozharness: 2016-09-21 12:35:43.232470Z] Running populate-webroot step. 05:35:43 INFO - Running pre-action listener: _resource_record_pre_action 05:35:43 INFO - Running main action method: populate_webroot 05:35:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:43 INFO - '--tppagecycles', 05:35:43 INFO - '7'], 05:35:43 INFO - 'tests': ['tsvgm']}}, 05:35:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['damp', 'tps']}, 05:35:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'tests': ['damp', 'tps']}, 05:35:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['dromaeo_dom']}, 05:35:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['basic_compositor_video']}, 05:35:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:35:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore', 05:35:43 INFO - 'tabpaint']}, 05:35:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore', 05:35:43 INFO - 'tabpaint']}, 05:35:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore', 05:35:43 INFO - 'tabpaint']}, 05:35:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore', 05:35:43 INFO - 'tabpaint']}, 05:35:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore', 05:35:43 INFO - 'tabpaint']}, 05:35:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore', 05:35:43 INFO - 'tabpaint']}, 05:35:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['tsvgx', 05:35:43 INFO - 'tsvgr_opacity', 05:35:43 INFO - 'tart', 05:35:43 INFO - 'tscrollx', 05:35:43 INFO - 'cart']}, 05:35:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:43 INFO - 'tsvgr_opacity', 05:35:43 INFO - 'tart', 05:35:43 INFO - 'tscrollx', 05:35:43 INFO - 'cart']}, 05:35:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--disable-e10s'], 05:35:43 INFO - 'tests': ['tp5o']}, 05:35:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'tests': ['tp5o']}, 05:35:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--disable-e10s', 05:35:43 INFO - '--xperf_path', 05:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:43 INFO - 'tests': ['tp5n']}, 05:35:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--xperf_path', 05:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:43 INFO - 'tests': ['tp5n']}}, 05:35:43 INFO - 'talos.zip': {'path': '', 05:35:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:43 INFO - Running post-action listener: _resource_record_post_action 05:35:43 INFO - [mozharness: 2016-09-21 12:35:43.251277Z] Finished populate-webroot step (success) 05:35:43 INFO - [mozharness: 2016-09-21 12:35:43.251381Z] Running create-virtualenv step. 05:35:43 INFO - Running pre-action listener: _resource_record_pre_action 05:35:43 INFO - Running main action method: create_virtualenv 05:35:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:43 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:35:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:43 INFO - Using real prefix '/tools/python27' 05:35:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:46 INFO - Installing pip.................done. 05:35:46 INFO - Return code: 0 05:35:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35:46 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:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:46 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:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:46 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:35:46 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:35:46 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:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:46 INFO - 'HOME': '/Users/cltbld', 05:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:46 INFO - 'LOGNAME': 'cltbld', 05:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:46 INFO - 'MOZ_NO_REMOTE': '1', 05:35:46 INFO - 'NO_EM_RESTART': '1', 05:35:46 INFO - 'PAGER': '/bin/cat', 05:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:46 INFO - 'PWD': '/builds/slave/test', 05:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:46 INFO - 'SHELL': '/bin/bash', 05:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:35:46 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:46 INFO - 'USER': 'cltbld', 05:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:46 INFO - 'XPC_FLAGS': '0x0', 05:35:46 INFO - 'XPC_SERVICE_NAME': '0', 05:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:47 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:35:47 INFO - Cleaning up... 05:35:47 INFO - Return code: 0 05:35:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:35: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:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:47 INFO - 'HOME': '/Users/cltbld', 05:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:47 INFO - 'LOGNAME': 'cltbld', 05:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:47 INFO - 'MOZ_NO_REMOTE': '1', 05:35:47 INFO - 'NO_EM_RESTART': '1', 05:35:47 INFO - 'PAGER': '/bin/cat', 05:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:47 INFO - 'PWD': '/builds/slave/test', 05:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:47 INFO - 'SHELL': '/bin/bash', 05:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:35:47 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:47 INFO - 'USER': 'cltbld', 05:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:47 INFO - 'XPC_FLAGS': '0x0', 05:35:47 INFO - 'XPC_SERVICE_NAME': '0', 05:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:47 INFO - Downloading/unpacking psutil>=3.1.1 05:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:51 INFO - Installing collected packages: psutil 05:35:51 INFO - Running setup.py install for psutil 05:35:51 INFO - building 'psutil._psutil_osx' extension 05:35:51 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:35:51 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:35:51 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:35:51 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:35:51 INFO - building 'psutil._psutil_posix' extension 05:35:51 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:35:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:35:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:35:51 INFO - ^ 05:35:51 INFO - 1 warning generated. 05:35:51 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:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:51 INFO - Successfully installed psutil 05:35:51 INFO - Cleaning up... 05:35:51 INFO - Return code: 0 05:35:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:35:51 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:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:51 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:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:51 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:35:51 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:35:51 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:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:51 INFO - 'HOME': '/Users/cltbld', 05:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:51 INFO - 'LOGNAME': 'cltbld', 05:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:51 INFO - 'MOZ_NO_REMOTE': '1', 05:35:51 INFO - 'NO_EM_RESTART': '1', 05:35:51 INFO - 'PAGER': '/bin/cat', 05:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:51 INFO - 'PWD': '/builds/slave/test', 05:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:51 INFO - 'SHELL': '/bin/bash', 05:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:35:51 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:51 INFO - 'USER': 'cltbld', 05:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:51 INFO - 'XPC_FLAGS': '0x0', 05:35:51 INFO - 'XPC_SERVICE_NAME': '0', 05:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:35:54 INFO - Installing collected packages: mozsystemmonitor 05:35:54 INFO - Running setup.py install for mozsystemmonitor 05:35:54 INFO - Successfully installed mozsystemmonitor 05:35:54 INFO - Cleaning up... 05:35:54 INFO - Return code: 0 05:35:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:35: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:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:54 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:35:54 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:35:54 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:35:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:35:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:54 INFO - 'HOME': '/Users/cltbld', 05:35:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:54 INFO - 'LOGNAME': 'cltbld', 05:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:54 INFO - 'MOZ_NO_REMOTE': '1', 05:35:54 INFO - 'NO_EM_RESTART': '1', 05:35:54 INFO - 'PAGER': '/bin/cat', 05:35:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:54 INFO - 'PWD': '/builds/slave/test', 05:35:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:54 INFO - 'SHELL': '/bin/bash', 05:35:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:35:54 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:35:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:54 INFO - 'USER': 'cltbld', 05:35:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:54 INFO - 'XPC_FLAGS': '0x0', 05:35:54 INFO - 'XPC_SERVICE_NAME': '0', 05:35:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:55 INFO - Downloading/unpacking jsonschema==2.5.1 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:35:57 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:35:57 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:35:57 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:35:57 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:35:57 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:35:57 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:35:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:58 INFO - warning: no files found matching '*.txt' 05:35:58 INFO - no previously-included directories found matching 'build' 05:35:58 INFO - no previously-included directories found matching 'dist' 05:35:58 INFO - no previously-included directories found matching '.git*' 05:35:58 INFO - Installing collected packages: jsonschema, functools32 05:35:58 INFO - Running setup.py install for functools32 05:35:58 INFO - warning: no files found matching '*.txt' 05:35:58 INFO - no previously-included directories found matching 'build' 05:35:58 INFO - no previously-included directories found matching 'dist' 05:35:58 INFO - no previously-included directories found matching '.git*' 05:35:58 INFO - Successfully installed jsonschema functools32 05:35:58 INFO - Cleaning up... 05:35:58 INFO - Return code: 0 05:35:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:35:58 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:35:58 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:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:58 INFO - 'HOME': '/Users/cltbld', 05:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:58 INFO - 'LOGNAME': 'cltbld', 05:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:58 INFO - 'MOZ_NO_REMOTE': '1', 05:35:58 INFO - 'NO_EM_RESTART': '1', 05:35:58 INFO - 'PAGER': '/bin/cat', 05:35:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:58 INFO - 'PWD': '/builds/slave/test', 05:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:58 INFO - 'SHELL': '/bin/bash', 05:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:35:58 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:58 INFO - 'USER': 'cltbld', 05:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:58 INFO - 'XPC_FLAGS': '0x0', 05:35:58 INFO - 'XPC_SERVICE_NAME': '0', 05:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:35:58 INFO - Cleaning up... 05:35:58 INFO - Return code: 0 05:35:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:35:58 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:35:58 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:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:58 INFO - 'HOME': '/Users/cltbld', 05:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:58 INFO - 'LOGNAME': 'cltbld', 05:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:58 INFO - 'MOZ_NO_REMOTE': '1', 05:35:58 INFO - 'NO_EM_RESTART': '1', 05:35:58 INFO - 'PAGER': '/bin/cat', 05:35:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:58 INFO - 'PWD': '/builds/slave/test', 05:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:58 INFO - 'SHELL': '/bin/bash', 05:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:35:58 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:58 INFO - 'USER': 'cltbld', 05:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:58 INFO - 'XPC_FLAGS': '0x0', 05:35:58 INFO - 'XPC_SERVICE_NAME': '0', 05:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:58 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:35:58 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:35:58 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:35:58 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:35:58 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:35:58 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:36:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:02 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:36:02 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:36:02 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:36:02 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:36:02 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:36:02 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:36:02 INFO - Downloading docopt-0.6.1.tar.gz 05:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:02 INFO - Running setup.py install for blobuploader 05:36:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:02 INFO - Running setup.py install for requests 05:36:03 INFO - Running setup.py install for docopt 05:36:03 INFO - Successfully installed blobuploader requests docopt 05:36:03 INFO - Cleaning up... 05:36:03 INFO - Return code: 0 05:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:03 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:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:36:03 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:36:03 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:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:03 INFO - 'HOME': '/Users/cltbld', 05:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PAGER': '/bin/cat', 05:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test', 05:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:36:03 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - 'XPC_FLAGS': '0x0', 05:36:03 INFO - 'XPC_SERVICE_NAME': '0', 05:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:03 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-WGPPPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:03 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-QtYclQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:03 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-_r7u0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-9_Qhal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-D1WOIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-WZKhY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Xm1E1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-WxM2v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-M1I4yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-oz_uzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-u0hEFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-AQP7yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-fLiNbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-oRi00Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-XObvCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-CnpUki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qG_FBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:05 INFO - Running setup.py install for manifestparser 05:36:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:05 INFO - Running setup.py install for mozcrash 05:36:05 INFO - Running setup.py install for mozdebug 05:36:05 INFO - Running setup.py install for mozdevice 05:36:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozfile 05:36:06 INFO - Running setup.py install for mozhttpd 05:36:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozinfo 05:36:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozInstall 05:36:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozleak 05:36:06 INFO - Running setup.py install for mozlog 05:36:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for moznetwork 05:36:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozprocess 05:36:07 INFO - Running setup.py install for mozprofile 05:36:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozrunner 05:36:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozscreenshot 05:36:07 INFO - Running setup.py install for moztest 05:36:07 INFO - Running setup.py install for mozversion 05:36:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:08 INFO - Cleaning up... 05:36:08 INFO - Return code: 0 05:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:08 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:36:08 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:36:08 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:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:08 INFO - 'HOME': '/Users/cltbld', 05:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:08 INFO - 'LOGNAME': 'cltbld', 05:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:08 INFO - 'MOZ_NO_REMOTE': '1', 05:36:08 INFO - 'NO_EM_RESTART': '1', 05:36:08 INFO - 'PAGER': '/bin/cat', 05:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:08 INFO - 'PWD': '/builds/slave/test', 05:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:08 INFO - 'SHELL': '/bin/bash', 05:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:36:08 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:08 INFO - 'USER': 'cltbld', 05:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:08 INFO - 'XPC_FLAGS': '0x0', 05:36:08 INFO - 'XPC_SERVICE_NAME': '0', 05:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-6d62BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:08 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:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-3__aoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-F0heib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:08 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:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-I7b8f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-jrpIMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:08 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:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-YXBdZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:08 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:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-j3EFa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-aaqSs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Q4yQea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-BzE7q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-9fG_19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Hde8iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-yfoccP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-eLccSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Hlo6cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:09 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-kE8bqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:10 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-8P3iNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:10 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:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:10 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:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:10 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:36:10 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:36:10 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:36:10 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:36:10 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:36:10 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:36:12 INFO - Downloading blessings-1.6.tar.gz 05:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:12 INFO - Installing collected packages: blessings 05:36:12 INFO - Running setup.py install for blessings 05:36:12 INFO - Successfully installed blessings 05:36:12 INFO - Cleaning up... 05:36:12 INFO - Return code: 0 05:36:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:13 INFO - Reading from file tmpfile_stdout 05:36:13 INFO - Current package versions: 05:36:13 INFO - blessings == 1.6 05:36:13 INFO - blobuploader == 1.2.4 05:36:13 INFO - docopt == 0.6.1 05:36:13 INFO - functools32 == 3.2.3-2 05:36:13 INFO - jsonschema == 2.5.1 05:36:13 INFO - manifestparser == 1.1 05:36:13 INFO - mozInstall == 1.12 05:36:13 INFO - mozcrash == 0.17 05:36:13 INFO - mozdebug == 0.1 05:36:13 INFO - mozdevice == 0.48 05:36:13 INFO - mozfile == 1.2 05:36:13 INFO - mozhttpd == 0.7 05:36:13 INFO - mozinfo == 0.9 05:36:13 INFO - mozleak == 0.1 05:36:13 INFO - mozlog == 3.4 05:36:13 INFO - moznetwork == 0.27 05:36:13 INFO - mozprocess == 0.23 05:36:13 INFO - mozprofile == 0.28 05:36:13 INFO - mozrunner == 6.12 05:36:13 INFO - mozscreenshot == 0.1 05:36:13 INFO - mozsystemmonitor == 0.3 05:36:13 INFO - moztest == 0.7 05:36:13 INFO - mozversion == 1.4 05:36:13 INFO - psutil == 3.1.1 05:36:13 INFO - requests == 1.2.3 05:36:13 INFO - wsgiref == 0.1.2 05:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:13 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:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:36:13 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:36:13 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:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:13 INFO - 'HOME': '/Users/cltbld', 05:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:13 INFO - 'LOGNAME': 'cltbld', 05:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:13 INFO - 'MOZ_NO_REMOTE': '1', 05:36:13 INFO - 'NO_EM_RESTART': '1', 05:36:13 INFO - 'PAGER': '/bin/cat', 05:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:13 INFO - 'PWD': '/builds/slave/test', 05:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:13 INFO - 'SHELL': '/bin/bash', 05:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:36:13 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:13 INFO - 'USER': 'cltbld', 05:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:13 INFO - 'XPC_FLAGS': '0x0', 05:36:13 INFO - 'XPC_SERVICE_NAME': '0', 05:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:13 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:36:13 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:36:13 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:36:13 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:36:13 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:36:13 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:36:13 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:36:13 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:36:13 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:36:13 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:36:13 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:36:13 INFO - Cleaning up... 05:36:13 INFO - Return code: 0 05:36:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:13 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:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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 0x103d12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d35d05b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, '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.dr441w4wzE/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.4MptEcL7lX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:36:13 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:36:13 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:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:13 INFO - 'HOME': '/Users/cltbld', 05:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:13 INFO - 'LOGNAME': 'cltbld', 05:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:13 INFO - 'MOZ_NO_REMOTE': '1', 05:36:13 INFO - 'NO_EM_RESTART': '1', 05:36:13 INFO - 'PAGER': '/bin/cat', 05:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:13 INFO - 'PWD': '/builds/slave/test', 05:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:13 INFO - 'SHELL': '/bin/bash', 05:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:36:13 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:13 INFO - 'USER': 'cltbld', 05:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:13 INFO - 'XPC_FLAGS': '0x0', 05:36:13 INFO - 'XPC_SERVICE_NAME': '0', 05:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:36:13 INFO - Cleaning up... 05:36:13 INFO - Return code: 0 05:36:13 INFO - Running post-action listener: _resource_record_post_action 05:36:13 INFO - Running post-action listener: _start_resource_monitoring 05:36:13 INFO - Starting resource monitoring. 05:36:13 INFO - [mozharness: 2016-09-21 12:36:13.820418Z] Finished create-virtualenv step (success) 05:36:13 INFO - [mozharness: 2016-09-21 12:36:13.821411Z] Running install step. 05:36:13 INFO - Running pre-action listener: _resource_record_pre_action 05:36:13 INFO - Running main action method: install 05:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:14 INFO - Reading from file tmpfile_stdout 05:36:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:14 INFO - Reading from file tmpfile_stdout 05:36:14 INFO - Output received: 05:36:14 INFO - Usage: mozinstall [options] installer 05:36:14 INFO - Options: 05:36:14 INFO - -h, --help show this help message and exit 05:36:14 INFO - -d DEST, --destination=DEST 05:36:14 INFO - Directory to install application into. [default: 05:36:14 INFO - "/builds/slave/test"] 05:36:14 INFO - --app=APP Application being installed. [default: firefox] 05:36:14 INFO - mkdir: /builds/slave/test/build/application 05:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:36:48 INFO - Reading from file tmpfile_stdout 05:36:48 INFO - Output received: 05:36:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:36:48 INFO - Running post-action listener: _resource_record_post_action 05:36:48 INFO - [mozharness: 2016-09-21 12:36:48.324155Z] Finished install step (success) 05:36:48 INFO - [mozharness: 2016-09-21 12:36:48.324314Z] Running run-tests step. 05:36:48 INFO - Running pre-action listener: _resource_record_pre_action 05:36:48 INFO - Running main action method: run_tests 05:36:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:48 INFO - 2016-09-21 05:36:48.338 screenresolution[2108:23587] starting screenresolution argv=screenresolution get 05:36:48 INFO - 2016-09-21 05:36:48.341 screenresolution[2108:23587] Display 0: 1600x1200x32@60 05:36:48 INFO - 2016-09-21 05:36:48.347 screenresolution[2109:23592] starting screenresolution argv=screenresolution list 05:36:48 INFO - Available Modes on Display 0 05:36:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:48 INFO - Intel Iris: 05:36:48 INFO - Chipset Model: Intel Iris 05:36:48 INFO - Type: GPU 05:36:48 INFO - Bus: Built-In 05:36:48 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:48 INFO - Vendor: Intel (0x8086) 05:36:48 INFO - Device ID: 0x0a2e 05:36:48 INFO - Revision ID: 0x0009 05:36:48 INFO - Displays: 05:36:48 INFO - Display: 05:36:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:48 INFO - Display Serial Number: 1600x1200 60 05:36:48 INFO - Main Display: Yes 05:36:48 INFO - Mirror: Off 05:36:48 INFO - Online: Yes 05:36:48 INFO - Rotation: Supported 05:36:48 INFO - Return code: 0 05:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:48 INFO - Python 2.7.3 05:36:48 INFO - Return code: 0 05:36:48 INFO - grabbing minidump binary from tooltool 05:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:48 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 0x103b26d30>, '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 0x10394cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:48 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:36:48 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:36:48 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:36:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:48 INFO - Return code: 0 05:36:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:36:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:36:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0382 --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:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr441w4wzE/Render', 05:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:48 INFO - 'HOME': '/Users/cltbld', 05:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:48 INFO - 'LOGNAME': 'cltbld', 05:36:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:48 INFO - 'MOZ_NO_REMOTE': '1', 05:36:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:48 INFO - 'NO_EM_RESTART': '1', 05:36:48 INFO - 'PAGER': '/bin/cat', 05:36:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:48 INFO - 'PWD': '/builds/slave/test', 05:36:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:48 INFO - 'SHELL': '/bin/bash', 05:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MptEcL7lX/Listeners', 05:36:48 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 05:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:48 INFO - 'USER': 'cltbld', 05:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:48 INFO - 'XPC_FLAGS': '0x0', 05:36:48 INFO - 'XPC_SERVICE_NAME': '0', 05:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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:36:48 INFO - mozversion application_buildid: 20160921032308 05:36:48 INFO - mozversion application_changeset: 9ef3676a12ff3ce0489acfc180e8e77d0d3717f6 05:36:48 INFO - mozversion application_display_name: Nightly 05:36:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:48 INFO - mozversion application_name: Firefox 05:36:48 INFO - mozversion application_remotingname: firefox 05:36:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 05:36:48 INFO - mozversion application_vendor: Mozilla 05:36:48 INFO - mozversion application_version: 52.0a1 05:36:48 INFO - mozversion platform_buildid: 20160921032308 05:36:48 INFO - mozversion platform_changeset: 9ef3676a12ff3ce0489acfc180e8e77d0d3717f6 05:36:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 05:36:48 INFO - mozversion platform_version: 52.0a1 05:36:48 INFO - using testdate: 1474461408 05:36:48 INFO - actual date: 1474461408 05:36:48 INFO - starting webserver on 'localhost:49359' 05:36:48 INFO - SUITE-START | Running 2 tests 05:36:48 INFO - TEST-START | dromaeo_css 05:36:48 INFO - operating with platform_type : mac_ 05:36:48 INFO - Initialising browser for dromaeo_css test... 05:36:48 INFO - TEST-INFO | started process 2119 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpi3fWPj/profile http://localhost:49359/getInfo.html) 05:36:51 INFO - PROCESS | 2119 | __metrics Screen width/height:1600/1200 05:36:51 INFO - PROCESS | 2119 | colorDepth:24 05:36:51 INFO - PROCESS | 2119 | Browser inner width/height: 1024/689 05:36:51 INFO - PROCESS | 2119 | __metrics 05:36:51 INFO - PROCESS | 2119 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:36:51 INFO - PROCESS | 2119 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:52 INFO - TEST-INFO | 2119: exit 0 05:36:52 INFO - Browser initialized. 05:36:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:52 INFO - TEST-INFO | started process 2122 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpi3fWPj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:04 INFO - PROCESS | 2122 | RSS: Main: 234967040 05:37:04 INFO - PROCESS | 2122 | 05:37:55 INFO - PROCESS | 2122 | 1474461475563 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:40:07 INFO - PROCESS | 2122 | Cycle 1(1): loaded http://localhost:49359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49359/tests/dromaeo/cssquery-ext.html) 05:40:08 INFO - PROCESS | 2122 | RSS: Main: 367468544 05:40:08 INFO - PROCESS | 2122 | 05:43:11 INFO - PROCESS | 2122 | Cycle 1(1): loaded http://localhost:49359/tests/dromaeo/cssquery-ext.html (next: http://localhost:49359/tests/dromaeo/cssquery-jquery.html) 05:43:12 INFO - PROCESS | 2122 | RSS: Main: 373825536 05:43:12 INFO - PROCESS | 2122 | 05:46:14 INFO - PROCESS | 2122 | Cycle 1(1): loaded http://localhost:49359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49359/tests/dromaeo/cssquery-mootools.html) 05:46:15 INFO - PROCESS | 2122 | RSS: Main: 367800320 05:46:15 INFO - PROCESS | 2122 | 05:49:17 INFO - PROCESS | 2122 | Cycle 1(1): loaded http://localhost:49359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49359/tests/dromaeo/cssquery-prototype.html) 05:49:18 INFO - PROCESS | 2122 | RSS: Main: 341913600 05:49:18 INFO - PROCESS | 2122 | 05:52:21 INFO - PROCESS | 2122 | Cycle 1(1): loaded http://localhost:49359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49359/tests/dromaeo/cssquery-yui.html) 05:52:22 INFO - PROCESS | 2122 | RSS: Main: 326254592 05:52:22 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | Cycle 1(1): loaded http://localhost:49359/tests/dromaeo/cssquery-yui.html (next: http://localhost:49359/tests/dromaeo/cssquery-dojo.html) 05:55:25 INFO - PROCESS | 2122 | RSS: Main: 444370944 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | __start_tp_report 05:55:25 INFO - PROCESS | 2122 | _x_x_mozilla_page_load 05:55:25 INFO - PROCESS | 2122 | _x_x_mozilla_page_load_details 05:55:25 INFO - PROCESS | 2122 | |i|pagename|runs| 05:55:25 INFO - PROCESS | 2122 | |0;dojo.html;3325.401427743007;3334.666533346666;3366.276250606121;3400.1159698478386;3430.142464383904;5595.4124816894255;5647.491725744682;5692.459216374448;5781.595288329813;5801.36185019648;5246.606504512168;5692.117721753135;5724.570657200717;5726.255586773724;5729.197912292282;4730.172219861519;5176.171812509999;5192.376914770233;5220.973895130519;5235.528802407783;5285.603579731516;5293.52358287754;5293.867653308679;5297.364316282052;5302.416734159239;5203.661761985478;5241.580673546107;5249.606279529032;5282.445343238962;5284.048871203182;5279.524842764151;5292.867678308035;5325.920111198335;5331.147016477384;5376.220448035013;5095.541401273866;5107.846764597068;5149.562287205592;5242.9213561796605;5245.423003469616;5598.048331783607;5723.027085395493;5730.312362516483;5731.742071606746;5739.655620662732;6264.373562643699;6281.277653069909;6291.559590828644;6294.968525157391;6299.748010079591;5733.254676892019;6116.454587092042;6225.906611400833;6312.589681670676;6321.146645202884;5793.246877905887;5829.4170582942215;5834.854128646818;5863.970680146572;5884.323302820188;6274.247090349096;6296.275928268308;6299.401556852092;6307.905381419282;6314.968425157845;5981.700914954235;6095.05526643371;6165.971026288776;6216.595921265103;6259.71831267594;5074.594032477393;6195;6198.473129784019;6309.148264984168;6325.114483972247;6216.378362163748;6234.781782637586;6251.718672659741;6257;6264.029075493306;6086.2696476422225;6261;6272.843178920472;6275.497960163176;6283.151774510474;4822.132016237041;4919.3358896549225;4938.08645400602;4965.478624744422;4985.4266759323145;4442.089371678798;4446.911061778746;4461;4493.6854420190275;4507.571780680895;5799.39106393831;5825.766969321265;5849.151872978395;5852.268466441695;5873.647581145145;6106.035994416554;6107.219158344477;6191.783287585003;6258.123862659231;6280.623162610258;5849.298084229919;5851.795187168429;5857.326407463196;5871.706414679249;5922;5428.348598168245;5429.239906413105;5436.347638283352;5442.809501667422;5445.482679145475;6225.937740622536;6228.750849966042;6254.2807577129215;6298.905516417349;6304.621722696653;6277.5605707600025;6287.559870808999;6309.053641953744;6317.020861766434;6318.115463834974;6294.433500984934;6303.49572034227;6307.833050885601;6315.147455093504;6317.241930968313;6079.939200608114;6105.145279660762;6138.97087834436;6236.064590311489;6238.906416403848;6188.845278868064;6313.43179113882;6314.905276420765;6323.620582765049;6326.493880489457;6156.784512542219;6156.846078848064;6167.259928808572;6177.660228687465;6203.720832562455;5988.610740301867;6027.909581356371;6129.785457509144;6181.752729890754;6190.7523699051535;5932.317783454958;5988.4909782668965;5990.610610310316;6077.381070909389;6102.786402475892;6174.691265436621;6179.0422484514975;6181.165542651865;6204.286507051746;6219.720112595034;5815.447532484407;5823.79616713413;5888.411158884077;6046.334903160561;6087.391260873877 05:55:25 INFO - PROCESS | 2122 | |1;ext.html;487.95820922330836;499.5429182298197;530.9575233981282;540.9161579955108;566.2101368590813;29561.2609684758;39028.02429939253;40141.7992910035;40194.39708404376;41920;40119;40659.18681626366;40745;40835.79582102085;40966.7951660242;8786.736397908073;9814.214862810957;9973.601055957753;9974.850377244347;9994.15049720771;8786;11971.221870578429;12145.635630931087;12176.330301833395;12424.254544727346;12070.094742894275;12108.15242932995;12157.331346775924;12170.93914530426;12173.634790956241;8668.826623467558;8854.734357969272;12137.635870923843;12172.026237900947;12204.389780510939;11660.125490588154;11866.228695134789;11875;12196.329201893892;12216.205946613441;39845.425504791674;40144.59855401438;40200.39699404511;40233.195336093406;40252.79873600643;3257.3516271866183;3280.8995499253215;3399.1672040350027;3401.557797486336;3618.9276214475562;29712.257193570334;30088.548671769942;30856.691433085605;30873.536896946564;30921;3146.2606287522412;3313.9834300828343;3333.4333163362044;3336;3341.732661387083;476115.61942190415;476857;478190;480038;483565;56546.47628189735;57019.42980570224;57033.714831426405;57072.14391784126;57213.71393143091;56338;56358.7182064087;56505.43494565002;56529.86940261254;56645.43354566484;15696.136712480695;15927;15962.68074638524;15971.600709982344;15974.76037859433;11035.282706624044;11237.494312755945;11251;12444.688882778002;12517.749645007048;15297.923510382378;15421.922890385476;15594.610134746496;15623.3750649975;16031.759523607156;5703.74333155009;6859.622720750406;6866.622335771481;6891.483138764613;6933.826654333581;873.1748497669768;958.712386284112;1022.9795404091876;1123.3316176874746;1138.3113216504062;28610.855565777136;29587.852060739988;29617.33443990051;30421;30532.847335763625;930.9581068851918;967.3760424526282;1023.902729240721;1051.7055224537141;1062.2245760594808;13016.349182540835;15458.5362439127;15462.226888655747;15724.842751572567;15808.92095539515;586359;591284;592669;592850;593219;45215.321770173476;55097.17354239689;55389.44610553923;55393.44606553883;55437.72281138568;1183.6094088950626;1263.6651287408845;1353.722486890205;1372.9725405492034;1395.7138786548733;29288.853555732087;31031;31074.53388199224;31152;31908.6809131915;39097;47808.52191478041;48107.79730506765;48189.75905120452;48232.041713116945;513594;519392;519698;521114.3944280254;521217;21763.455913601654;22139.557208856055;22192.445188869762;23050.53898922046;38995.6100438992;45960.267549165554;46162.538374615826;46894;47006.52993470158;47680.7615961918;38422.03944901288;38694.80652596719;38705;39852;39953;30415.847920760254;31888;37465.31406086678;38015.809920951324;38768.80615596904;36986;37771;38263.42604860874;38401.65594204189;38418.42372364473;28097.43805123927;30404.695953040187;33272.83363583167;33284.500732488545;33960.66039339575;22257.220997265667;24554.263372098867;24761.876190618932;25450.109246176296;25707.742922570535 05:55:25 INFO - PROCESS | 2122 | |2;jquery.html;350.7124158190285;370.7867975913849;371.0815731065613;381.11581131774284;399.7448013238432;15221.771673424893;15281.923590382046;17068;21303.147874085018;21352.735541847265;20536.8973155134;20557.4860628484;21250.574988500222;21297.893510532464;21457.46356341092;5828.47543721065;5832.329282132546;6038.486728628071;6107.114468402079;6120.60216085953;5743.425657434265;5914.852128696774;5926.614770039955;5926.762929482816;5933.821985340447;4121.402396652498;4347.304431290994;6244.656543890084;6515.283318834924;6570.967145164267;6023.367546407608;6596.868062638769;6606.4384527315;6621.999999999976;6628.668566571652;5761.654300741969;5763.164341170549;5764.135379693038;5768.74040668171;5774.82675519735;25183.496330073296;25799.871000645064;26249.212523624323;26572.86713566439;26910.73089269102;2232.8548644338066;2493.6259561065804;2536.1206563611036;2946.4696354656153;3095.876164953399;9747.707568772948;10299.53652085658;10341.172706183488;10356.223283253787;15414.383424663;1824.1295740373234;1824.7536582561318;1861.8789778664343;1878.3801345555935;2016.616842799878;117913.41043294815;119773;121552.39223803913;122187.389063055;122768;11040.779184416268;11138.387388693538;11231.069125806065;11307.830382544269;11551.711207219718;14261.64514371133;14268.001239913106;14271.500497482539;14286.9999100062;14302.356393962089;6798.626075565891;8044;8299.875501867476;8316.41785075039;8458.957705211435;8193.67225310981;8196;8232.794180145544;8385.748427547183;8386.245237928493;3853.8265778040054;4423.137488189836;4431.290993441098;4431.601155895921;4501.68488205829;1727.680379129865;1772.7961284452454;1825.4249911277905;1827.0590645817415;1899.164367678217;746.391690772019;849.6856163219649;868.2186032570737;903.1375036839802;947.9857802132974;19756.506087347643;20969.895150524455;21001;21423.250186243407;21569.352919412442;833.98332033359;905.8686490458979;929.4423345992485;1010.5806090472519;1019.3476175247847;9128.315376346667;10325.48372581368;11228;11292.887071129348;11317.377544235145;548330;548684;554206;559358;567165;119118.21322680167;119509;120611;121620;122901;897.2014906733012;908.822779557993;933.6498812945146;937.3625934364561;938.2353381993789;14856.405743770129;15148.394064237747;17636.559086022953;18673;18678.34625788091;37555;50242;51129.977400452524;51249.487505124474;51747.461123452515;72109.27890721026;72520;72733.90899136623;72741;75295.62352188423;5310.389305229948;7783.610819459118;8021.598920053857;8039.959800200962;8279.461834980708;10570;12731.61805145847;13130.277834719182;13146.21122732639;13242.66893327636;11275.887241127812;11288.717782055513;11531.250468719507;11571.30572165639;11600;11059.336439813636;11100.389478578756;11199.096153654062;11235.55057797679;11594.94202528982;11417.257878237888;11643.301401915573;11777.528898844294;11832.230904991147;11908.821367679318;6943.583384996917;7771.300582947561;7870.960645196967;8085.83828323442;8386.622601983048;10845.674629761119;11316.114390830286;11556;11576.768464630492;11594 05:55:25 INFO - PROCESS | 2122 | |3;mootools.html;1480.740870347689;1542.9305681244343;1741.6864964306428;1852.3516769130797;1933.0914470199011;8385.748427547176;8861.86707199391;8875.37872348935;8883.46699198047;8884.555772211395;7801.453898227112;7957.641906114224;7979.122296547375;8475.067742548315;8616.052234254226;2354.3054798834387;2376.0970831084164;2377.5126099149634;2382.5711371953043;2382.7498112698177;2354.105439932823;2367.112332875172;2372.110458578033;2388.152205966883;2395.2335252719135;2049.6925461180795;2330.475642980324;2365.042157926043;2379.4408314046186;2400.7479214682467;2344.2381226101415;2359.245041586693;2365.1249037856105;2368.27767530903;2372.810175185981;2325.9415417355763;2375.5842727522613;2378.2151889876473;2387.6418537219383;2387.7373488916205;8757.912420875773;8810.911890881138;8840.38117331787;8843.690470833555;8850.60172292242;5250.343707036621;5410;5411.404745477994;5421.376541697677;5434.809781657663;3327.8336083195745;3452.2750222453315;3643.43526753351;3686.078480379905;3714.665680088778;1068.7167900506372;1073.2272763610267;1081.621432498627;1093.9398333091676;1094.7591529863416;11755.94122029393;11779.941100294529;11794.233374830608;11895.82156267648;11915.463804128834;4092.8335424403904;4575.81696732127;4798.760061996886;4803.735794531264;4805.783739731721;9976.950115249523;9987.700368988943;10003.049710277512;10003.549840257207;10006;5364.14173732201;5364.678119312854;5366.973165134149;5369.382521010056;5370.543503802221;4433;4445.688801783844;4871.80512779492;4921.532454416824;4934.051049835295;3882.6311500407414;3884.786336751449;3967.206558688274;4009.7594144351433;4011.532907262013;1285.4151361130664;1289.8774616411426;1290.374168528263;1302.6873550348039;1307.235267368581;787.4055088408215;857.8730527228342;896.4710820615868;903.1014140929685;933.4725879877848;5422.7017514036315;5438.102713052302;5685.232493613309;5939.584229103922;5999.296880028983;894.3069121430943;929.8651695504115;931.7903471718945;933.9066093390607;980.9656662016795;3913.745606535566;3928.3125453045604;3992.301347264217;4011.4584531088512;4097.91804163921;10309.587616495257;10729.302595331435;10744.677659670222;10756.677299681021;10768.730781730363;10682.51928663212;10693.625723099809;10694.89305106939;10701;10713.410762407986;7776.183500732342;8049.597520123971;8105.594720263845;8107.594620268963;8182.7545173644885;5398.865028374322;5925.970370148121;6006.759729610767;6064.545159112996;6140.293866205265;9621.422714637145;9759.707208783748;9974.40153590787;10117.848232276669;10139.493025348851;9761.755956101155;10174.643887463903;10276.743081423025;10338;10360.171186305228;7414.740484083247;7572.167061623327;7616.2383761625615;7677.424193185422;7679.923200767921;8119.147489513753;8200.38497112707;8218.835623287381;8220.63007164691;8223.506589604644;7187.712491500491;7221.4222862171955;7372.778816635509;7477.663505142173;7499.587522686086;7147.142342918883;7150.821229469305;7199.964000180175;7220.783376498714;7360.043194384696;6820.590764554143;6979.8255043622285;6980.720771169096;6982.79051628452;6986.825329366807;4938.970493301086;5043.193089105872;5068.454121492832;5093.592512598909;5105.897882042413;4946.530079642428;4955.4301255356095;5119.257707632298;5150.8969820604125;5222.29499017643 05:55:25 INFO - PROCESS | 2122 | |4;prototype.html;262.19375420581713;299.2593331504525;307.6354519893926;312.113597383431;315.13652591898204;5096.439391666923;5280.603954703393;5328.760205790739;5401.3248343957;5428.991273228911;4469.664775141861;4697.2954056891485;5114.079465696173;5117.539421452068;5202.086831374433;3866.8646597369097;4044.2518134145275;4064.9187016259657;4084.121913788535;4089.9386509202386;3404.438267685829;3955.9604403956023;4061.0659548303906;4072.572379900112;4119.485064366954;3280.671932806712;4039.2527382434196;4041.211963667086;4047.9797601011956;4070.267351876661;4027.677785777131;4053.6757059435176;4055.837766489337;4059.7970101494957;4095.037666148453;3333.4999750037446;3510.701590364822;3541.8937431876825;3550.8757193498363;3555.235624340779;4520.208963431419;5032.169692000815;5071.695698258116;5135.332406787131;5219.530242278175;4618.699784513996;4621.768911554443;4625.930611040837;4638.536146385334;4669.509701481364;4547.363369128325;5060.2409638554145;5060.74696265189;5563.415841336642;5580.665160090408;3480.2169511859884;3714.7028237740915;3831.1954489556947;3868.9806550967064;3895.435161901537;5116.744162791882;5813.331466881278;5834.112114503348;5866.472017518444;5877.473515890474;3455.652295604716;3816.236752649426;3944.2308749793515;3989.7805620691142;3997.700172487075;3880.8059597020037;4041.777702226347;4052.4124002019544;4054.736442131252;4063.898402539901;3815.939392727951;4638.281066434708;4660.790264438108;4664.323673067454;4671.8364857229835;5026.52248036436;5316.3354580677415;5494.972525137348;5595.944040559623;5610.102383618683;1071.7856428714288;1331.9467221311234;1335.8730920562532;1337.959861204146;1348.716769478401;767.447437844762;847.2586486824028;847.809242920338;858.6476299827797;861.5821326656567;3908.5376212986207;4388.824447022147;4400.931562165841;4446.911061778811;4480.574345437179;4277.337012763027;4659.720416775004;4813.687110337817;4816.373871396766;4907.607391408679;3948.9210215795524;4932.383452068491;5362.463753624685;5382.542483888835;5416.674999500043;3024.7126522980284;3056.982391621519;3064.4024415238814;3072.38552289543;3072.6620071792086;4860.392450943632;5144.6077573928305;5297.443768404262;5711.371749107595;5901.049475262369;5962.522998160137;5969.522438204933;5997.880042399128;6001.399860014051;6036.879262414727;6018.759249630053;6019.969900150471;6067.54493412987;6092;6143.477804386588;5481.232627432083;5765.472149880201;5811.912821307599;5857.7698683275285;5900.970495147497;5300.814471493479;5762.250907382014;5772.797952071657;5774.42255774436;5854.331515518057;5838.94161058384;5891.0103813746855;5954.970225148846;5989.2812862456785;6065.514758819196;3868.709846761448;3885.5337359515906;3888.1446081861945;3889.96110038896;3894.6884249259424;5306.575473961997;5815.121514850007;5862.530997520274;5887.499562537232;5905.409459054232;4911.312416261655;5177.456367081402;5395.489263006364;5669.291338582677;5674.602777805679;4767.070421267819;5572.331320241597;5661.207430959751;5685.459881311269;5716.657000579979;4803.438882363176;4902.117618828645;5444.428335024765;5538.033997930676;5640.520555752642;5575;5722;5725.2843394575675;5736.827895163152;5791.971040144772;4665.323528088476;4975.139294905516;5264.605154613496;5662.773489060556;5745.994450970979 05:55:25 INFO - PROCESS | 2122 | |5;yui.html;718.3678363040524;720.7261240728524;735.569691730338;767.7696690992701;815.6900377856414;13406.1956282623;13435;13438.260895650736;13480.123791953529;13480.191188528695;14029.719405611882;14199;14201.28993550321;14220.146791192536;14241.35913883875;677.915260592426;694.9895751563705;822.7284995951321;832.8167803083327;850.7787975126449;800.0918956983836;810.6068556749972;811.3225456743626;811.5577010529275;812.4069429316603;756.5763172623349;855.0679759062621;857.2070834478114;858.9914100858974;861.1087524412235;712.8217945513621;852.9019162796296;853.2917678326974;853.7097386888488;857.7641148684099;542.446704361549;646.8706258748222;648.7145655911384;665.6139439125295;668.1781408867121;14363.784543231859;14442.927785361111;14453.421863125463;14467.348969296407;14522.419103235858;13293.86706132936;13708.3831227595;13748.862511374859;13885.097468664606;14293.78559321611;10902.5093870776;12272;12734.172278801849;12762.298073605947;12779.744405111938;4166.375043743433;4459;4508.481524624644;4551.249043907751;4602.539746025404;111317;112703;112803.43598282037;113159;113578.86421135765;10905.34567925927;11010.834837477445;11124.944375278072;11194.720131996603;11531.538738450368;21775.891120544296;21938.890305548688;22652.773472265068;22666.433339166324;22751.772482275297;8045.597720113971;8105.797355066171;8263.338932885355;8263.710770123016;8484.53335066565;4327.935080973788;4440.555944405533;4513.638908887347;4526.117407105583;4652.255639097728;3588.5873124591008;3679.6504332088407;3706.425504046877;3713.7586056906757;3719.9956011876643;562.9662220266797;671.1476424940298;678.9490788190906;679.140886778226;681.56039354616;578.8321386797866;626.8495561065403;642.2517766801717;666.5567397680488;681.2234053179379;9378.623695469625;9468.810623787485;9490;9495.123493361009;9736.561854716554;520.9843704688866;578.4302462074853;606.7209083821404;673.6463356737752;679.1442782094498;4554;4646.381374744893;4649.325847752057;4680.3915490985955;4684.789184486638;89797.75505612412;107670;118669.69312148067;143907;149801.7529737033;57023;113511;127614;127771;133531.33234333765;70325.64837175884;94563;110536.89463105588;112447;115509.42245288887;7739;9026.368154229142;9181.265498759949;9236.815263694823;9239.39943903644;60010.699946501736;60967.39032609794;61969;62113.68943155255;62712;87037;88522.11477885139;89570;90579.5471022667;92185.07814921765;11766.411679416165;12144.878551214728;12188.695282618006;12227.938860305641;12421.19262247951;14192.645183870485;14806.037607555474;14891.106533608017;15842.68314633724;15879.444219452263;13783.310834458438;14073.929630351782;14336.211508366723;14382.640433988816;14621.903357248462;13200.782592287249;14019.439222430989;14049.367778450198;14055.22696251716;14065.296735163405;13439.126456780277;13665.521706740217;13732.478496336269;13903.51337703216;13948.372323245276;11164.832527511931;11755.588554400554;11783.175177737476;11823.290602563873;11869.169158158846;9011.684591039282;11423.771524569629;11441.027512661183;11594.304341739522;11815.527378904748 05:55:25 INFO - PROCESS | 2122 | __end_tp_report 05:55:25 INFO - PROCESS | 2122 | __start_cc_report 05:55:25 INFO - PROCESS | 2122 | _x_x_mozilla_cycle_collect,1217 05:55:25 INFO - PROCESS | 2122 | __end_cc_report 05:55:25 INFO - PROCESS | 2122 | __startTimestamp1474462525813__endTimestamp 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | ------- Summary: start ------- 05:55:25 INFO - PROCESS | 2122 | Number of tests: 6 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | [#0] dojo.html Cycles:165 Average:5764.82 Median:5988.49 stddev:641.90 (10.7%) stddev-sans-first:614.68 05:55:25 INFO - PROCESS | 2122 | Values: 3325.4 3334.7 3366.3 3400.1 3430.1 5595.4 5647.5 5692.5 5781.6 5801.4 5246.6 5692.1 5724.6 5726.3 5729.2 4730.2 5176.2 5192.4 5221.0 5235.5 5285.6 5293.5 5293.9 5297.4 5302.4 5203.7 5241.6 5249.6 5282.4 5284.0 5279.5 5292.9 5325.9 5331.1 5376.2 5095.5 5107.8 5149.6 5242.9 5245.4 5598.0 5723.0 5730.3 5731.7 5739.7 6264.4 6281.3 6291.6 6295.0 6299.7 5733.3 6116.5 6225.9 6312.6 6321.1 5793.2 5829.4 5834.9 5864.0 5884.3 6274.2 6296.3 6299.4 6307.9 6315.0 5981.7 6095.1 6166.0 6216.6 6259.7 5074.6 6195.0 6198.5 6309.1 6325.1 6216.4 6234.8 6251.7 6257.0 6264.0 6086.3 6261.0 6272.8 6275.5 6283.2 4822.1 4919.3 4938.1 4965.5 4985.4 4442.1 4446.9 4461.0 4493.7 4507.6 5799.4 5825.8 5849.2 5852.3 5873.6 6106.0 6107.2 6191.8 6258.1 6280.6 5849.3 5851.8 5857.3 5871.7 5922.0 5428.3 5429.2 5436.3 5442.8 5445.5 6225.9 6228.8 6254.3 6298.9 6304.6 6277.6 6287.6 6309.1 6317.0 6318.1 6294.4 6303.5 6307.8 6315.1 6317.2 6079.9 6105.1 6139.0 6236.1 6238.9 6188.8 6313.4 6314.9 6323.6 6326.5 6156.8 6156.8 6167.3 6177.7 6203.7 5988.6 6027.9 6129.8 6181.8 6190.8 5932.3 5988.5 5990.6 6077.4 6102.8 6174.7 6179.0 6181.2 6204.3 6219.7 5815.4 5823.8 5888.4 6046.3 6087.4 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | [#1] ext.html Cycles:180 Average:66253.37 Median:37225.66 stddev:141780.27 (380.9%) stddev-sans-first:142092.02 05:55:25 INFO - PROCESS | 2122 | Values: 488.0 499.5 531.0 540.9 566.2 29561.3 39028.0 40141.8 40194.4 41920.0 40119.0 40659.2 40745.0 40835.8 40966.8 8786.7 9814.2 9973.6 9974.9 9994.2 8786.0 11971.2 12145.6 12176.3 12424.3 12070.1 12108.2 12157.3 12170.9 12173.6 8668.8 8854.7 12137.6 12172.0 12204.4 11660.1 11866.2 11875.0 12196.3 12216.2 39845.4 40144.6 40200.4 40233.2 40252.8 3257.4 3280.9 3399.2 3401.6 3618.9 29712.3 30088.5 30856.7 30873.5 30921.0 3146.3 3314.0 3333.4 3336.0 3341.7 476115.6 476857.0 478190.0 480038.0 483565.0 56546.5 57019.4 57033.7 57072.1 57213.7 56338.0 56358.7 56505.4 56529.9 56645.4 15696.1 15927.0 15962.7 15971.6 15974.8 11035.3 11237.5 11251.0 12444.7 12517.7 15297.9 15421.9 15594.6 15623.4 16031.8 5703.7 6859.6 6866.6 6891.5 6933.8 873.2 958.7 1023.0 1123.3 1138.3 28610.9 29587.9 29617.3 30421.0 30532.8 931.0 967.4 1023.9 1051.7 1062.2 13016.3 15458.5 15462.2 15724.8 15808.9 586359.0 591284.0 592669.0 592850.0 593219.0 45215.3 55097.2 55389.4 55393.4 55437.7 1183.6 1263.7 1353.7 1373.0 1395.7 29288.9 31031.0 31074.5 31152.0 31908.7 39097.0 47808.5 48107.8 48189.8 48232.0 513594.0 519392.0 519698.0 521114.4 521217.0 21763.5 22139.6 22192.4 23050.5 38995.6 45960.3 46162.5 46894.0 47006.5 47680.8 38422.0 38694.8 38705.0 39852.0 39953.0 30415.8 31888.0 37465.3 38015.8 38768.8 36986.0 37771.0 38263.4 38401.7 38418.4 28097.4 30404.7 33272.8 33284.5 33960.7 22257.2 24554.3 24761.9 25450.1 25707.7 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | [#2] jquery.html Cycles:180 Average:33404.60 Median:26411.04 stddev:92953.88 (352.0%) stddev-sans-first:93181.50 05:55:25 INFO - PROCESS | 2122 | Values: 350.7 370.8 371.1 381.1 399.7 15221.8 15281.9 17068.0 21303.1 21352.7 20536.9 20557.5 21250.6 21297.9 21457.5 5828.5 5832.3 6038.5 6107.1 6120.6 5743.4 5914.9 5926.6 5926.8 5933.8 4121.4 4347.3 6244.7 6515.3 6571.0 6023.4 6596.9 6606.4 6622.0 6628.7 5761.7 5763.2 5764.1 5768.7 5774.8 25183.5 25799.9 26249.2 26572.9 26910.7 2232.9 2493.6 2536.1 2946.5 3095.9 9747.7 10299.5 10341.2 10356.2 15414.4 1824.1 1824.8 1861.9 1878.4 2016.6 117913.4 119773.0 121552.4 122187.4 122768.0 11040.8 11138.4 11231.1 11307.8 11551.7 14261.6 14268.0 14271.5 14287.0 14302.4 6798.6 8044.0 8299.9 8316.4 8459.0 8193.7 8196.0 8232.8 8385.7 8386.2 3853.8 4423.1 4431.3 4431.6 4501.7 1727.7 1772.8 1825.4 1827.1 1899.2 746.4 849.7 868.2 903.1 948.0 19756.5 20969.9 21001.0 21423.3 21569.4 834.0 905.9 929.4 1010.6 1019.3 9128.3 10325.5 11228.0 11292.9 11317.4 548330.0 548684.0 554206.0 559358.0 567165.0 119118.2 119509.0 120611.0 121620.0 122901.0 897.2 908.8 933.6 937.4 938.2 14856.4 15148.4 17636.6 18673.0 18678.3 37555.0 50242.0 51130.0 51249.5 51747.5 72109.3 72520.0 72733.9 72741.0 75295.6 5310.4 7783.6 8021.6 8040.0 8279.5 10570.0 12731.6 13130.3 13146.2 13242.7 11275.9 11288.7 11531.3 11571.3 11600.0 11059.3 11100.4 11199.1 11235.6 11594.9 11417.3 11643.3 11777.5 11832.2 11908.8 6943.6 7771.3 7871.0 8085.8 8386.6 10845.7 11316.1 11556.0 11576.8 11594.0 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | [#3] mootools.html Cycles:180 Average:5705.99 Median:4950.98 stddev:3187.03 (64.4%) stddev-sans-first:3180.15 05:55:25 INFO - PROCESS | 2122 | Values: 1480.7 1542.9 1741.7 1852.4 1933.1 8385.7 8861.9 8875.4 8883.5 8884.6 7801.5 7957.6 7979.1 8475.1 8616.1 2354.3 2376.1 2377.5 2382.6 2382.7 2354.1 2367.1 2372.1 2388.2 2395.2 2049.7 2330.5 2365.0 2379.4 2400.7 2344.2 2359.2 2365.1 2368.3 2372.8 2325.9 2375.6 2378.2 2387.6 2387.7 8757.9 8810.9 8840.4 8843.7 8850.6 5250.3 5410.0 5411.4 5421.4 5434.8 3327.8 3452.3 3643.4 3686.1 3714.7 1068.7 1073.2 1081.6 1093.9 1094.8 11755.9 11779.9 11794.2 11895.8 11915.5 4092.8 4575.8 4798.8 4803.7 4805.8 9977.0 9987.7 10003.0 10003.5 10006.0 5364.1 5364.7 5367.0 5369.4 5370.5 4433.0 4445.7 4871.8 4921.5 4934.1 3882.6 3884.8 3967.2 4009.8 4011.5 1285.4 1289.9 1290.4 1302.7 1307.2 787.4 857.9 896.5 903.1 933.5 5422.7 5438.1 5685.2 5939.6 5999.3 894.3 929.9 931.8 933.9 981.0 3913.7 3928.3 3992.3 4011.5 4097.9 10309.6 10729.3 10744.7 10756.7 10768.7 10682.5 10693.6 10694.9 10701.0 10713.4 7776.2 8049.6 8105.6 8107.6 8182.8 5398.9 5926.0 6006.8 6064.5 6140.3 9621.4 9759.7 9974.4 10117.8 10139.5 9761.8 10174.6 10276.7 10338.0 10360.2 7414.7 7572.2 7616.2 7677.4 7679.9 8119.1 8200.4 8218.8 8220.6 8223.5 7187.7 7221.4 7372.8 7477.7 7499.6 7147.1 7150.8 7200.0 7220.8 7360.0 6820.6 6979.8 6980.7 6982.8 6986.8 4939.0 5043.2 5068.5 5093.6 5105.9 4946.5 4955.4 5119.3 5150.9 5222.3 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | [#4] prototype.html Cycles:180 Average:4520.20 Median:4921.85 stddev:1396.33 (28.4%) stddev-sans-first:1363.18 05:55:25 INFO - PROCESS | 2122 | Values: 262.2 299.3 307.6 312.1 315.1 5096.4 5280.6 5328.8 5401.3 5429.0 4469.7 4697.3 5114.1 5117.5 5202.1 3866.9 4044.3 4064.9 4084.1 4089.9 3404.4 3956.0 4061.1 4072.6 4119.5 3280.7 4039.3 4041.2 4048.0 4070.3 4027.7 4053.7 4055.8 4059.8 4095.0 3333.5 3510.7 3541.9 3550.9 3555.2 4520.2 5032.2 5071.7 5135.3 5219.5 4618.7 4621.8 4625.9 4638.5 4669.5 4547.4 5060.2 5060.7 5563.4 5580.7 3480.2 3714.7 3831.2 3869.0 3895.4 5116.7 5813.3 5834.1 5866.5 5877.5 3455.7 3816.2 3944.2 3989.8 3997.7 3880.8 4041.8 4052.4 4054.7 4063.9 3815.9 4638.3 4660.8 4664.3 4671.8 5026.5 5316.3 5495.0 5595.9 5610.1 1071.8 1331.9 1335.9 1338.0 1348.7 767.4 847.3 847.8 858.6 861.6 3908.5 4388.8 4400.9 4446.9 4480.6 4277.3 4659.7 4813.7 4816.4 4907.6 3948.9 4932.4 5362.5 5382.5 5416.7 3024.7 3057.0 3064.4 3072.4 3072.7 4860.4 5144.6 5297.4 5711.4 5901.0 5962.5 5969.5 5997.9 6001.4 6036.9 6018.8 6020.0 6067.5 6092.0 6143.5 5481.2 5765.5 5811.9 5857.8 5901.0 5300.8 5762.3 5772.8 5774.4 5854.3 5838.9 5891.0 5955.0 5989.3 6065.5 3868.7 3885.5 3888.1 3890.0 3894.7 5306.6 5815.1 5862.5 5887.5 5905.4 4911.3 5177.5 5395.5 5669.3 5674.6 4767.1 5572.3 5661.2 5685.5 5716.7 4803.4 4902.1 5444.4 5538.0 5640.5 5575.0 5722.0 5725.3 5736.8 5792.0 4665.3 4975.1 5264.6 5662.8 5746.0 05:55:25 INFO - PROCESS | 2122 | 05:55:25 INFO - PROCESS | 2122 | [#5] yui.html Cycles:180 Average:23398.73 Median:4247.16 stddev:36240.67 (853.3%) stddev-sans-first:36302.32 05:55:25 INFO - PROCESS | 2122 | Values: 718.4 720.7 735.6 767.8 815.7 13406.2 13435.0 13438.3 13480.1 13480.2 14029.7 14199.0 14201.3 14220.1 14241.4 677.9 695.0 822.7 832.8 850.8 800.1 810.6 811.3 811.6 812.4 756.6 855.1 857.2 859.0 861.1 712.8 852.9 853.3 853.7 857.8 542.4 646.9 648.7 665.6 668.2 14363.8 14442.9 14453.4 14467.3 14522.4 13293.9 13708.4 13748.9 13885.1 14293.8 10902.5 12272.0 12734.2 12762.3 12779.7 4166.4 4459.0 4508.5 4551.2 4602.5 111317.0 112703.0 112803.4 113159.0 113578.9 10905.3 11010.8 11124.9 11194.7 11531.5 21775.9 21938.9 22652.8 22666.4 22751.8 8045.6 8105.8 8263.3 8263.7 8484.5 4327.9 4440.6 4513.6 4526.1 4652.3 3588.6 3679.7 3706.4 3713.8 3720.0 563.0 671.1 678.9 679.1 681.6 578.8 626.8 642.3 666.6 681.2 9378.6 9468.8 9490.0 9495.1 9736.6 521.0 578.4 606.7 673.6 679.1 4554.0 4646.4 4649.3 4680.4 4684.8 89797.8 107670.0 118669.7 143907.0 149801.8 57023.0 113511.0 127614.0 127771.0 133531.3 70325.6 94563.0 110536.9 112447.0 115509.4 7739.0 9026.4 9181.3 9236.8 9239.4 60010.7 60967.4 61969.0 62113.7 62712.0 87037.0 88522.1 89570.0 90579.5 92185.1 11766.4 12144.9 12188.7 12227.9 12421.2 14192.6 14806.0 14891.1 15842.7 15879.4 13783.3 14073.9 14336.2 14382.6 14621.9 13200.8 14019.4 14049.4 14055.2 14065.3 13439.1 13665.5 13732.5 13903.5 13948.4 11164.8 11755.6 11783.2 11823.3 11869.2 9011.7 11423.8 11441.0 11594.3 11815.5 05:55:25 INFO - PROCESS | 2122 | -------- Summary: end -------- 05:55:25 INFO - PROCESS | 2122 | 05:55:26 INFO - TEST-INFO | 2122: exit 0 05:55:26 INFO - TEST-OK | dromaeo_css | took 1117518ms 05:55:26 INFO - TEST-START | kraken 05:55:26 INFO - operating with platform_type : mac_ 05:55:26 INFO - Initialising browser for kraken test... 05:55:26 INFO - TEST-INFO | started process 2126 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpu2Nt6v/profile http://localhost:49359/getInfo.html) 05:55:28 INFO - PROCESS | 2126 | __metrics Screen width/height:1600/1200 05:55:28 INFO - PROCESS | 2126 | colorDepth:24 05:55:28 INFO - PROCESS | 2126 | Browser inner width/height: 1024/689 05:55:28 INFO - PROCESS | 2126 | __metrics 05:55:28 INFO - PROCESS | 2126 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:55:28 INFO - PROCESS | 2126 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:29 INFO - TEST-INFO | 2126: exit 0 05:55:29 INFO - Browser initialized. 05:55:29 INFO - Running cycle 1/1 for kraken test... 05:55:29 INFO - TEST-INFO | started process 2127 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpu2Nt6v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:41 INFO - PROCESS | 2127 | RSS: Main: 235450368 05:55:41 INFO - PROCESS | 2127 | 05:55:44 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49359/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:45 INFO - PROCESS | 2127 | RSS: Main: 294830080 05:55:45 INFO - PROCESS | 2127 | 05:55:48 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49359/tests/kraken/driver.html?testName=audio-dft) 05:55:48 INFO - PROCESS | 2127 | RSS: Main: 293974016 05:55:48 INFO - PROCESS | 2127 | 05:55:52 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49359/tests/kraken/driver.html?testName=audio-fft) 05:55:52 INFO - PROCESS | 2127 | RSS: Main: 383254528 05:55:52 INFO - PROCESS | 2127 | 05:55:54 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49359/tests/kraken/driver.html?testName=audio-oscillator) 05:55:55 INFO - PROCESS | 2127 | RSS: Main: 283869184 05:55:55 INFO - PROCESS | 2127 | 05:55:57 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:58 INFO - PROCESS | 2127 | RSS: Main: 289648640 05:55:58 INFO - PROCESS | 2127 | 05:56:00 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49359/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:01 INFO - PROCESS | 2127 | RSS: Main: 326066176 05:56:01 INFO - PROCESS | 2127 | 05:56:04 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49359/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:05 INFO - PROCESS | 2127 | RSS: Main: 328032256 05:56:05 INFO - PROCESS | 2127 | 05:56:07 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49359/tests/kraken/driver.html?testName=json-parse-financial) 05:56:08 INFO - PROCESS | 2127 | RSS: Main: 325832704 05:56:08 INFO - PROCESS | 2127 | 05:56:10 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:10 INFO - PROCESS | 2127 | RSS: Main: 299577344 05:56:10 INFO - PROCESS | 2127 | 05:56:12 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:13 INFO - PROCESS | 2127 | RSS: Main: 305352704 05:56:13 INFO - PROCESS | 2127 | 05:56:15 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:16 INFO - PROCESS | 2127 | RSS: Main: 303226880 05:56:16 INFO - PROCESS | 2127 | 05:56:19 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:19 INFO - PROCESS | 2127 | RSS: Main: 320593920 05:56:19 INFO - PROCESS | 2127 | 05:56:23 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:23 INFO - PROCESS | 2127 | RSS: Main: 316776448 05:56:23 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | Cycle 1(1): loaded http://localhost:49359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49359/tests/kraken/driver.html?testName=ai-astar) 05:56:25 INFO - PROCESS | 2127 | RSS: Main: 360308736 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | __start_tp_report 05:56:25 INFO - PROCESS | 2127 | _x_x_mozilla_page_load 05:56:25 INFO - PROCESS | 2127 | _x_x_mozilla_page_load_details 05:56:25 INFO - PROCESS | 2127 | |i|pagename|runs| 05:56:25 INFO - PROCESS | 2127 | |0;ai-astar;114;122;169;146;112;111;112;112;113;113 05:56:25 INFO - PROCESS | 2127 | |1;audio-beat-detection;151;129;139;147;109;108;109;110;139;109 05:56:25 INFO - PROCESS | 2127 | |2;audio-dft;184;185;184;184;184;183;183;185;185;186 05:56:25 INFO - PROCESS | 2127 | |3;audio-fft;81;58;58;90;62;58;59;58;83;64 05:56:25 INFO - PROCESS | 2127 | |4;audio-oscillator;90;70;90;69;68;70;91;69;69;89 05:56:25 INFO - PROCESS | 2127 | |5;imaging-gaussian-blur;90;88;88;85;88;85;89;86;89;85 05:56:25 INFO - PROCESS | 2127 | |6;imaging-darkroom;92;94;94;93;95;94;95;103;149;130 05:56:25 INFO - PROCESS | 2127 | |7;imaging-desaturate;83;96;120;84;83;85;86;83;85;85 05:56:25 INFO - PROCESS | 2127 | |8;json-parse-financial;57;55;54;52;53;55;54;52;54;54 05:56:25 INFO - PROCESS | 2127 | |9;json-stringify-tinderbox;66;70;80;76;72;69;69;70;71;71 05:56:25 INFO - PROCESS | 2127 | |10;stanford-crypto-aes;87;87;86;86;90;94;103;105;83;85 05:56:25 INFO - PROCESS | 2127 | |11;stanford-crypto-ccm;165;169;155;139;134;139;139;137;180;140 05:56:25 INFO - PROCESS | 2127 | |12;stanford-crypto-pbkdf2;169;171;170;170;168;171;203;167;226;229 05:56:25 INFO - PROCESS | 2127 | |13;stanford-crypto-sha256-iterative;67;68;66;68;67;66;67;68;67;68 05:56:25 INFO - PROCESS | 2127 | __end_tp_report 05:56:25 INFO - PROCESS | 2127 | __start_cc_report 05:56:25 INFO - PROCESS | 2127 | _x_x_mozilla_cycle_collect,2076 05:56:25 INFO - PROCESS | 2127 | __end_cc_report 05:56:25 INFO - PROCESS | 2127 | __startTimestamp1474462585602__endTimestamp 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | ------- Summary: start ------- 05:56:25 INFO - PROCESS | 2127 | Number of tests: 14 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#0] ai-astar Cycles:10 Average:122.40 Median:113.50 stddev:19.52 (17.2%) stddev-sans-first:20.47 05:56:25 INFO - PROCESS | 2127 | Values: 114.0 122.0 169.0 146.0 112.0 111.0 112.0 112.0 113.0 113.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:134.00 stddev:17.80 (13.3%) stddev-sans-first:16.20 05:56:25 INFO - PROCESS | 2127 | Values: 151.0 129.0 139.0 147.0 109.0 108.0 109.0 110.0 139.0 109.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:0.95 (0.5%) stddev-sans-first:1.00 05:56:25 INFO - PROCESS | 2127 | Values: 184.0 185.0 184.0 184.0 184.0 183.0 183.0 185.0 185.0 186.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#3] audio-fft Cycles:10 Average:67.10 Median:63.00 stddev:12.49 (19.8%) stddev-sans-first:12.19 05:56:25 INFO - PROCESS | 2127 | Values: 81.0 58.0 58.0 90.0 62.0 58.0 59.0 58.0 83.0 64.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.50 stddev:10.78 (13.6%) stddev-sans-first:10.45 05:56:25 INFO - PROCESS | 2127 | Values: 90.0 70.0 90.0 69.0 68.0 70.0 91.0 69.0 69.0 89.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.00 stddev:1.89 (2.1%) stddev-sans-first:1.73 05:56:25 INFO - PROCESS | 2127 | Values: 90.0 88.0 88.0 85.0 88.0 85.0 89.0 86.0 89.0 85.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#6] imaging-darkroom Cycles:10 Average:103.90 Median:94.00 stddev:19.52 (20.8%) stddev-sans-first:20.22 05:56:25 INFO - PROCESS | 2127 | Values: 92.0 94.0 94.0 93.0 95.0 94.0 95.0 103.0 149.0 130.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#7] imaging-desaturate Cycles:10 Average:89.00 Median:85.00 stddev:11.55 (13.6%) stddev-sans-first:12.04 05:56:25 INFO - PROCESS | 2127 | Values: 83.0 96.0 120.0 84.0 83.0 85.0 86.0 83.0 85.0 85.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.49 (2.8%) stddev-sans-first:1.12 05:56:25 INFO - PROCESS | 2127 | Values: 57.0 55.0 54.0 52.0 53.0 55.0 54.0 52.0 54.0 54.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:3.95 (5.6%) stddev-sans-first:3.67 05:56:25 INFO - PROCESS | 2127 | Values: 66.0 70.0 80.0 76.0 72.0 69.0 69.0 70.0 71.0 71.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:86.50 stddev:7.68 (8.9%) stddev-sans-first:8.03 05:56:25 INFO - PROCESS | 2127 | Values: 87.0 87.0 86.0 86.0 90.0 94.0 103.0 105.0 83.0 85.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:147.50 stddev:16.32 (11.1%) stddev-sans-first:16.35 05:56:25 INFO - PROCESS | 2127 | Values: 165.0 169.0 155.0 139.0 134.0 139.0 139.0 137.0 180.0 140.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:171.00 stddev:25.05 (14.7%) stddev-sans-first:25.94 05:56:25 INFO - PROCESS | 2127 | Values: 169.0 171.0 170.0 170.0 168.0 171.0 203.0 167.0 226.0 229.0 05:56:25 INFO - PROCESS | 2127 | 05:56:25 INFO - PROCESS | 2127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 05:56:25 INFO - PROCESS | 2127 | Values: 67.0 68.0 66.0 68.0 67.0 66.0 67.0 68.0 67.0 68.0 05:56:25 INFO - PROCESS | 2127 | -------- Summary: end -------- 05:56:25 INFO - PROCESS | 2127 | 05:56:26 INFO - TEST-INFO | 2127: exit 0 05:56:26 INFO - TEST-OK | kraken | took 60196ms 05:56:26 INFO - SUITE-END | took 1177s 05:56:26 INFO - Completed test suite (00:19:37) 05:56:26 INFO - javascript benchmark 05:56:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.401427743007, 3334.666533346666, 3366.276250606121, 3400.1159698478386, 3430.142464383904, 5595.4124816894255, 5647.491725744682, 5692.459216374448, 5781.595288329813, 5801.36185019648, 5246.606504512168, 5692.117721753135, 5724.570657200717, 5726.255586773724, 5729.197912292282, 4730.172219861519, 5176.171812509999, 5192.376914770233, 5220.973895130519, 5235.528802407783, 5285.603579731516, 5293.52358287754, 5293.867653308679, 5297.364316282052, 5302.416734159239, 5203.661761985478, 5241.580673546107, 5249.606279529032, 5282.445343238962, 5284.048871203182, 5279.524842764151, 5292.867678308035, 5325.920111198335, 5331.147016477384, 5376.220448035013, 5095.541401273866, 5107.846764597068, 5149.562287205592, 5242.9213561796605, 5245.423003469616, 5598.048331783607, 5723.027085395493, 5730.312362516483, 5731.742071606746, 5739.655620662732, 6264.373562643699, 6281.277653069909, 6291.559590828644, 6294.968525157391, 6299.748010079591, 5733.254676892019, 6116.454587092042, 6225.906611400833, 6312.589681670676, 6321.146645202884, 5793.246877905887, 5829.4170582942215, 5834.854128646818, 5863.970680146572, 5884.323302820188, 6274.247090349096, 6296.275928268308, 6299.401556852092, 6307.905381419282, 6314.968425157845, 5981.700914954235, 6095.05526643371, 6165.971026288776, 6216.595921265103, 6259.71831267594, 5074.594032477393, 6195.0, 6198.473129784019, 6309.148264984168, 6325.114483972247, 6216.378362163748, 6234.781782637586, 6251.718672659741, 6257.0, 6264.029075493306, 6086.2696476422225, 6261.0, 6272.843178920472, 6275.497960163176, 6283.151774510474, 4822.132016237041, 4919.3358896549225, 4938.08645400602, 4965.478624744422, 4985.4266759323145, 4442.089371678798, 4446.911061778746, 4461.0, 4493.6854420190275, 4507.571780680895, 5799.39106393831, 5825.766969321265, 5849.151872978395, 5852.268466441695, 5873.647581145145, 6106.035994416554, 6107.219158344477, 6191.783287585003, 6258.123862659231, 6280.623162610258, 5849.298084229919, 5851.795187168429, 5857.326407463196, 5871.706414679249, 5922.0, 5428.348598168245, 5429.239906413105, 5436.347638283352, 5442.809501667422, 5445.482679145475, 6225.937740622536, 6228.750849966042, 6254.2807577129215, 6298.905516417349, 6304.621722696653, 6277.5605707600025, 6287.559870808999, 6309.053641953744, 6317.020861766434, 6318.115463834974, 6294.433500984934, 6303.49572034227, 6307.833050885601, 6315.147455093504, 6317.241930968313, 6079.939200608114, 6105.145279660762, 6138.97087834436, 6236.064590311489, 6238.906416403848, 6188.845278868064, 6313.43179113882, 6314.905276420765, 6323.620582765049, 6326.493880489457, 6156.784512542219, 6156.846078848064, 6167.259928808572, 6177.660228687465, 6203.720832562455, 5988.610740301867, 6027.909581356371, 6129.785457509144, 6181.752729890754, 6190.7523699051535, 5932.317783454958, 5988.4909782668965, 5990.610610310316, 6077.381070909389, 6102.786402475892, 6174.691265436621, 6179.0422484514975, 6181.165542651865, 6204.286507051746, 6219.720112595034, 5815.447532484407, 5823.79616713413, 5888.411158884077, 6046.334903160561, 6087.391260873877], "value": 5723.613688282426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.95820922330836, 499.5429182298197, 530.9575233981282, 540.9161579955108, 566.2101368590813, 29561.2609684758, 39028.02429939253, 40141.7992910035, 40194.39708404376, 41920.0, 40119.0, 40659.18681626366, 40745.0, 40835.79582102085, 40966.7951660242, 8786.736397908073, 9814.214862810957, 9973.601055957753, 9974.850377244347, 9994.15049720771, 8786.0, 11971.221870578429, 12145.635630931087, 12176.330301833395, 12424.254544727346, 12070.094742894275, 12108.15242932995, 12157.331346775924, 12170.93914530426, 12173.634790956241, 8668.826623467558, 8854.734357969272, 12137.635870923843, 12172.026237900947, 12204.389780510939, 11660.125490588154, 11866.228695134789, 11875.0, 12196.329201893892, 12216.205946613441, 39845.425504791674, 40144.59855401438, 40200.39699404511, 40233.195336093406, 40252.79873600643, 3257.3516271866183, 3280.8995499253215, 3399.1672040350027, 3401.557797486336, 3618.9276214475562, 29712.257193570334, 30088.548671769942, 30856.691433085605, 30873.536896946564, 30921.0, 3146.2606287522412, 3313.9834300828343, 3333.4333163362044, 3336.0, 3341.732661387083, 476115.61942190415, 476857.0, 478190.0, 480038.0, 483565.0, 56546.47628189735, 57019.42980570224, 57033.714831426405, 57072.14391784126, 57213.71393143091, 56338.0, 56358.7182064087, 56505.43494565002, 56529.86940261254, 56645.43354566484, 15696.136712480695, 15927.0, 15962.68074638524, 15971.600709982344, 15974.76037859433, 11035.282706624044, 11237.494312755945, 11251.0, 12444.688882778002, 12517.749645007048, 15297.923510382378, 15421.922890385476, 15594.610134746496, 15623.3750649975, 16031.759523607156, 5703.74333155009, 6859.622720750406, 6866.622335771481, 6891.483138764613, 6933.826654333581, 873.1748497669768, 958.712386284112, 1022.9795404091876, 1123.3316176874746, 1138.3113216504062, 28610.855565777136, 29587.852060739988, 29617.33443990051, 30421.0, 30532.847335763625, 930.9581068851918, 967.3760424526282, 1023.902729240721, 1051.7055224537141, 1062.2245760594808, 13016.349182540835, 15458.5362439127, 15462.226888655747, 15724.842751572567, 15808.92095539515, 586359.0, 591284.0, 592669.0, 592850.0, 593219.0, 45215.321770173476, 55097.17354239689, 55389.44610553923, 55393.44606553883, 55437.72281138568, 1183.6094088950626, 1263.6651287408845, 1353.722486890205, 1372.9725405492034, 1395.7138786548733, 29288.853555732087, 31031.0, 31074.53388199224, 31152.0, 31908.6809131915, 39097.0, 47808.52191478041, 48107.79730506765, 48189.75905120452, 48232.041713116945, 513594.0, 519392.0, 519698.0, 521114.3944280254, 521217.0, 21763.455913601654, 22139.557208856055, 22192.445188869762, 23050.53898922046, 38995.6100438992, 45960.267549165554, 46162.538374615826, 46894.0, 47006.52993470158, 47680.7615961918, 38422.03944901288, 38694.80652596719, 38705.0, 39852.0, 39953.0, 30415.847920760254, 31888.0, 37465.31406086678, 38015.809920951324, 38768.80615596904, 36986.0, 37771.0, 38263.42604860874, 38401.65594204189, 38418.42372364473, 28097.43805123927, 30404.695953040187, 33272.83363583167, 33284.500732488545, 33960.66039339575, 22257.220997265667, 24554.263372098867, 24761.876190618932, 25450.109246176296, 25707.742922570535], "value": 19711.29502326377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7124158190285, 370.7867975913849, 371.0815731065613, 381.11581131774284, 399.7448013238432, 15221.771673424893, 15281.923590382046, 17068.0, 21303.147874085018, 21352.735541847265, 20536.8973155134, 20557.4860628484, 21250.574988500222, 21297.893510532464, 21457.46356341092, 5828.47543721065, 5832.329282132546, 6038.486728628071, 6107.114468402079, 6120.60216085953, 5743.425657434265, 5914.852128696774, 5926.614770039955, 5926.762929482816, 5933.821985340447, 4121.402396652498, 4347.304431290994, 6244.656543890084, 6515.283318834924, 6570.967145164267, 6023.367546407608, 6596.868062638769, 6606.4384527315, 6621.999999999976, 6628.668566571652, 5761.654300741969, 5763.164341170549, 5764.135379693038, 5768.74040668171, 5774.82675519735, 25183.496330073296, 25799.871000645064, 26249.212523624323, 26572.86713566439, 26910.73089269102, 2232.8548644338066, 2493.6259561065804, 2536.1206563611036, 2946.4696354656153, 3095.876164953399, 9747.707568772948, 10299.53652085658, 10341.172706183488, 10356.223283253787, 15414.383424663, 1824.1295740373234, 1824.7536582561318, 1861.8789778664343, 1878.3801345555935, 2016.616842799878, 117913.41043294815, 119773.0, 121552.39223803913, 122187.389063055, 122768.0, 11040.779184416268, 11138.387388693538, 11231.069125806065, 11307.830382544269, 11551.711207219718, 14261.64514371133, 14268.001239913106, 14271.500497482539, 14286.9999100062, 14302.356393962089, 6798.626075565891, 8044.0, 8299.875501867476, 8316.41785075039, 8458.957705211435, 8193.67225310981, 8196.0, 8232.794180145544, 8385.748427547183, 8386.245237928493, 3853.8265778040054, 4423.137488189836, 4431.290993441098, 4431.601155895921, 4501.68488205829, 1727.680379129865, 1772.7961284452454, 1825.4249911277905, 1827.0590645817415, 1899.164367678217, 746.391690772019, 849.6856163219649, 868.2186032570737, 903.1375036839802, 947.9857802132974, 19756.506087347643, 20969.895150524455, 21001.0, 21423.250186243407, 21569.352919412442, 833.98332033359, 905.8686490458979, 929.4423345992485, 1010.5806090472519, 1019.3476175247847, 9128.315376346667, 10325.48372581368, 11228.0, 11292.887071129348, 11317.377544235145, 548330.0, 548684.0, 554206.0, 559358.0, 567165.0, 119118.21322680167, 119509.0, 120611.0, 121620.0, 122901.0, 897.2014906733012, 908.822779557993, 933.6498812945146, 937.3625934364561, 938.2353381993789, 14856.405743770129, 15148.394064237747, 17636.559086022953, 18673.0, 18678.34625788091, 37555.0, 50242.0, 51129.977400452524, 51249.487505124474, 51747.461123452515, 72109.27890721026, 72520.0, 72733.90899136623, 72741.0, 75295.62352188423, 5310.389305229948, 7783.610819459118, 8021.598920053857, 8039.959800200962, 8279.461834980708, 10570.0, 12731.61805145847, 13130.277834719182, 13146.21122732639, 13242.66893327636, 11275.887241127812, 11288.717782055513, 11531.250468719507, 11571.30572165639, 11600.0, 11059.336439813636, 11100.389478578756, 11199.096153654062, 11235.55057797679, 11594.94202528982, 11417.257878237888, 11643.301401915573, 11777.528898844294, 11832.230904991147, 11908.821367679318, 6943.583384996917, 7771.300582947561, 7870.960645196967, 8085.83828323442, 8386.622601983048, 10845.674629761119, 11316.114390830286, 11556.0, 11576.768464630492, 11594.0], "value": 9452.761843945596, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.740870347689, 1542.9305681244343, 1741.6864964306428, 1852.3516769130797, 1933.0914470199011, 8385.748427547176, 8861.86707199391, 8875.37872348935, 8883.46699198047, 8884.555772211395, 7801.453898227112, 7957.641906114224, 7979.122296547375, 8475.067742548315, 8616.052234254226, 2354.3054798834387, 2376.0970831084164, 2377.5126099149634, 2382.5711371953043, 2382.7498112698177, 2354.105439932823, 2367.112332875172, 2372.110458578033, 2388.152205966883, 2395.2335252719135, 2049.6925461180795, 2330.475642980324, 2365.042157926043, 2379.4408314046186, 2400.7479214682467, 2344.2381226101415, 2359.245041586693, 2365.1249037856105, 2368.27767530903, 2372.810175185981, 2325.9415417355763, 2375.5842727522613, 2378.2151889876473, 2387.6418537219383, 2387.7373488916205, 8757.912420875773, 8810.911890881138, 8840.38117331787, 8843.690470833555, 8850.60172292242, 5250.343707036621, 5410.0, 5411.404745477994, 5421.376541697677, 5434.809781657663, 3327.8336083195745, 3452.2750222453315, 3643.43526753351, 3686.078480379905, 3714.665680088778, 1068.7167900506372, 1073.2272763610267, 1081.621432498627, 1093.9398333091676, 1094.7591529863416, 11755.94122029393, 11779.941100294529, 11794.233374830608, 11895.82156267648, 11915.463804128834, 4092.8335424403904, 4575.81696732127, 4798.760061996886, 4803.735794531264, 4805.783739731721, 9976.950115249523, 9987.700368988943, 10003.049710277512, 10003.549840257207, 10006.0, 5364.14173732201, 5364.678119312854, 5366.973165134149, 5369.382521010056, 5370.543503802221, 4433.0, 4445.688801783844, 4871.80512779492, 4921.532454416824, 4934.051049835295, 3882.6311500407414, 3884.786336751449, 3967.206558688274, 4009.7594144351433, 4011.532907262013, 1285.4151361130664, 1289.8774616411426, 1290.374168528263, 1302.6873550348039, 1307.235267368581, 787.4055088408215, 857.8730527228342, 896.4710820615868, 903.1014140929685, 933.4725879877848, 5422.7017514036315, 5438.102713052302, 5685.232493613309, 5939.584229103922, 5999.296880028983, 894.3069121430943, 929.8651695504115, 931.7903471718945, 933.9066093390607, 980.9656662016795, 3913.745606535566, 3928.3125453045604, 3992.301347264217, 4011.4584531088512, 4097.91804163921, 10309.587616495257, 10729.302595331435, 10744.677659670222, 10756.677299681021, 10768.730781730363, 10682.51928663212, 10693.625723099809, 10694.89305106939, 10701.0, 10713.410762407986, 7776.183500732342, 8049.597520123971, 8105.594720263845, 8107.594620268963, 8182.7545173644885, 5398.865028374322, 5925.970370148121, 6006.759729610767, 6064.545159112996, 6140.293866205265, 9621.422714637145, 9759.707208783748, 9974.40153590787, 10117.848232276669, 10139.493025348851, 9761.755956101155, 10174.643887463903, 10276.743081423025, 10338.0, 10360.171186305228, 7414.740484083247, 7572.167061623327, 7616.2383761625615, 7677.424193185422, 7679.923200767921, 8119.147489513753, 8200.38497112707, 8218.835623287381, 8220.63007164691, 8223.506589604644, 7187.712491500491, 7221.4222862171955, 7372.778816635509, 7477.663505142173, 7499.587522686086, 7147.142342918883, 7150.821229469305, 7199.964000180175, 7220.783376498714, 7360.043194384696, 6820.590764554143, 6979.8255043622285, 6980.720771169096, 6982.79051628452, 6986.825329366807, 4938.970493301086, 5043.193089105872, 5068.454121492832, 5093.592512598909, 5105.897882042413, 4946.530079642428, 4955.4301255356095, 5119.257707632298, 5150.8969820604125, 5222.29499017643], "value": 4594.991084513214, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.19375420581713, 299.2593331504525, 307.6354519893926, 312.113597383431, 315.13652591898204, 5096.439391666923, 5280.603954703393, 5328.760205790739, 5401.3248343957, 5428.991273228911, 4469.664775141861, 4697.2954056891485, 5114.079465696173, 5117.539421452068, 5202.086831374433, 3866.8646597369097, 4044.2518134145275, 4064.9187016259657, 4084.121913788535, 4089.9386509202386, 3404.438267685829, 3955.9604403956023, 4061.0659548303906, 4072.572379900112, 4119.485064366954, 3280.671932806712, 4039.2527382434196, 4041.211963667086, 4047.9797601011956, 4070.267351876661, 4027.677785777131, 4053.6757059435176, 4055.837766489337, 4059.7970101494957, 4095.037666148453, 3333.4999750037446, 3510.701590364822, 3541.8937431876825, 3550.8757193498363, 3555.235624340779, 4520.208963431419, 5032.169692000815, 5071.695698258116, 5135.332406787131, 5219.530242278175, 4618.699784513996, 4621.768911554443, 4625.930611040837, 4638.536146385334, 4669.509701481364, 4547.363369128325, 5060.2409638554145, 5060.74696265189, 5563.415841336642, 5580.665160090408, 3480.2169511859884, 3714.7028237740915, 3831.1954489556947, 3868.9806550967064, 3895.435161901537, 5116.744162791882, 5813.331466881278, 5834.112114503348, 5866.472017518444, 5877.473515890474, 3455.652295604716, 3816.236752649426, 3944.2308749793515, 3989.7805620691142, 3997.700172487075, 3880.8059597020037, 4041.777702226347, 4052.4124002019544, 4054.736442131252, 4063.898402539901, 3815.939392727951, 4638.281066434708, 4660.790264438108, 4664.323673067454, 4671.8364857229835, 5026.52248036436, 5316.3354580677415, 5494.972525137348, 5595.944040559623, 5610.102383618683, 1071.7856428714288, 1331.9467221311234, 1335.8730920562532, 1337.959861204146, 1348.716769478401, 767.447437844762, 847.2586486824028, 847.809242920338, 858.6476299827797, 861.5821326656567, 3908.5376212986207, 4388.824447022147, 4400.931562165841, 4446.911061778811, 4480.574345437179, 4277.337012763027, 4659.720416775004, 4813.687110337817, 4816.373871396766, 4907.607391408679, 3948.9210215795524, 4932.383452068491, 5362.463753624685, 5382.542483888835, 5416.674999500043, 3024.7126522980284, 3056.982391621519, 3064.4024415238814, 3072.38552289543, 3072.6620071792086, 4860.392450943632, 5144.6077573928305, 5297.443768404262, 5711.371749107595, 5901.049475262369, 5962.522998160137, 5969.522438204933, 5997.880042399128, 6001.399860014051, 6036.879262414727, 6018.759249630053, 6019.969900150471, 6067.54493412987, 6092.0, 6143.477804386588, 5481.232627432083, 5765.472149880201, 5811.912821307599, 5857.7698683275285, 5900.970495147497, 5300.814471493479, 5762.250907382014, 5772.797952071657, 5774.42255774436, 5854.331515518057, 5838.94161058384, 5891.0103813746855, 5954.970225148846, 5989.2812862456785, 6065.514758819196, 3868.709846761448, 3885.5337359515906, 3888.1446081861945, 3889.96110038896, 3894.6884249259424, 5306.575473961997, 5815.121514850007, 5862.530997520274, 5887.499562537232, 5905.409459054232, 4911.312416261655, 5177.456367081402, 5395.489263006364, 5669.291338582677, 5674.602777805679, 4767.070421267819, 5572.331320241597, 5661.207430959751, 5685.459881311269, 5716.657000579979, 4803.438882363176, 4902.117618828645, 5444.428335024765, 5538.033997930676, 5640.520555752642, 5575.0, 5722.0, 5725.2843394575675, 5736.827895163152, 5791.971040144772, 4665.323528088476, 4975.139294905516, 5264.605154613496, 5662.773489060556, 5745.994450970979], "value": 4069.1755706266094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.3678363040524, 720.7261240728524, 735.569691730338, 767.7696690992701, 815.6900377856414, 13406.1956282623, 13435.0, 13438.260895650736, 13480.123791953529, 13480.191188528695, 14029.719405611882, 14199.0, 14201.28993550321, 14220.146791192536, 14241.35913883875, 677.915260592426, 694.9895751563705, 822.7284995951321, 832.8167803083327, 850.7787975126449, 800.0918956983836, 810.6068556749972, 811.3225456743626, 811.5577010529275, 812.4069429316603, 756.5763172623349, 855.0679759062621, 857.2070834478114, 858.9914100858974, 861.1087524412235, 712.8217945513621, 852.9019162796296, 853.2917678326974, 853.7097386888488, 857.7641148684099, 542.446704361549, 646.8706258748222, 648.7145655911384, 665.6139439125295, 668.1781408867121, 14363.784543231859, 14442.927785361111, 14453.421863125463, 14467.348969296407, 14522.419103235858, 13293.86706132936, 13708.3831227595, 13748.862511374859, 13885.097468664606, 14293.78559321611, 10902.5093870776, 12272.0, 12734.172278801849, 12762.298073605947, 12779.744405111938, 4166.375043743433, 4459.0, 4508.481524624644, 4551.249043907751, 4602.539746025404, 111317.0, 112703.0, 112803.43598282037, 113159.0, 113578.86421135765, 10905.34567925927, 11010.834837477445, 11124.944375278072, 11194.720131996603, 11531.538738450368, 21775.891120544296, 21938.890305548688, 22652.773472265068, 22666.433339166324, 22751.772482275297, 8045.597720113971, 8105.797355066171, 8263.338932885355, 8263.710770123016, 8484.53335066565, 4327.935080973788, 4440.555944405533, 4513.638908887347, 4526.117407105583, 4652.255639097728, 3588.5873124591008, 3679.6504332088407, 3706.425504046877, 3713.7586056906757, 3719.9956011876643, 562.9662220266797, 671.1476424940298, 678.9490788190906, 679.140886778226, 681.56039354616, 578.8321386797866, 626.8495561065403, 642.2517766801717, 666.5567397680488, 681.2234053179379, 9378.623695469625, 9468.810623787485, 9490.0, 9495.123493361009, 9736.561854716554, 520.9843704688866, 578.4302462074853, 606.7209083821404, 673.6463356737752, 679.1442782094498, 4554.0, 4646.381374744893, 4649.325847752057, 4680.3915490985955, 4684.789184486638, 89797.75505612412, 107670.0, 118669.69312148067, 143907.0, 149801.7529737033, 57023.0, 113511.0, 127614.0, 127771.0, 133531.33234333765, 70325.64837175884, 94563.0, 110536.89463105588, 112447.0, 115509.42245288887, 7739.0, 9026.368154229142, 9181.265498759949, 9236.815263694823, 9239.39943903644, 60010.699946501736, 60967.39032609794, 61969.0, 62113.68943155255, 62712.0, 87037.0, 88522.11477885139, 89570.0, 90579.5471022667, 92185.07814921765, 11766.411679416165, 12144.878551214728, 12188.695282618006, 12227.938860305641, 12421.19262247951, 14192.645183870485, 14806.037607555474, 14891.106533608017, 15842.68314633724, 15879.444219452263, 13783.310834458438, 14073.929630351782, 14336.211508366723, 14382.640433988816, 14621.903357248462, 13200.782592287249, 14019.439222430989, 14049.367778450198, 14055.22696251716, 14065.296735163405, 13439.126456780277, 13665.521706740217, 13732.478496336269, 13903.51337703216, 13948.372323245276, 11164.832527511931, 11755.588554400554, 11783.175177737476, 11823.290602563873, 11869.169158158846, 9011.684591039282, 11423.771524569629, 11441.027512661183, 11594.304341739522, 11815.527378904748], "value": 7699.351663958837, "unit": "score"}], "name": "dromaeo_css", "value": 7317.6641622643065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 122.0, 169.0, 146.0, 112.0, 111.0, 112.0, 112.0, 113.0, 113.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 139.0, 147.0, 109.0, 108.0, 109.0, 110.0, 139.0, 109.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 184.0, 184.0, 183.0, 183.0, 185.0, 185.0, 186.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 90.0, 62.0, 58.0, 59.0, 58.0, 83.0, 64.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 90.0, 69.0, 68.0, 70.0, 91.0, 69.0, 69.0, 89.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 88.0, 85.0, 88.0, 85.0, 89.0, 86.0, 89.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 94.0, 93.0, 95.0, 94.0, 95.0, 103.0, 149.0, 130.0], "value": 103.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 96.0, 120.0, 84.0, 83.0, 85.0, 86.0, 83.0, 85.0, 85.0], "value": 89.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 52.0, 53.0, 55.0, 54.0, 52.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 80.0, 76.0, 72.0, 69.0, 69.0, 70.0, 71.0, 71.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 90.0, 94.0, 103.0, 105.0, 83.0, 85.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 155.0, 139.0, 134.0, 139.0, 139.0, 137.0, 180.0, 140.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 170.0, 170.0, 168.0, 171.0, 203.0, 167.0, 226.0, 229.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 68.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1473.8000000000002, "alertThreshold": 2.0}]} 05:56:26 INFO - Return code: 0 05:56:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:56:26 INFO - # TBPL SUCCESS # 05:56:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:26 INFO - 2016-09-21 05:56:26.925 screenresolution[2131:25651] starting screenresolution argv=screenresolution get 05:56:26 INFO - 2016-09-21 05:56:26.929 screenresolution[2131:25651] Display 0: 1600x1200x32@60 05:56:26 INFO - 2016-09-21 05:56:26.935 screenresolution[2132:25654] starting screenresolution argv=screenresolution list 05:56:26 INFO - Available Modes on Display 0 05:56:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:27 INFO - Intel Iris: 05:56:27 INFO - Chipset Model: Intel Iris 05:56:27 INFO - Type: GPU 05:56:27 INFO - Bus: Built-In 05:56:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:27 INFO - Vendor: Intel (0x8086) 05:56:27 INFO - Device ID: 0x0a2e 05:56:27 INFO - Revision ID: 0x0009 05:56:27 INFO - Displays: 05:56:27 INFO - Display: 05:56:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:27 INFO - Display Serial Number: 1600x1200 60 05:56:27 INFO - Main Display: Yes 05:56:27 INFO - Mirror: Off 05:56:27 INFO - Online: Yes 05:56:27 INFO - Rotation: Supported 05:56:27 INFO - Return code: 0 05:56:27 INFO - Running post-action listener: _resource_record_post_action 05:56:27 INFO - [mozharness: 2016-09-21 12:56:27.185043Z] Finished run-tests step (success) 05:56:27 INFO - Running post-run listener: _resource_record_post_run 05:56:27 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 29699072; Write bytes: 702512640; Read time: 178; Write time: 2007 05:56:27 INFO - TinderboxPrint: CPU usage
53.4% 05:56:27 INFO - TinderboxPrint: I/O read bytes / time
29,699,072 / 178 05:56:27 INFO - TinderboxPrint: I/O write bytes / time
702,512,640 / 2,007 05:56:27 INFO - TinderboxPrint: CPU idle
2,261.2 (46.6%) 05:56:27 INFO - TinderboxPrint: CPU system
965.9 (19.9%) 05:56:27 INFO - TinderboxPrint: CPU user
1,622.7 (33.5%) 05:56:27 INFO - TinderboxPrint: Swap in / out
429,719,552 / 0 05:56:27 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397433344; Write bytes: 389457920; Read time: 29754; Write time: 860 05:56:27 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 29555712; Write bytes: 294262272; Read time: 175; Write time: 1097 05:56:27 INFO - Running post-run listener: _upload_blobber_files 05:56:27 INFO - Blob upload gear active. 05:56:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:27 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:56:27 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:27 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:28 INFO - (blobuploader) - INFO - Done attempting. 05:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:29 INFO - (blobuploader) - INFO - Done attempting. 05:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:32 INFO - (blobuploader) - INFO - Done attempting. 05:56:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:32 INFO - Return code: 0 05:56:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c90ccf473a313f7d1afe9bd74bea9ec13f610ea29b8ce3bc15a5256014174ca220a5eb737cfbab708e4b0e8034592f343940af4a44c488059d2feb252e5aa9ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa4cf29f29fca515e9a4a4f77b0bcc7ab0015fd58c0456b7d9b37a8d1b55932d99861f56b206582036dc06a0228dbaab33a767de1fd3b7888c53dd46abb18039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/582518c0ae938a7c6289c47932d0d5ed9535c8c8f285e36b54bc34aeea9253c97691b029dd6a697d6063bb99705b6f6758796de79496fa54474bd81819c5d233"} 05:56:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:32 INFO - Contents: 05:56:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c90ccf473a313f7d1afe9bd74bea9ec13f610ea29b8ce3bc15a5256014174ca220a5eb737cfbab708e4b0e8034592f343940af4a44c488059d2feb252e5aa9ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa4cf29f29fca515e9a4a4f77b0bcc7ab0015fd58c0456b7d9b37a8d1b55932d99861f56b206582036dc06a0228dbaab33a767de1fd3b7888c53dd46abb18039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/582518c0ae938a7c6289c47932d0d5ed9535c8c8f285e36b54bc34aeea9253c97691b029dd6a697d6063bb99705b6f6758796de79496fa54474bd81819c5d233"} 05:56:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:32 INFO - Copying logs to upload dir... 05:56:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.567974 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 05:56:32.354230) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 05:56:32.357336) ========= 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.dr441w4wzE/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.4MptEcL7lX/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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/Autoland/sha512/c90ccf473a313f7d1afe9bd74bea9ec13f610ea29b8ce3bc15a5256014174ca220a5eb737cfbab708e4b0e8034592f343940af4a44c488059d2feb252e5aa9ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa4cf29f29fca515e9a4a4f77b0bcc7ab0015fd58c0456b7d9b37a8d1b55932d99861f56b206582036dc06a0228dbaab33a767de1fd3b7888c53dd46abb18039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/582518c0ae938a7c6289c47932d0d5ed9535c8c8f285e36b54bc34aeea9253c97691b029dd6a697d6063bb99705b6f6758796de79496fa54474bd81819c5d233"} build_url:https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011043 build_url: 'https://queue.taskcluster.net/v1/task/AHEbzOwJTPmALHofAyCcUg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c90ccf473a313f7d1afe9bd74bea9ec13f610ea29b8ce3bc15a5256014174ca220a5eb737cfbab708e4b0e8034592f343940af4a44c488059d2feb252e5aa9ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa4cf29f29fca515e9a4a4f77b0bcc7ab0015fd58c0456b7d9b37a8d1b55932d99861f56b206582036dc06a0228dbaab33a767de1fd3b7888c53dd46abb18039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/582518c0ae938a7c6289c47932d0d5ed9535c8c8f285e36b54bc34aeea9253c97691b029dd6a697d6063bb99705b6f6758796de79496fa54474bd81819c5d233"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 05:56:32.390511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:56:32.390800) ========= 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.dr441w4wzE/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.4MptEcL7lX/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.005094 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:56:32.438397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 05:56:32.438673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 05:56:32.438965) ========= ========= Total master_lag: 0.18 =========