builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0079 starttime: 1467032268.79 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.791223) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.791556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.791838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.847617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.850915) ========= 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.64QeC5eYUI/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.fcUauWfYYq/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-06-27 05:57:48-- 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% 25.7M=0s 2016-06-27 05:57:49 (25.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.555814 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.431474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.431798) ========= 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.64QeC5eYUI/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.fcUauWfYYq/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.029270 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.481594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:57:49.481977) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.64QeC5eYUI/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.fcUauWfYYq/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-06-27 05:57:49,557 truncating revision to first 12 chars 2016-06-27 05:57:49,557 Setting DEBUG logging. 2016-06-27 05:57:49,557 attempt 1/10 2016-06-27 05:57:49,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/229741b7de04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 05:57:50,695 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.397290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:57:50.903785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.904278) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.904901) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.905348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.925372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-06-27 05:57:50.925759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.64QeC5eYUI/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.fcUauWfYYq/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:57:51 INFO - MultiFileLogger online at 20160627 05:57:51 in /builds/slave/test 05:57:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:57:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:51 INFO - {'append_to_log': False, 05:57:51 INFO - 'base_work_dir': '/builds/slave/test', 05:57:51 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:57:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:51 INFO - 'branch': 'Mozilla-Beta', 05:57:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:51 INFO - 'config_files': ('talos/mac_config.py',), 05:57:51 INFO - 'default_actions': ('clobber', 05:57:51 INFO - 'read-buildbot-config', 05:57:51 INFO - 'download-and-extract', 05:57:51 INFO - 'populate-webroot', 05:57:51 INFO - 'create-virtualenv', 05:57:51 INFO - 'install', 05:57:51 INFO - 'run-tests'), 05:57:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:51 INFO - 'download_minidump_stackwalk': True, 05:57:51 INFO - 'download_symbols': 'ondemand', 05:57:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:51 INFO - 'installer_path': 'installer.exe', 05:57:51 INFO - 'log_level': 'info', 05:57:51 INFO - 'log_name': 'talos', 05:57:51 INFO - 'log_to_console': True, 05:57:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:57:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:57:51 INFO - 'opt_config_files': (), 05:57:51 INFO - 'pip_index': False, 05:57:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:51 INFO - 'cmd': ('bash', 05:57:51 INFO - '-c', 05:57:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:51 INFO - 'enabled': True, 05:57:51 INFO - 'halt_on_failure': False, 05:57:51 INFO - 'name': 'check_screen_resolution'},), 05:57:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:51 INFO - 'cmd': ('bash', 05:57:51 INFO - '-c', 05:57:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:51 INFO - 'enabled': True, 05:57:51 INFO - 'halt_on_failure': False, 05:57:51 INFO - 'name': 'check_screen_resolution'},), 05:57:51 INFO - 'run_cmd_checks_enabled': True, 05:57:51 INFO - 'sps_profile': False, 05:57:51 INFO - 'sps_profile_interval': 0, 05:57:51 INFO - 'suite': 'dromaeojs-e10s', 05:57:51 INFO - 'system_bits': '32', 05:57:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:51 INFO - 'title': 't-yosemite-r7-0079', 05:57:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:51 INFO - 'use_talos_json': True, 05:57:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:51 INFO - 'work_dir': 'build'} 05:57:51 INFO - ##### 05:57:51 INFO - ##### Running clobber step. 05:57:51 INFO - ##### 05:57:51 INFO - Running pre-action listener: _resource_record_pre_action 05:57:51 INFO - Running main action method: clobber 05:57:51 INFO - rmtree: /builds/slave/test/build 05:57:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:53 INFO - Running post-action listener: _resource_record_post_action 05:57:53 INFO - ##### 05:57:53 INFO - ##### Running read-buildbot-config step. 05:57:53 INFO - ##### 05:57:53 INFO - Running pre-action listener: _resource_record_pre_action 05:57:53 INFO - Running main action method: read_buildbot_config 05:57:53 INFO - Using buildbot properties: 05:57:53 INFO - { 05:57:53 INFO - "project": "", 05:57:53 INFO - "product": "firefox", 05:57:53 INFO - "script_repo_revision": "production", 05:57:53 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 05:57:53 INFO - "repository": "", 05:57:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 05:57:53 INFO - "buildid": "20160624143557", 05:57:53 INFO - "pgo_build": "False", 05:57:53 INFO - "basedir": "/builds/slave/test", 05:57:53 INFO - "buildnumber": 15, 05:57:53 INFO - "slavename": "t-yosemite-r7-0079", 05:57:53 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:57:53 INFO - "platform": "yosemite_r7", 05:57:53 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:57:53 INFO - "branch": "mozilla-beta", 05:57:53 INFO - "repo_path": "releases/mozilla-beta", 05:57:53 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 05:57:53 INFO - "stage_platform": "macosx64", 05:57:53 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 05:57:53 INFO - "slavebuilddir": "test" 05:57:53 INFO - } 05:57:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 05:57:53 INFO - Running post-action listener: _resource_record_post_action 05:57:53 INFO - ##### 05:57:53 INFO - ##### Running download-and-extract step. 05:57:53 INFO - ##### 05:57:53 INFO - Running pre-action listener: _resource_record_pre_action 05:57:53 INFO - Running main action method: download_and_extract 05:57:53 INFO - mkdir: /builds/slave/test/build/tests 05:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:53 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 05:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 05:58:04 INFO - Downloaded 1165 bytes. 05:58:04 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 05:58:04 INFO - Using the following test package requirements: 05:58:04 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:58:04 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:58:04 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 05:58:04 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:58:04 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 05:58:04 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:58:04 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:58:04 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 05:58:04 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:58:04 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:58:04 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 05:58:04 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:58:04 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 05:58:04 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:58:04 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 05:58:04 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:58:04 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 05:58:04 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 05:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:04 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:58:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 05:58:29 INFO - Downloaded 18344069 bytes. 05:58:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:58:32 INFO - Return code: 0 05:58:32 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:58:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:32 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 05:58:58 INFO - Downloaded 18344069 bytes. 05:58:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:59:02 INFO - Return code: 0 05:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:02 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 05:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 05:59:03 INFO - Downloaded 10840145 bytes. 05:59:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:59:04 INFO - Return code: 0 05:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:04 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 05:59:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:59:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:59:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 05:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 05:59:08 INFO - Downloaded 86227039 bytes. 05:59:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:59:08 INFO - mkdir: /builds/slave/test/properties 05:59:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:08 INFO - Contents: 05:59:08 INFO - build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:59:09 INFO - Running post-action listener: _resource_record_post_action 05:59:09 INFO - Running post-action listener: set_extra_try_arguments 05:59:09 INFO - ##### 05:59:09 INFO - ##### Running populate-webroot step. 05:59:09 INFO - ##### 05:59:09 INFO - Running pre-action listener: _resource_record_pre_action 05:59:09 INFO - Running main action method: populate_webroot 05:59:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:09 INFO - '--tppagecycles', 05:59:09 INFO - '7'], 05:59:09 INFO - 'tests': ['tsvgm']}}, 05:59:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:59:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:59:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:59:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['damp', 'tps']}, 05:59:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'tests': ['damp', 'tps']}, 05:59:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['dromaeo_dom']}, 05:59:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['a11yr', 05:59:09 INFO - 'ts_paint', 05:59:09 INFO - 'tpaint', 05:59:09 INFO - 'sessionrestore', 05:59:09 INFO - 'sessionrestore_no_auto_restore', 05:59:09 INFO - 'tabpaint']}, 05:59:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:59:09 INFO - 'ts_paint', 05:59:09 INFO - 'tpaint', 05:59:09 INFO - 'sessionrestore', 05:59:09 INFO - 'sessionrestore_no_auto_restore', 05:59:09 INFO - 'tabpaint']}, 05:59:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:59:09 INFO - 'ts_paint', 05:59:09 INFO - 'tpaint', 05:59:09 INFO - 'sessionrestore', 05:59:09 INFO - 'sessionrestore_no_auto_restore', 05:59:09 INFO - 'tabpaint']}, 05:59:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:59:09 INFO - 'ts_paint', 05:59:09 INFO - 'tpaint', 05:59:09 INFO - 'sessionrestore', 05:59:09 INFO - 'sessionrestore_no_auto_restore', 05:59:09 INFO - 'tabpaint']}, 05:59:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['a11yr', 05:59:09 INFO - 'ts_paint', 05:59:09 INFO - 'tpaint', 05:59:09 INFO - 'sessionrestore', 05:59:09 INFO - 'sessionrestore_no_auto_restore', 05:59:09 INFO - 'tabpaint']}, 05:59:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['a11yr', 05:59:09 INFO - 'ts_paint', 05:59:09 INFO - 'tpaint', 05:59:09 INFO - 'sessionrestore', 05:59:09 INFO - 'sessionrestore_no_auto_restore', 05:59:09 INFO - 'tabpaint']}, 05:59:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['tsvgx', 05:59:09 INFO - 'tsvgr_opacity', 05:59:09 INFO - 'tart', 05:59:09 INFO - 'tscrollx', 05:59:09 INFO - 'cart']}, 05:59:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:59:09 INFO - 'tsvgr_opacity', 05:59:09 INFO - 'tart', 05:59:09 INFO - 'tscrollx', 05:59:09 INFO - 'cart']}, 05:59:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'talos_options': ['--disable-e10s'], 05:59:09 INFO - 'tests': ['tp5o']}, 05:59:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'tests': ['tp5o']}, 05:59:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'talos_options': ['--disable-e10s', 05:59:09 INFO - '--xperf_path', 05:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:09 INFO - 'tests': ['tp5n']}, 05:59:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:09 INFO - 'talos_options': ['--xperf_path', 05:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:09 INFO - 'tests': ['tp5n']}}, 05:59:09 INFO - 'talos.zip': {'path': '', 05:59:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:09 INFO - Running post-action listener: _resource_record_post_action 05:59:09 INFO - ##### 05:59:09 INFO - ##### Running create-virtualenv step. 05:59:09 INFO - ##### 05:59:09 INFO - Running pre-action listener: _resource_record_pre_action 05:59:09 INFO - Running main action method: create_virtualenv 05:59:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:09 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:59:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:09 INFO - Using real prefix '/tools/python27' 05:59:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:13 INFO - Installing pip.................done. 05:59:13 INFO - Return code: 0 05:59:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59: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', 'pip>=1.5'] in /builds/slave/test/build 05:59: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 pip>=1.5 05:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:13 INFO - 'HOME': '/Users/cltbld', 05:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:13 INFO - 'LOGNAME': 'cltbld', 05:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:13 INFO - 'MOZ_NO_REMOTE': '1', 05:59:13 INFO - 'NO_EM_RESTART': '1', 05:59:13 INFO - 'PAGER': '/bin/cat', 05:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:13 INFO - 'PWD': '/builds/slave/test', 05:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:13 INFO - 'SHELL': '/bin/bash', 05:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:13 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:13 INFO - 'USER': 'cltbld', 05:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:13 INFO - 'XPC_FLAGS': '0x0', 05:59:13 INFO - 'XPC_SERVICE_NAME': '0', 05:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:13 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:59:13 INFO - Cleaning up... 05:59:13 INFO - Return code: 0 05:59:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:59: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 psutil>=0.7.1 05:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:13 INFO - 'HOME': '/Users/cltbld', 05:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:13 INFO - 'LOGNAME': 'cltbld', 05:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:13 INFO - 'MOZ_NO_REMOTE': '1', 05:59:13 INFO - 'NO_EM_RESTART': '1', 05:59:13 INFO - 'PAGER': '/bin/cat', 05:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:13 INFO - 'PWD': '/builds/slave/test', 05:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:13 INFO - 'SHELL': '/bin/bash', 05:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:13 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:13 INFO - 'USER': 'cltbld', 05:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:13 INFO - 'XPC_FLAGS': '0x0', 05:59:13 INFO - 'XPC_SERVICE_NAME': '0', 05:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:14 INFO - Downloading/unpacking psutil>=0.7.1 05:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:17 INFO - Installing collected packages: psutil 05:59:17 INFO - Running setup.py install for psutil 05:59:17 INFO - building 'psutil._psutil_osx' extension 05:59:17 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:59:17 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:59:17 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:59:17 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:59:17 INFO - building 'psutil._psutil_posix' extension 05:59:17 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:59:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:59:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:59:18 INFO - ^ 05:59:18 INFO - 1 warning generated. 05:59:18 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:59:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:18 INFO - Successfully installed psutil 05:59:18 INFO - Cleaning up... 05:59:18 INFO - Return code: 0 05:59:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:59:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:18 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59:18 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.0.0'] in /builds/slave/test/build 05:59:18 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.0.0 05:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:18 INFO - 'HOME': '/Users/cltbld', 05:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:18 INFO - 'LOGNAME': 'cltbld', 05:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:18 INFO - 'MOZ_NO_REMOTE': '1', 05:59:18 INFO - 'NO_EM_RESTART': '1', 05:59:18 INFO - 'PAGER': '/bin/cat', 05:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:18 INFO - 'PWD': '/builds/slave/test', 05:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:18 INFO - 'SHELL': '/bin/bash', 05:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:18 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:18 INFO - 'USER': 'cltbld', 05:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:18 INFO - 'XPC_FLAGS': '0x0', 05:59:18 INFO - 'XPC_SERVICE_NAME': '0', 05:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:59:18 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:59:18 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:59:18 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:59:18 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:59:18 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:59:18 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:59:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:59:21 INFO - Installing collected packages: mozsystemmonitor 05:59:21 INFO - Running setup.py install for mozsystemmonitor 05:59:21 INFO - Successfully installed mozsystemmonitor 05:59:21 INFO - Cleaning up... 05:59:21 INFO - Return code: 0 05:59:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:21 INFO - 'HOME': '/Users/cltbld', 05:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:21 INFO - 'LOGNAME': 'cltbld', 05:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:21 INFO - 'MOZ_NO_REMOTE': '1', 05:59:21 INFO - 'NO_EM_RESTART': '1', 05:59:21 INFO - 'PAGER': '/bin/cat', 05:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:21 INFO - 'PWD': '/builds/slave/test', 05:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:21 INFO - 'SHELL': '/bin/bash', 05:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:21 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:21 INFO - 'USER': 'cltbld', 05:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:21 INFO - 'XPC_FLAGS': '0x0', 05:59:21 INFO - 'XPC_SERVICE_NAME': '0', 05:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:25 INFO - Downloading docopt-0.6.1.tar.gz 05:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:25 INFO - Running setup.py install for blobuploader 05:59:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:25 INFO - Running setup.py install for requests 05:59:25 INFO - Running setup.py install for docopt 05:59:26 INFO - Successfully installed blobuploader requests docopt 05:59:26 INFO - Cleaning up... 05:59:26 INFO - Return code: 0 05:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:26 INFO - 'HOME': '/Users/cltbld', 05:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:26 INFO - 'LOGNAME': 'cltbld', 05:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:26 INFO - 'MOZ_NO_REMOTE': '1', 05:59:26 INFO - 'NO_EM_RESTART': '1', 05:59:26 INFO - 'PAGER': '/bin/cat', 05:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:26 INFO - 'PWD': '/builds/slave/test', 05:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:26 INFO - 'SHELL': '/bin/bash', 05:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:26 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:26 INFO - 'USER': 'cltbld', 05:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:26 INFO - 'XPC_FLAGS': '0x0', 05:59:26 INFO - 'XPC_SERVICE_NAME': '0', 05:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-tjqTlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-PLRZvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4WIEdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-YBcwRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-J8jhGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-OKw_RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-VvyK93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Tdlcm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-L5F3lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-VZ08uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-WpeK35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9KCpk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_ns7CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yOSZwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4IZtUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:28 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-JDAyAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:28 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-KJp5UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:28 INFO - Running setup.py install for manifestparser 05:59:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:28 INFO - Running setup.py install for mozcrash 05:59:28 INFO - Running setup.py install for mozdebug 05:59:28 INFO - Running setup.py install for mozdevice 05:59:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:28 INFO - Running setup.py install for mozfile 05:59:28 INFO - Running setup.py install for mozhttpd 05:59:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozinfo 05:59:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozInstall 05:59:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozleak 05:59:29 INFO - Running setup.py install for mozlog 05:59:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for moznetwork 05:59:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozprocess 05:59:29 INFO - Running setup.py install for mozprofile 05:59:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Running setup.py install for mozrunner 05:59:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Running setup.py install for mozscreenshot 05:59:30 INFO - Running setup.py install for moztest 05:59:30 INFO - Running setup.py install for mozversion 05:59:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:30 INFO - Cleaning up... 05:59:30 INFO - Return code: 0 05:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:30 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 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59:30 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:59:30 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:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:30 INFO - 'HOME': '/Users/cltbld', 05:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:30 INFO - 'LOGNAME': 'cltbld', 05:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:30 INFO - 'MOZ_NO_REMOTE': '1', 05:59:30 INFO - 'NO_EM_RESTART': '1', 05:59:30 INFO - 'PAGER': '/bin/cat', 05:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:30 INFO - 'PWD': '/builds/slave/test', 05:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:30 INFO - 'SHELL': '/bin/bash', 05:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:30 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:30 INFO - 'USER': 'cltbld', 05:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:30 INFO - 'XPC_FLAGS': '0x0', 05:59:30 INFO - 'XPC_SERVICE_NAME': '0', 05:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yaeAgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-6NIvmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-rafnVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BwXrQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Eo516U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BtielK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bpnMfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4IJ2mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-exzAVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-5zOcWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Z_TlaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yRyHQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-RcoxGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yKndb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BBVN0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-GSuTX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-laEFwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:32 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:59:32 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:59:32 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:59:32 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:59:32 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:59:32 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:59:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:32 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:59:32 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:59:32 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:59:32 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:59:32 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:59:32 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:59:35 INFO - Downloading blessings-1.6.tar.gz 05:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:35 INFO - Installing collected packages: blessings 05:59:35 INFO - Running setup.py install for blessings 05:59:35 INFO - Successfully installed blessings 05:59:35 INFO - Cleaning up... 05:59:35 INFO - Return code: 0 05:59:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:35 INFO - Reading from file tmpfile_stdout 05:59:35 INFO - Current package versions: 05:59:35 INFO - blessings == 1.6 05:59:35 INFO - blobuploader == 1.2.4 05:59:35 INFO - docopt == 0.6.1 05:59:35 INFO - manifestparser == 1.1 05:59:35 INFO - mozInstall == 1.12 05:59:35 INFO - mozcrash == 0.17 05:59:35 INFO - mozdebug == 0.1 05:59:35 INFO - mozdevice == 0.48 05:59:35 INFO - mozfile == 1.2 05:59:35 INFO - mozhttpd == 0.7 05:59:35 INFO - mozinfo == 0.9 05:59:35 INFO - mozleak == 0.1 05:59:35 INFO - mozlog == 3.1 05:59:36 INFO - moznetwork == 0.27 05:59:36 INFO - mozprocess == 0.22 05:59:36 INFO - mozprofile == 0.28 05:59:36 INFO - mozrunner == 6.11 05:59:36 INFO - mozscreenshot == 0.1 05:59:36 INFO - mozsystemmonitor == 0.0 05:59:36 INFO - moztest == 0.7 05:59:36 INFO - mozversion == 1.4 05:59:36 INFO - psutil == 3.1.1 05:59:36 INFO - requests == 1.2.3 05:59:36 INFO - wsgiref == 0.1.2 05:59:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 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 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59:36 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:59:36 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:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:36 INFO - 'HOME': '/Users/cltbld', 05:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:36 INFO - 'LOGNAME': 'cltbld', 05:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:36 INFO - 'MOZ_NO_REMOTE': '1', 05:59:36 INFO - 'NO_EM_RESTART': '1', 05:59:36 INFO - 'PAGER': '/bin/cat', 05:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:36 INFO - 'PWD': '/builds/slave/test', 05:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:36 INFO - 'SHELL': '/bin/bash', 05:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:36 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:36 INFO - 'USER': 'cltbld', 05:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:36 INFO - 'XPC_FLAGS': '0x0', 05:59:36 INFO - 'XPC_SERVICE_NAME': '0', 05:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 INFO - Cleaning up... 05:59:36 INFO - Return code: 0 05:59:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:36 INFO - 'HOME': '/Users/cltbld', 05:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:36 INFO - 'LOGNAME': 'cltbld', 05:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:36 INFO - 'MOZ_NO_REMOTE': '1', 05:59:36 INFO - 'NO_EM_RESTART': '1', 05:59:36 INFO - 'PAGER': '/bin/cat', 05:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:36 INFO - 'PWD': '/builds/slave/test', 05:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:36 INFO - 'SHELL': '/bin/bash', 05:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:36 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:36 INFO - 'USER': 'cltbld', 05:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:36 INFO - 'XPC_FLAGS': '0x0', 05:59:36 INFO - 'XPC_SERVICE_NAME': '0', 05:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:36 INFO - Downloading/unpacking jsonschema 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:39 INFO - Downloading/unpacking functools32 (from jsonschema) 05:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:39 INFO - warning: no files found matching '*.txt' 05:59:39 INFO - no previously-included directories found matching 'build' 05:59:39 INFO - no previously-included directories found matching 'dist' 05:59:39 INFO - no previously-included directories found matching '.git*' 05:59:39 INFO - Installing collected packages: jsonschema, functools32 05:59:39 INFO - Running setup.py install for functools32 05:59:39 INFO - warning: no files found matching '*.txt' 05:59:39 INFO - no previously-included directories found matching 'build' 05:59:39 INFO - no previously-included directories found matching 'dist' 05:59:39 INFO - no previously-included directories found matching '.git*' 05:59:39 INFO - Successfully installed jsonschema functools32 05:59:39 INFO - Cleaning up... 05:59:39 INFO - Return code: 0 05:59:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0704aa840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, '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.64QeC5eYUI/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.fcUauWfYYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 05:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:39 INFO - 'HOME': '/Users/cltbld', 05:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:39 INFO - 'LOGNAME': 'cltbld', 05:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:39 INFO - 'MOZ_NO_REMOTE': '1', 05:59:39 INFO - 'NO_EM_RESTART': '1', 05:59:39 INFO - 'PAGER': '/bin/cat', 05:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:39 INFO - 'PWD': '/builds/slave/test', 05:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:39 INFO - 'SHELL': '/bin/bash', 05:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 05:59:39 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:39 INFO - 'USER': 'cltbld', 05:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:39 INFO - 'XPC_FLAGS': '0x0', 05:59:39 INFO - 'XPC_SERVICE_NAME': '0', 05:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:40 INFO - Downloading/unpacking flake8 05:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:59:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:59:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:59:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:43 INFO - no previously-included directories found matching 'docs/_build' 05:59:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:59:44 INFO - Running setup.py install for pep8 05:59:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:44 INFO - no previously-included directories found matching 'docs/_build' 05:59:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:59:44 INFO - Cleaning up... 05:59:44 INFO - Return code: 0 05:59:44 INFO - Running post-action listener: _resource_record_post_action 05:59:44 INFO - Running post-action listener: _start_resource_monitoring 05:59:44 INFO - Starting resource monitoring. 05:59:44 INFO - ##### 05:59:44 INFO - ##### Running install step. 05:59:44 INFO - ##### 05:59:44 INFO - Running pre-action listener: _resource_record_pre_action 05:59:44 INFO - Running main action method: install 05:59:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:44 INFO - Reading from file tmpfile_stdout 05:59:44 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:44 INFO - Reading from file tmpfile_stdout 05:59:44 INFO - Output received: 05:59:44 INFO - Usage: mozinstall [options] installer 05:59:44 INFO - Options: 05:59:44 INFO - -h, --help show this help message and exit 05:59:44 INFO - -d DEST, --destination=DEST 05:59:44 INFO - Directory to install application into. [default: 05:59:44 INFO - "/builds/slave/test"] 05:59:44 INFO - --app=APP Application being installed. [default: firefox] 05:59:44 INFO - mkdir: /builds/slave/test/build/application 05:59:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:00:06 INFO - Reading from file tmpfile_stdout 06:00:06 INFO - Output received: 06:00:06 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:00:06 INFO - Running post-action listener: _resource_record_post_action 06:00:06 INFO - ##### 06:00:06 INFO - ##### Running run-tests step. 06:00:06 INFO - ##### 06:00:06 INFO - Running pre-action listener: _resource_record_pre_action 06:00:06 INFO - Running main action method: run_tests 06:00:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:00:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:00:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:00:06 INFO - 2016-06-27 06:00:06.437 screenresolution[1649:8711] starting screenresolution argv=screenresolution get 06:00:06 INFO - 2016-06-27 06:00:06.440 screenresolution[1649:8711] Display 0: 1600x1200x32@60 06:00:06 INFO - 2016-06-27 06:00:06.445 screenresolution[1650:8714] starting screenresolution argv=screenresolution list 06:00:06 INFO - Available Modes on Display 0 06:00:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:00:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:00:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:00:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:00:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:00:06 INFO - Intel Iris: 06:00:06 INFO - Chipset Model: Intel Iris 06:00:06 INFO - Type: GPU 06:00:06 INFO - Bus: Built-In 06:00:06 INFO - VRAM (Dynamic, Max): 1536 MB 06:00:06 INFO - Vendor: Intel (0x8086) 06:00:06 INFO - Device ID: 0x0a2e 06:00:06 INFO - Revision ID: 0x0009 06:00:06 INFO - Displays: 06:00:06 INFO - Display: 06:00:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:00:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:00:06 INFO - Display Serial Number: 1600x1200 60 06:00:06 INFO - Main Display: Yes 06:00:06 INFO - Mirror: Off 06:00:06 INFO - Online: Yes 06:00:06 INFO - Rotation: Supported 06:00:06 INFO - Return code: 0 06:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:00:06 INFO - Python 2.7.3 06:00:06 INFO - Return code: 0 06:00:06 INFO - grabbing minidump binary from tooltool 06:00:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:06 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa29e00>, '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 0x10a892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa24b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:00:06 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 06:00:06 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 06:00:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:06 INFO - Return code: 0 06:00:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:00:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:00:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:00:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:00:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:00:07 INFO - Return code: 0 06:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64QeC5eYUI/Render', 06:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:07 INFO - 'HOME': '/Users/cltbld', 06:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:07 INFO - 'LOGNAME': 'cltbld', 06:00:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:00:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:07 INFO - 'MOZ_NO_REMOTE': '1', 06:00:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:00:07 INFO - 'NO_EM_RESTART': '1', 06:00:07 INFO - 'PAGER': '/bin/cat', 06:00:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:07 INFO - 'PWD': '/builds/slave/test', 06:00:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:07 INFO - 'SHELL': '/bin/bash', 06:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fcUauWfYYq/Listeners', 06:00:07 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 06:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:07 INFO - 'USER': 'cltbld', 06:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:07 INFO - 'XPC_FLAGS': '0x0', 06:00:07 INFO - 'XPC_SERVICE_NAME': '0', 06:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:00:08 INFO - mozversion application_buildid: 20160624143557 06:00:08 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:00:08 INFO - mozversion application_display_name: Firefox 06:00:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:08 INFO - mozversion application_name: Firefox 06:00:08 INFO - mozversion application_remotingname: firefox 06:00:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:00:08 INFO - mozversion application_vendor: Mozilla 06:00:08 INFO - mozversion application_version: 48.0 06:00:08 INFO - mozversion platform_buildid: 20160624143557 06:00:08 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:00:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:00:08 INFO - mozversion platform_version: 48.0 06:00:08 INFO - using testdate: 1467032408 06:00:08 INFO - actual date: 1467032408 06:00:08 INFO - starting webserver on 'localhost:49271' 06:00:08 INFO - SUITE-START | Running 2 tests 06:00:08 INFO - TEST-START | dromaeo_css 06:00:08 INFO - operating with platform_type : mac_ 06:00:08 INFO - Initialising browser for dromaeo_css test... 06:00:08 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpNAGlYf/profile http://localhost:49271/getInfo.html) 06:00:10 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 06:00:10 INFO - PROCESS | 1668 | colorDepth:24 06:00:10 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 06:00:10 INFO - PROCESS | 1668 | __metrics 06:00:10 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:00:11 INFO - TEST-INFO | 1668: exit 0 06:00:11 INFO - Browser initialized. 06:00:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:00:11 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpNAGlYf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:23 INFO - PROCESS | 1673 | RSS: Main: 170422272 06:00:23 INFO - PROCESS | 1673 | 06:01:13 INFO - PROCESS | 1673 | 1467032473061 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] 06:03:23 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:03:24 INFO - PROCESS | 1673 | RSS: Main: 181559296 06:03:24 INFO - PROCESS | 1673 | 06:06:27 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:06:27 INFO - PROCESS | 1673 | RSS: Main: 192106496 06:06:27 INFO - PROCESS | 1673 | 06:09:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:09:30 INFO - PROCESS | 1673 | RSS: Main: 194387968 06:09:30 INFO - PROCESS | 1673 | 06:12:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:12:32 INFO - PROCESS | 1673 | RSS: Main: 198029312 06:12:32 INFO - PROCESS | 1673 | 06:15:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:15:35 INFO - PROCESS | 1673 | RSS: Main: 197165056 06:15:35 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:18:37 INFO - PROCESS | 1673 | RSS: Main: 202039296 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | __start_tp_report 06:18:37 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 06:18:37 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 06:18:37 INFO - PROCESS | 1673 | |i|pagename|runs| 06:18:37 INFO - PROCESS | 1673 | |0;dojo.html;3659.5425571803526;3705.8702945396917;3715.294094122118;3725.683316918062;3752.7185461090407;6041.848953776147;6079.78720744774;6095.786647467339;6109.358517355675;6160.106784516242;6089.147519347284;6092.603980741249;6095.512359011268;6101.511879049665;6122.693865306739;5399.892002159964;5423.755930983096;5491.725413729318;5510.393856675762;5556.666600003992;5422.91865622016;5506.779728810863;5506.981208476444;5556.91664625031;5582.358028826676;4524.660650451213;5482.424345443731;5516.007118718629;5519.69641669708;5526.392096869341;4795.304680821297;5470.64440811348;5483.424240454735;5492.670439773607;5535.861603459905;4149.419081328617;4423.6630232996895;4432.867013989586;5424.783008679648;5467.289252397202;6107.4503294703245;6136.693165341715;6139.293981192131;6140.048292514667;6143.047827586731;6287.056941458818;6368.10846481493;6374;6383.042543618448;6399.488040956712;6413.454856337217;6463.450606698436;6468.320826313264;6478.125453063823;6481.48148148147;5078.542931136179;6151.046587778901;6165.075238714184;6173.56785025044;6173.783917562864;6433.806985790434;6526.086347911296;6536.954087346002;6610.537262391683;6623.07276981223;6308;6325.209348831396;6340.4293613575;6342.429181373698;6343.365663433712;6476.643784591893;6483.189601299838;6490.675466226669;6511.772087976898;6512.316206798313;5537.307836520435;6197.318294987548;6339.302676705559;6339.302676705559;6383.616982981036;6313.463355614824;6348.206474190726;6351.682415879188;6361.01404282337;6388.488920886318;5023.6483446159145;5061.544460998528;5149.665271757323;5150.690958542425;5180.481951804864;4598.2412901871485;4620.514845941195;4639.698419602715;4648.256278995412;4709.858704238878;6165.352637973038;6186.381361863778;6187.690615469209;6189.381061893775;6209.0996805462955;6357.268914074848;6490.707918143695;6492.058651495507;6503.122078519339;6510.641914694737;6091.8172454825535;6132.20254427538;6154;6198.659073750987;6207.131001659771;5656.123300888369;5660.632058916157;5678.0915053591225;5678.734727531686;5681.801136960186;6564.081028656087;6707.1616047994;6713.899291510631;6771.559848609824;6799.762008329783;5391.676499410048;6376.39424254695;6452.032195170575;6500.349965003462;6501.934980650322;6662.433693135944;6677.098591690254;6698.196216454056;6734.326567343226;6739.292374300628;6317.873642527215;6351.777687780906;6365.236171659245;6415.903761443676;6499.3175716549085;6428;6454.838629034124;6480;6486.610803351814;6505.447037001908;5667.943320566907;6174.969125154345;6276.089966954674;6281.057841323838;6289.371062893674;6163.19878415803;6165.599236049642;6255.624662520263;6286.214223222098;6318.08387783778;5211.957608478244;6184.948558744934;6188.226471691039;6199.256089269316;6248.4688801452385;6179.3202747698615;6264.185655864709;6321.810345689637;6324.3991820776955;6355.237371515448;5194.818181363634;6163.075538669235;6167.475764559883;6181.629102253699;6214.347493513297 06:18:37 INFO - PROCESS | 1673 | |1;ext.html;506.68838664221494;518.6706441409705;555.8999380111578;576.7174084698497;627.3914303125966;39179.41230881536;40167.99999999996;40195.1960960781;40219.59780402195;40256.39615405764;41269;41794;42417.78791106048;42501.149977000445;42539.36190957138;9760.755981100494;9970.302078854484;9976.850347244797;9977.75055623608;9995.100440960312;9814.656487022956;9869.654562090329;9925.156361709263;10000.499975001258;10005.249606279558;9809.411435313905;9952.452615106165;9962.153216976565;9972.900270997307;10034.297599168061;9939.40363578184;9961.850572241423;9984.90015099847;10001.449920254383;10001.599936002587;9787.657431989917;9835.065668761456;9876.506174691309;9897.901020989842;9907.603695852158;40076.599234007575;40095.39856902149;40172.598274017175;40301.39547906784;40742.77771666855;3185.2992341684794;3278.7377009839156;3358.6809253120914;3391.6947474727144;3817.828197731109;27181.320466988287;27976;28000.439991200266;28268.43463130726;28763.56854647182;2306.988465057681;2723.677411661829;2859.8999035033676;2863.3700585871075;2878.3811480531576;369245;426928;439632;444293.7785311085;444586;37201.06997325034;37840.62159378371;62868.371316287165;64351.67824160849;64440.35559644437;32216.516752248735;35578.644213557534;36317.455238171446;36458;36561.26877462489;16480.34078636865;16619.6676066478;16645.0012999218;16655.167241637868;16675.91606545595;13564.93217533906;13984.930075349761;14018.299085045706;14076.648083797987;14078.366473508717;7520.774376768706;8369.702696082117;8419.200175983271;8446.704365347183;8488.575571221414;2943.499605067144;3515.1212196950764;3516.4549494828343;3530;3533.551243990003;1018.6371031147561;1021.6934919524113;1037.2790910317258;1052.3054783842626;1110.439228189759;30319;30347.48262586862;30769.69230307668;30870.69129308723;30960.535591966138;1101.1136035491506;1119.322809700136;1149.149629274331;1164.6738913104343;1218.500414829933;15563.688726225411;15681.90226684144;15733.753352008142;15736.92131539335;16107;663257;663263;665229;669284;676962;55247.723761380934;60602.696986514784;62183.37816621867;62555;63097;1537.8308386077522;1538;1554.5880341709455;1557.6651020030747;1614.2897125264847;29777;30444;30548.541771873883;30668;30767.773456974952;51413.7429312851;52720.9455810874;52819.47180528146;52929;52965.7351713239;574516;574868;590103;596080;596993;26642;27540.89836406521;27607.58588621132;45173.54826451825;45580.772096139306;44639.10721785481;44863.32705009362;45581.77209114066;45824.770876145405;46594;31250.374992500478;35369.292614148086;36358.8182059088;37321.880343589735;38658.6134138655;33180;33435.66564334326;34405.82797085999;37407;37882.43176352412;38163.80918095392;38416;38843.80578097091;39245.01887452837;39967.60032399639;30196.54705179468;33311.66688333086;33467.82862599797;34466.13834654053;34500;25262.74737252604;25731.742682572934;25945;26090.86954565215;26268 06:18:37 INFO - PROCESS | 1673 | |2;jquery.html;406.29710600660854;409.53926832313647;413.7104027180973;417.52402261421963;420.46600816962456;20714.792852071474;21081.367558973216;21696.457588560275;21715.45711357215;22030.788306643128;12167.965722913563;12181.025517958564;12188.878111218884;16867.493975180732;20575.074121664522;5526.088195447746;5690.516306113986;5716.8856622867725;5739.684317362543;5742.97128514359;6247.125402443661;6343.555951083426;6351.9682401587925;6369.681515924209;6376.202974628171;4741.644376671763;5972.014617588093;6173.475254603341;6302.55882088254;6334.334894836045;5639.295088113986;5648.887022259552;5684.971575142098;5718.056520674084;5724.9427505724825;5501.477359650827;5526.447355264481;5579.2746942897165;5588.91616625751;5600.0759874620635;13982.161070335813;14531.128132312095;21859.68841869493;25920.61119083215;27227.591586126026;2051.7435320584927;2167.111484291433;2213.0705103856417;2424.9151279705125;2618.9083382081726;8610.268127209194;10126.088652021353;10313.174946004301;10483.10893574047;10497.947510262476;1749.8425141737305;1825.8356747892753;1853.759011328532;1878.074973152516;1913.961720765577;117792;118011;119999.80000199974;123171;125137;12118.575849845212;12225.388730563436;12238.81641775374;12359.69100772488;12402.875971240172;12843.422046007952;15366.078035317916;15467.458638947583;15848;15934.362625495081;9385.296102792317;9462.101100395452;9629.277804164716;9658.71023869285;9684.854727179098;7872.763817085496;9437.669681561112;9470.621175153054;9524.571394287274;9533.761655958519;4880.804767809248;4933.98853235086;4983.476734942851;4991.625628077909;5033;2056.465319017066;2085.8122768950866;2126.5534237809925;2128.616848967201;2140.860844045132;947.7204224753714;961.9759506012406;971.6842026341326;993.1409330928839;1071.3090056913247;20976.149422423296;21534.353969380943;21667.67498487524;21710.45723856916;21748.456288592595;975.3708857786829;977.5258999385293;1001.7295330260789;1005.2360206243308;1018.2617602238317;9523.857142142873;10468.738281543023;11113.72215694598;11500.712482187844;11592.246503977214;523799;636117;644094;663319;665594;109555.90444095457;122142.38928805299;122986;124583;126613;1021.2748948246827;1039.2673165418362;1040.3497813866334;1042.6663467690266;1076.3272954403342;18578.721319179953;18740.81259187445;19165.520861978563;19195.61608767845;19468.31860884862;36566.26867462689;51920.22119668283;52318.95362092813;53859.73070134624;55912.720436397554;77807;78162.82755758782;78653.21346786458;78768.60615696885;81150.59424702839;8381.16188381157;8422.284105851071;8432;8708.433951793113;8709;9385.38994965325;12607.243565386107;12688.936555317534;13049;13089.67275818074;10220.335678180894;11252.987231149236;11475.311481311148;11503.884961150281;11517.769644607228;8982.550872456482;10830.783384332111;11037.172212084286;11107.44462776874;11304.095672346357;11502.309861408343;11556.479958401724;11669.474873630537;11787.528498859949;11843.348615826213;8453.027901791373;8536.31709463229;8560.186782255676;8598.82802343962;8761.824763504566;10704.625338113128;10795.244332896622;10916.7270818227;10929.726756830825;11268.323900565993 06:18:37 INFO - PROCESS | 1673 | |3;mootools.html;1461.481174183165;1656.1636373631318;1777.7955535113465;1859.367814942919;2009.6884982827667;8244.340452763765;8891.510966896834;9037.096290370959;9269.21211697005;9272.304577156716;7690.384769218463;8946.881639795025;8970.461772293667;8999.82000359994;9006.95496522518;2251.795289520107;2267.2744721689064;2358.151065616377;2535.404180017694;2550.3496608364885;2517.6601158843505;2534.771870531652;2560.8207425480223;2564.6281289213052;2572.048342113421;2524.899004039836;2527.19129878439;2550.1457011901034;2558.539462896678;2562.525932702447;2259.621630805216;2405.446747248125;2511.623256511529;2555.488902219545;2559.4881023795315;2197.230969160797;2513.648089267504;2521.3948652323493;2522.041624182817;2560.6543116679195;9059.547022648907;9126.81746365069;9193.494357810318;9200.309976751703;9269.258459323239;5533.723313834292;5584.357798853143;5597.720113994284;5644.887102257973;5711.428857114297;3659;3698.7041036716996;3720.2559488102215;3738.1962877981364;3786.450964610116;1041.387191335024;1069.9144068474504;1072.1155047086186;1073.1736562846565;1073.9355638661705;11708.238964467368;11797.52809887612;12249.510019599295;12280.263184208976;12301.630951071393;4952.47998960104;4995.675281106716;5050.898982020412;5059.848204553869;5156.74216289184;10427.843582346271;10444.42555659446;10457.215708821717;10479.266451348332;10490.632827850988;5538.75075621598;5571.554275657938;5653.575981801381;5774.047282198474;5786.797462088806;4156.376543518496;4631.907361852744;5146.30524879144;5195.844124676266;5292.20616907467;4202.054537728986;4207.368894665825;4215.704900656925;4306.80619372129;4329.848455304113;1390.0686540018212;1415.3843078260784;1418.036020112152;1418.3900922603173;1424.950126745559;965.6185806606492;984.4487087231173;984.5815528400401;988.6885631026204;1002.0480543483719;6039.4262545058145;6141.324454310023;6165.907511387333;6233.34549872266;6325.841853953688;460.56016504238374;475.4888494868031;475.5696095034;480.0830413909416;483.9008003359303;4022.5374081980362;4072;4099.262132816122;4102.671786257092;4126.690498212646;10952;11163.27438716497;11251.324920504796;11278.774424511628;11288.379139147426;8886.4668119913;10759.193060520493;10779.02988731018;10869.782604348027;11023.503942322615;8523.147685231428;8661.696840610548;8674.956625216833;8684;8685.218330350172;5867.706614669335;6082.60463069899;6087.786927457518;6132.2947860996555;6294.339094395205;9860.16188623975;9930.900690992998;9951.552180151766;9997.050280223368;10039.799204016024;8453.492790432594;10113.544890480092;10344.793104137725;10351.792964140826;10550.683479495627;7439.776806695808;7593.924060759322;7693.6537855795505;7822.06135263772;7848.136704962335;8252.83494330098;8486.872696909675;8518.14818518168;8556.358273129415;8556.786080348042;7442.96278518604;7569.735059272899;7590.1650818408825;7680.308772210527;7697.8845317319165;7348.77953661391;7409.703611855465;7449.6275186241555;7467.141278753013;7570.507916985378;6995.405390541861;7044.506884518035;7127.216006239206;7141.750038748619;7151.713931442892;4929.679570827885;4936.284238785284;5055.393352797688;5057.216131499624;5132.640715150053;4372.256716358163;5032.647714659939;5132.589392848488;5149.304843846033;5192.506711862367 06:18:37 INFO - PROCESS | 1673 | |4;prototype.html;300.9683983181765;324.8586864713851;342.1787709497206;350.50928699820264;351.24832857684544;6935.999999999987;6993.615351155684;7031.8945215821805;7158.248383919685;7223;7065.540739851906;7129.857402851952;7143.607101609409;7163.212046674875;7177.066981292438;5225.137852254374;5227.895442091156;5228.372595288571;5232;5253.99999999999;4415.51429342772;5066.36670416198;5232.4767523247565;5242.318498595197;5242.449542798008;5147.124988751922;5168.948310516903;5178.637495375326;5179.4561571035065;5189.247559103927;5055.65657013614;5151.021305951876;5183.326167598226;5190.610704197182;5214.5046220609365;4400.955990440087;4438.667099967515;4438.977805110986;4461.286194208943;4465.754383508905;6791.898121528181;6829.180498340182;6833.760818371333;6843.828904277383;6874.278200788895;5949.9107513387335;6052.394760523956;6071.908921366183;6073.817785466443;6079.635221886657;7515.361194298491;7535.208803075653;7536.057992750906;7540.17058123606;7580.507267027626;4556.248219043887;4803.231482962744;4805.13507568641;4810.759462026885;4833.661643684944;7792.688292468294;7950.284474397275;7967.004124484497;7969.800754981114;8019.157988411192;4890.339804126397;4893.070316639827;4908.165611845923;4913.091078150554;4918.631102667314;4976.850694479172;4981.427135879348;5003.774830132653;5007.549320561167;5022.347094877642;5814.127880817911;6002;6013.308469525973;6023.969880150571;6027.216461860018;7467.663955122032;7522.059742532184;7528.360089392353;7544.547327160388;7552.924470755332;1682.3943380383298;1721.1652348610914;1723.2331612432597;1725.6031112843866;1729.8183690712547;1013.0780989299702;1057.7937302226146;1072.7586293083993;1073.7852429514128;1095.9397233152094;6008.386351936834;6935.063766391472;6968.407685346701;7001.859962800715;7037.1555413350725;7696.6536505857375;7721.729739459092;7729.497582657109;7756.991591093235;7769.223077692185;6295.18162638854;6975.267596902354;7012.964935175393;7032.929670703227;7049.436045116378;3321.8339083045753;4016.6987475938836;4046.817893194813;4078.9184216315507;4087.795610219477;8258.339332853357;8280.792980175544;8299.128591497927;8310.168983101763;8315.501069935703;6988;8179.304759095544;8188.713395031145;8205;8208.958955205306;7956.920430795618;8281.503109813431;8295.087540370676;8321.126281740451;8333;7660.463767536219;7870.881936770838;7898.921010790048;7914.129445761077;7924.088729795917;7734.342580880688;7757.883631745642;7762.107357653942;7772.417068719756;7776.883346749916;8278.875816862632;8282.50304981703;8286.337093032422;8292.212239837207;8306;4050.007748101734;4858.82994095205;4920.975395123001;4924.990376972641;4943.184374578154;7588.886166707393;7848.489848159851;7851.685932562634;7859.214078592095;7868.685252589832;7519.774406767806;7559.886601700869;7576.583287919218;7585.658645361083;7616.657250423634;7552.584607846401;7559.20628334017;7575.545467271982;7582.924170758442;7600.695972161273;7152.892706609301;7299.197088320387;7345.8898116527225;7375.446841487017;7419;7549.396048316232;7565.205653406533;7570.318671319607;7572.318491335806;7618.276263754934;7100.112485939258;7213;7448.143463501767;7500.737474188377;7532.171461139161 06:18:37 INFO - PROCESS | 1673 | |5;yui.html;725.5791640848307;753.9999999999993;773.5242825662218;773.8761798112299;781.3944193250234;12764;15270.465533706323;15611.453599124034;15634.921825390886;15637.609059773511;14368.425262989467;14402.27988600571;14403.63990900228;14408.991370604062;14422.278886055681;744.9478536502447;901.5266984832982;916.867054277131;940.1679513630418;940.6096469964956;918.5177781664613;929.7071422501924;933;933.883264591926;936.8688383626263;952.3428834104445;976.9902300977005;987.1757082835804;989.6338354808731;990.9306348555604;951.0299494515556;973.810107029126;980.0444566547559;991.6083147156869;995.044757033249;715.7172916697928;739.0207974433897;742.2466196810242;742.8959945607619;744.0253268218597;14702.191379474125;14785.482508112165;15092.943493955427;15213.011154274936;15278.847211527966;12872.29202393868;12879.67800804978;12990.935045324808;13063.608091757167;13199.208047517084;7886.329661978739;9562.90437095627;10239.795204095877;11231.663050108427;11243.325400475916;3323.8005719656658;3465.5321531593163;3596.892093237207;3611.3860643690637;3665.5784584772828;74494.88257676193;75309.61106750209;86307;88956;90840.54579727125;8235.95882020598;9098.04470530598;9651.806963860683;9723.222142228604;9893.455859927773;21712.674309885366;21927.67108493374;21954.34136975893;22106.778932210473;22197.1121155152;6792.694328755218;7591.620418979029;7617.200193979663;7637.694492220249;7677.769666910001;4075.612816782401;4169.583041695867;4237.788110594458;4245.766482843474;4269.978650106729;3777.9433308500393;3821.44589034594;3852.9036774080873;3857.247836671822;3926.6858651307825;676.5264314979534;691.6472598974459;692.0864458914185;694.9583025018516;696.6481926627021;600.8197540737849;612.9938700613026;613.0865011133379;625.252822876658;642.9839254018686;8472;8483.95758021206;8498.490090594583;8623.396362254582;8690.478571285617;605.5458406195354;609.834700090235;617.2716194889983;630.5334052800895;631.7094136697079;3934.272159650474;3936.9212615747524;3947.921041579152;4044.51465824103;4229.6827737919775;88594.67107993385;90549.09450905406;91033.1793364129;97380.51309743548;97622;78870.60564697254;79296.60351698204;79966;80385.59807201044;80933.59533202296;54816.17775733367;72075.2792472079;72593.6370318145;73415.89876151862;74424;7607.961960190164;8633.740987770378;8794.076621954602;8807.867881981647;8833.072527384533;44485.11029779322;50495.74752126216;51085;51563;52153.73923130512;66040;68968.6551567239;70957;71715.64142179256;71881;11072.280301780358;11348.773024539298;11354.772904542027;11522.769544608893;11554.364509952033;11926.463309151282;11956.46195921203;12142.332171730286;12184.329861857328;12325.075619328407;11161.460995935176;11529.596464123715;11638;11774.3524106175;11782.764344713229;11157.442127893735;11463.426828658367;11606.24559403636;11627.127965402799;12306.630801075982;11500.309981401142;11516.021138203347;11579.942100289445;11782.234154779911;12464.626061218178;8215.917840821754;8998.280137589109;10052.64815731446;10076.84884726715;10346.172306215334;9924.255680824112;10165.237607179342;10167.389956602627;10171.796564068825;10188.694339169837 06:18:37 INFO - PROCESS | 1673 | __end_tp_report 06:18:37 INFO - PROCESS | 1673 | __start_cc_report 06:18:37 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,397 06:18:37 INFO - PROCESS | 1673 | __end_cc_report 06:18:37 INFO - PROCESS | 1673 | __startTimestamp1467033517850__endTimestamp 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | ------- Summary: start ------- 06:18:37 INFO - PROCESS | 1673 | Number of tests: 6 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5956.28 Median:6186.38 stddev:682.69 (11.0%) stddev-sans-first:660.58 06:18:37 INFO - PROCESS | 1673 | Values: 3659.5 3705.9 3715.3 3725.7 3752.7 6041.8 6079.8 6095.8 6109.4 6160.1 6089.1 6092.6 6095.5 6101.5 6122.7 5399.9 5423.8 5491.7 5510.4 5556.7 5422.9 5506.8 5507.0 5556.9 5582.4 4524.7 5482.4 5516.0 5519.7 5526.4 4795.3 5470.6 5483.4 5492.7 5535.9 4149.4 4423.7 4432.9 5424.8 5467.3 6107.5 6136.7 6139.3 6140.0 6143.0 6287.1 6368.1 6374.0 6383.0 6399.5 6413.5 6463.5 6468.3 6478.1 6481.5 5078.5 6151.0 6165.1 6173.6 6173.8 6433.8 6526.1 6537.0 6610.5 6623.1 6308.0 6325.2 6340.4 6342.4 6343.4 6476.6 6483.2 6490.7 6511.8 6512.3 5537.3 6197.3 6339.3 6339.3 6383.6 6313.5 6348.2 6351.7 6361.0 6388.5 5023.6 5061.5 5149.7 5150.7 5180.5 4598.2 4620.5 4639.7 4648.3 4709.9 6165.4 6186.4 6187.7 6189.4 6209.1 6357.3 6490.7 6492.1 6503.1 6510.6 6091.8 6132.2 6154.0 6198.7 6207.1 5656.1 5660.6 5678.1 5678.7 5681.8 6564.1 6707.2 6713.9 6771.6 6799.8 5391.7 6376.4 6452.0 6500.3 6501.9 6662.4 6677.1 6698.2 6734.3 6739.3 6317.9 6351.8 6365.2 6415.9 6499.3 6428.0 6454.8 6480.0 6486.6 6505.4 5667.9 6175.0 6276.1 6281.1 6289.4 6163.2 6165.6 6255.6 6286.2 6318.1 5212.0 6184.9 6188.2 6199.3 6248.5 6179.3 6264.2 6321.8 6324.4 6355.2 5194.8 6163.1 6167.5 6181.6 6214.3 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:68326.48 Median:37364.44 stddev:152446.70 (408.0%) stddev-sans-first:152789.31 06:18:37 INFO - PROCESS | 1673 | Values: 506.7 518.7 555.9 576.7 627.4 39179.4 40168.0 40195.2 40219.6 40256.4 41269.0 41794.0 42417.8 42501.1 42539.4 9760.8 9970.3 9976.9 9977.8 9995.1 9814.7 9869.7 9925.2 10000.5 10005.2 9809.4 9952.5 9962.2 9972.9 10034.3 9939.4 9961.9 9984.9 10001.4 10001.6 9787.7 9835.1 9876.5 9897.9 9907.6 40076.6 40095.4 40172.6 40301.4 40742.8 3185.3 3278.7 3358.7 3391.7 3817.8 27181.3 27976.0 28000.4 28268.4 28763.6 2307.0 2723.7 2859.9 2863.4 2878.4 369245.0 426928.0 439632.0 444293.8 444586.0 37201.1 37840.6 62868.4 64351.7 64440.4 32216.5 35578.6 36317.5 36458.0 36561.3 16480.3 16619.7 16645.0 16655.2 16675.9 13564.9 13984.9 14018.3 14076.6 14078.4 7520.8 8369.7 8419.2 8446.7 8488.6 2943.5 3515.1 3516.5 3530.0 3533.6 1018.6 1021.7 1037.3 1052.3 1110.4 30319.0 30347.5 30769.7 30870.7 30960.5 1101.1 1119.3 1149.1 1164.7 1218.5 15563.7 15681.9 15733.8 15736.9 16107.0 663257.0 663263.0 665229.0 669284.0 676962.0 55247.7 60602.7 62183.4 62555.0 63097.0 1537.8 1538.0 1554.6 1557.7 1614.3 29777.0 30444.0 30548.5 30668.0 30767.8 51413.7 52720.9 52819.5 52929.0 52965.7 574516.0 574868.0 590103.0 596080.0 596993.0 26642.0 27540.9 27607.6 45173.5 45580.8 44639.1 44863.3 45581.8 45824.8 46594.0 31250.4 35369.3 36358.8 37321.9 38658.6 33180.0 33435.7 34405.8 37407.0 37882.4 38163.8 38416.0 38843.8 39245.0 39967.6 30196.5 33311.7 33467.8 34466.1 34500.0 25262.7 25731.7 25945.0 26090.9 26268.0 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:35544.20 Median:21712.96 stddev:104608.93 (481.8%) stddev-sans-first:104869.11 06:18:37 INFO - PROCESS | 1673 | Values: 406.3 409.5 413.7 417.5 420.5 20714.8 21081.4 21696.5 21715.5 22030.8 12168.0 12181.0 12188.9 16867.5 20575.1 5526.1 5690.5 5716.9 5739.7 5743.0 6247.1 6343.6 6352.0 6369.7 6376.2 4741.6 5972.0 6173.5 6302.6 6334.3 5639.3 5648.9 5685.0 5718.1 5724.9 5501.5 5526.4 5579.3 5588.9 5600.1 13982.2 14531.1 21859.7 25920.6 27227.6 2051.7 2167.1 2213.1 2424.9 2618.9 8610.3 10126.1 10313.2 10483.1 10497.9 1749.8 1825.8 1853.8 1878.1 1914.0 117792.0 118011.0 119999.8 123171.0 125137.0 12118.6 12225.4 12238.8 12359.7 12402.9 12843.4 15366.1 15467.5 15848.0 15934.4 9385.3 9462.1 9629.3 9658.7 9684.9 7872.8 9437.7 9470.6 9524.6 9533.8 4880.8 4934.0 4983.5 4991.6 5033.0 2056.5 2085.8 2126.6 2128.6 2140.9 947.7 962.0 971.7 993.1 1071.3 20976.1 21534.4 21667.7 21710.5 21748.5 975.4 977.5 1001.7 1005.2 1018.3 9523.9 10468.7 11113.7 11500.7 11592.2 523799.0 636117.0 644094.0 663319.0 665594.0 109555.9 122142.4 122986.0 124583.0 126613.0 1021.3 1039.3 1040.3 1042.7 1076.3 18578.7 18740.8 19165.5 19195.6 19468.3 36566.3 51920.2 52319.0 53859.7 55912.7 77807.0 78162.8 78653.2 78768.6 81150.6 8381.2 8422.3 8432.0 8708.4 8709.0 9385.4 12607.2 12688.9 13049.0 13089.7 10220.3 11253.0 11475.3 11503.9 11517.8 8982.6 10830.8 11037.2 11107.4 11304.1 11502.3 11556.5 11669.5 11787.5 11843.3 8453.0 8536.3 8560.2 8598.8 8761.8 10704.6 10795.2 10916.7 10929.7 11268.3 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5875.19 Median:4974.08 stddev:3265.77 (65.7%) stddev-sans-first:3258.08 06:18:37 INFO - PROCESS | 1673 | Values: 1461.5 1656.2 1777.8 1859.4 2009.7 8244.3 8891.5 9037.1 9269.2 9272.3 7690.4 8946.9 8970.5 8999.8 9007.0 2251.8 2267.3 2358.2 2535.4 2550.3 2517.7 2534.8 2560.8 2564.6 2572.0 2524.9 2527.2 2550.1 2558.5 2562.5 2259.6 2405.4 2511.6 2555.5 2559.5 2197.2 2513.6 2521.4 2522.0 2560.7 9059.5 9126.8 9193.5 9200.3 9269.3 5533.7 5584.4 5597.7 5644.9 5711.4 3659.0 3698.7 3720.3 3738.2 3786.5 1041.4 1069.9 1072.1 1073.2 1073.9 11708.2 11797.5 12249.5 12280.3 12301.6 4952.5 4995.7 5050.9 5059.8 5156.7 10427.8 10444.4 10457.2 10479.3 10490.6 5538.8 5571.6 5653.6 5774.0 5786.8 4156.4 4631.9 5146.3 5195.8 5292.2 4202.1 4207.4 4215.7 4306.8 4329.8 1390.1 1415.4 1418.0 1418.4 1425.0 965.6 984.4 984.6 988.7 1002.0 6039.4 6141.3 6165.9 6233.3 6325.8 460.6 475.5 475.6 480.1 483.9 4022.5 4072.0 4099.3 4102.7 4126.7 10952.0 11163.3 11251.3 11278.8 11288.4 8886.5 10759.2 10779.0 10869.8 11023.5 8523.1 8661.7 8675.0 8684.0 8685.2 5867.7 6082.6 6087.8 6132.3 6294.3 9860.2 9930.9 9951.6 9997.1 10039.8 8453.5 10113.5 10344.8 10351.8 10550.7 7439.8 7593.9 7693.7 7822.1 7848.1 8252.8 8486.9 8518.1 8556.4 8556.8 7443.0 7569.7 7590.2 7680.3 7697.9 7348.8 7409.7 7449.6 7467.1 7570.5 6995.4 7044.5 7127.2 7141.8 7151.7 4929.7 4936.3 5055.4 5057.2 5132.6 4372.3 5032.6 5132.6 5149.3 5192.5 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:6181.30 Median:7032.41 stddev:2017.30 (28.7%) stddev-sans-first:1974.09 06:18:37 INFO - PROCESS | 1673 | Values: 301.0 324.9 342.2 350.5 351.2 6936.0 6993.6 7031.9 7158.2 7223.0 7065.5 7129.9 7143.6 7163.2 7177.1 5225.1 5227.9 5228.4 5232.0 5254.0 4415.5 5066.4 5232.5 5242.3 5242.4 5147.1 5168.9 5178.6 5179.5 5189.2 5055.7 5151.0 5183.3 5190.6 5214.5 4401.0 4438.7 4439.0 4461.3 4465.8 6791.9 6829.2 6833.8 6843.8 6874.3 5949.9 6052.4 6071.9 6073.8 6079.6 7515.4 7535.2 7536.1 7540.2 7580.5 4556.2 4803.2 4805.1 4810.8 4833.7 7792.7 7950.3 7967.0 7969.8 8019.2 4890.3 4893.1 4908.2 4913.1 4918.6 4976.9 4981.4 5003.8 5007.5 5022.3 5814.1 6002.0 6013.3 6024.0 6027.2 7467.7 7522.1 7528.4 7544.5 7552.9 1682.4 1721.2 1723.2 1725.6 1729.8 1013.1 1057.8 1072.8 1073.8 1095.9 6008.4 6935.1 6968.4 7001.9 7037.2 7696.7 7721.7 7729.5 7757.0 7769.2 6295.2 6975.3 7013.0 7032.9 7049.4 3321.8 4016.7 4046.8 4078.9 4087.8 8258.3 8280.8 8299.1 8310.2 8315.5 6988.0 8179.3 8188.7 8205.0 8209.0 7956.9 8281.5 8295.1 8321.1 8333.0 7660.5 7870.9 7898.9 7914.1 7924.1 7734.3 7757.9 7762.1 7772.4 7776.9 8278.9 8282.5 8286.3 8292.2 8306.0 4050.0 4858.8 4921.0 4925.0 4943.2 7588.9 7848.5 7851.7 7859.2 7868.7 7519.8 7559.9 7576.6 7585.7 7616.7 7552.6 7559.2 7575.5 7582.9 7600.7 7152.9 7299.2 7345.9 7375.4 7419.0 7549.4 7565.2 7570.3 7572.3 7618.3 7100.1 7213.0 7448.1 7500.7 7532.2 06:18:37 INFO - PROCESS | 1673 | 06:18:37 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18601.30 Median:615.18 stddev:26153.10 (4251.3%) stddev-sans-first:26192.02 06:18:37 INFO - PROCESS | 1673 | Values: 725.6 754.0 773.5 773.9 781.4 12764.0 15270.5 15611.5 15634.9 15637.6 14368.4 14402.3 14403.6 14409.0 14422.3 744.9 901.5 916.9 940.2 940.6 918.5 929.7 933.0 933.9 936.9 952.3 977.0 987.2 989.6 990.9 951.0 973.8 980.0 991.6 995.0 715.7 739.0 742.2 742.9 744.0 14702.2 14785.5 15092.9 15213.0 15278.8 12872.3 12879.7 12990.9 13063.6 13199.2 7886.3 9562.9 10239.8 11231.7 11243.3 3323.8 3465.5 3596.9 3611.4 3665.6 74494.9 75309.6 86307.0 88956.0 90840.5 8236.0 9098.0 9651.8 9723.2 9893.5 21712.7 21927.7 21954.3 22106.8 22197.1 6792.7 7591.6 7617.2 7637.7 7677.8 4075.6 4169.6 4237.8 4245.8 4270.0 3777.9 3821.4 3852.9 3857.2 3926.7 676.5 691.6 692.1 695.0 696.6 600.8 613.0 613.1 625.3 643.0 8472.0 8484.0 8498.5 8623.4 8690.5 605.5 609.8 617.3 630.5 631.7 3934.3 3936.9 3947.9 4044.5 4229.7 88594.7 90549.1 91033.2 97380.5 97622.0 78870.6 79296.6 79966.0 80385.6 80933.6 54816.2 72075.3 72593.6 73415.9 74424.0 7608.0 8633.7 8794.1 8807.9 8833.1 44485.1 50495.7 51085.0 51563.0 52153.7 66040.0 68968.7 70957.0 71715.6 71881.0 11072.3 11348.8 11354.8 11522.8 11554.4 11926.5 11956.5 12142.3 12184.3 12325.1 11161.5 11529.6 11638.0 11774.4 11782.8 11157.4 11463.4 11606.2 11627.1 12306.6 11500.3 11516.0 11579.9 11782.2 12464.6 8215.9 8998.3 10052.6 10076.8 10346.2 9924.3 10165.2 10167.4 10171.8 10188.7 06:18:37 INFO - PROCESS | 1673 | -------- Summary: end -------- 06:18:37 INFO - PROCESS | 1673 | 06:18:38 INFO - TEST-INFO | 1673: exit 0 06:18:38 INFO - TEST-OK | dromaeo_css | took 1110247ms 06:18:38 INFO - TEST-START | kraken 06:18:38 INFO - operating with platform_type : mac_ 06:18:38 INFO - Initialising browser for kraken test... 06:18:38 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp6XPu5P/profile http://localhost:49271/getInfo.html) 06:18:40 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 06:18:40 INFO - PROCESS | 1683 | colorDepth:24 06:18:40 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 06:18:40 INFO - PROCESS | 1683 | __metrics 06:18:40 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:18:41 INFO - TEST-INFO | 1683: exit 0 06:18:41 INFO - Browser initialized. 06:18:41 INFO - Running cycle 1/1 for kraken test... 06:18:41 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp6XPu5P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:53 INFO - PROCESS | 1687 | RSS: Main: 170717184 06:18:53 INFO - PROCESS | 1687 | 06:18:55 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:56 INFO - PROCESS | 1687 | RSS: Main: 183422976 06:18:56 INFO - PROCESS | 1687 | 06:18:59 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:19:00 INFO - PROCESS | 1687 | RSS: Main: 192454656 06:19:00 INFO - PROCESS | 1687 | 06:19:03 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:19:04 INFO - PROCESS | 1687 | RSS: Main: 196136960 06:19:04 INFO - PROCESS | 1687 | 06:19:06 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:19:06 INFO - PROCESS | 1687 | RSS: Main: 196980736 06:19:06 INFO - PROCESS | 1687 | 06:19:08 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:09 INFO - PROCESS | 1687 | RSS: Main: 197685248 06:19:09 INFO - PROCESS | 1687 | 06:19:12 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:12 INFO - PROCESS | 1687 | RSS: Main: 198316032 06:19:12 INFO - PROCESS | 1687 | 06:19:15 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:16 INFO - PROCESS | 1687 | RSS: Main: 197935104 06:19:16 INFO - PROCESS | 1687 | 06:19:19 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:19:19 INFO - PROCESS | 1687 | RSS: Main: 198189056 06:19:19 INFO - PROCESS | 1687 | 06:19:21 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:22 INFO - PROCESS | 1687 | RSS: Main: 197578752 06:19:22 INFO - PROCESS | 1687 | 06:19:24 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:24 INFO - PROCESS | 1687 | RSS: Main: 197558272 06:19:24 INFO - PROCESS | 1687 | 06:19:26 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:27 INFO - PROCESS | 1687 | RSS: Main: 197439488 06:19:27 INFO - PROCESS | 1687 | 06:19:30 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:30 INFO - PROCESS | 1687 | RSS: Main: 197644288 06:19:30 INFO - PROCESS | 1687 | 06:19:33 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:34 INFO - PROCESS | 1687 | RSS: Main: 197562368 06:19:34 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:19:36 INFO - PROCESS | 1687 | RSS: Main: 199622656 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | __start_tp_report 06:19:36 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 06:19:36 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 06:19:36 INFO - PROCESS | 1687 | |i|pagename|runs| 06:19:36 INFO - PROCESS | 1687 | |0;ai-astar;117;112;117;115;117;131;114;164;152;118 06:19:36 INFO - PROCESS | 1687 | |1;audio-beat-detection;159;114;173;192;113;130;142;151;199;152 06:19:36 INFO - PROCESS | 1687 | |2;audio-dft;196;205;194;199;194;195;235;217;205;193 06:19:36 INFO - PROCESS | 1687 | |3;audio-fft;64;76;72;144;58;56;59;68;124;56 06:19:36 INFO - PROCESS | 1687 | |4;audio-oscillator;79;80;132;78;83;83;118;80;79;122 06:19:36 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;88;90;91;88;89;86;91;97;121;85 06:19:36 INFO - PROCESS | 1687 | |6;imaging-darkroom;95;97;95;97;97;132;152;95;94;95 06:19:36 INFO - PROCESS | 1687 | |7;imaging-desaturate;119;147;102;139;148;118;90;87;91;89 06:19:36 INFO - PROCESS | 1687 | |8;json-parse-financial;59;60;76;94;81;63;64;77;63;59 06:19:36 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;61;64;69;66;76;74;102;63;65;65 06:19:36 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;81;82;87;87;104;81;80;83;81;88 06:19:36 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;128;126;117;146;141;130;148;137;180;147 06:19:36 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;166;167;166;170;168;166;168;164;160;163 06:19:36 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;70;68;68;69;68;71;73;96;91;69 06:19:36 INFO - PROCESS | 1687 | __end_tp_report 06:19:36 INFO - PROCESS | 1687 | __start_cc_report 06:19:36 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1050 06:19:36 INFO - PROCESS | 1687 | __end_cc_report 06:19:36 INFO - PROCESS | 1687 | __startTimestamp1467033576269__endTimestamp 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | ------- Summary: start ------- 06:19:36 INFO - PROCESS | 1687 | Number of tests: 14 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:125.70 Median:117.50 stddev:17.99 (15.3%) stddev-sans-first:18.80 06:19:36 INFO - PROCESS | 1687 | Values: 117.0 112.0 117.0 115.0 117.0 131.0 114.0 164.0 152.0 118.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:155.50 stddev:29.53 (19.0%) stddev-sans-first:31.22 06:19:36 INFO - PROCESS | 1687 | Values: 159.0 114.0 173.0 192.0 113.0 130.0 142.0 151.0 199.0 152.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:203.30 Median:202.00 stddev:13.41 (6.6%) stddev-sans-first:13.96 06:19:36 INFO - PROCESS | 1687 | Values: 196.0 205.0 194.0 199.0 194.0 195.0 235.0 217.0 205.0 193.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:77.70 Median:61.50 stddev:30.80 (50.1%) stddev-sans-first:32.26 06:19:36 INFO - PROCESS | 1687 | Values: 64.0 76.0 72.0 144.0 58.0 56.0 59.0 68.0 124.0 56.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:79.50 stddev:21.45 (27.0%) stddev-sans-first:22.11 06:19:36 INFO - PROCESS | 1687 | Values: 79.0 80.0 132.0 78.0 83.0 83.0 118.0 80.0 79.0 122.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:92.60 Median:89.50 stddev:10.51 (11.7%) stddev-sans-first:11.02 06:19:36 INFO - PROCESS | 1687 | Values: 88.0 90.0 91.0 88.0 89.0 86.0 91.0 97.0 121.0 85.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:95.00 stddev:20.14 (21.2%) stddev-sans-first:21.04 06:19:36 INFO - PROCESS | 1687 | Values: 95.0 97.0 95.0 97.0 97.0 132.0 152.0 95.0 94.0 95.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:113.00 Median:117.50 stddev:24.73 (21.0%) stddev-sans-first:26.13 06:19:36 INFO - PROCESS | 1687 | Values: 119.0 147.0 102.0 139.0 148.0 118.0 90.0 87.0 91.0 89.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:70.00 stddev:11.82 (16.9%) stddev-sans-first:11.89 06:19:36 INFO - PROCESS | 1687 | Values: 59.0 60.0 76.0 94.0 81.0 63.0 64.0 77.0 63.0 59.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:65.50 stddev:12.05 (18.4%) stddev-sans-first:12.28 06:19:36 INFO - PROCESS | 1687 | Values: 61.0 64.0 69.0 66.0 76.0 74.0 102.0 63.0 65.0 65.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:82.50 stddev:7.17 (8.7%) stddev-sans-first:7.42 06:19:36 INFO - PROCESS | 1687 | Values: 81.0 82.0 87.0 87.0 104.0 81.0 80.0 83.0 81.0 88.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:143.50 stddev:17.41 (12.1%) stddev-sans-first:17.92 06:19:36 INFO - PROCESS | 1687 | Values: 128.0 126.0 117.0 146.0 141.0 130.0 148.0 137.0 180.0 147.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.50 stddev:2.86 (1.7%) stddev-sans-first:3.03 06:19:36 INFO - PROCESS | 1687 | Values: 166.0 167.0 166.0 170.0 168.0 166.0 168.0 164.0 160.0 163.0 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:70.50 stddev:10.31 (14.6%) stddev-sans-first:10.81 06:19:36 INFO - PROCESS | 1687 | Values: 70.0 68.0 68.0 69.0 68.0 71.0 73.0 96.0 91.0 69.0 06:19:36 INFO - PROCESS | 1687 | -------- Summary: end -------- 06:19:36 INFO - PROCESS | 1687 | 06:19:36 INFO - TEST-INFO | 1687: exit 0 06:19:37 INFO - TEST-OK | kraken | took 58659ms 06:19:37 INFO - SUITE-END | took 1168s 06:19:37 INFO - Completed test suite (00:19:29) 06:19:37 INFO - javascript benchmark 06:19:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3659.5425571803526, 3705.8702945396917, 3715.294094122118, 3725.683316918062, 3752.7185461090407, 6041.848953776147, 6079.78720744774, 6095.786647467339, 6109.358517355675, 6160.106784516242, 6089.147519347284, 6092.603980741249, 6095.512359011268, 6101.511879049665, 6122.693865306739, 5399.892002159964, 5423.755930983096, 5491.725413729318, 5510.393856675762, 5556.666600003992, 5422.91865622016, 5506.779728810863, 5506.981208476444, 5556.91664625031, 5582.358028826676, 4524.660650451213, 5482.424345443731, 5516.007118718629, 5519.69641669708, 5526.392096869341, 4795.304680821297, 5470.64440811348, 5483.424240454735, 5492.670439773607, 5535.861603459905, 4149.419081328617, 4423.6630232996895, 4432.867013989586, 5424.783008679648, 5467.289252397202, 6107.4503294703245, 6136.693165341715, 6139.293981192131, 6140.048292514667, 6143.047827586731, 6287.056941458818, 6368.10846481493, 6374.0, 6383.042543618448, 6399.488040956712, 6413.454856337217, 6463.450606698436, 6468.320826313264, 6478.125453063823, 6481.48148148147, 5078.542931136179, 6151.046587778901, 6165.075238714184, 6173.56785025044, 6173.783917562864, 6433.806985790434, 6526.086347911296, 6536.954087346002, 6610.537262391683, 6623.07276981223, 6308.0, 6325.209348831396, 6340.4293613575, 6342.429181373698, 6343.365663433712, 6476.643784591893, 6483.189601299838, 6490.675466226669, 6511.772087976898, 6512.316206798313, 5537.307836520435, 6197.318294987548, 6339.302676705559, 6339.302676705559, 6383.616982981036, 6313.463355614824, 6348.206474190726, 6351.682415879188, 6361.01404282337, 6388.488920886318, 5023.6483446159145, 5061.544460998528, 5149.665271757323, 5150.690958542425, 5180.481951804864, 4598.2412901871485, 4620.514845941195, 4639.698419602715, 4648.256278995412, 4709.858704238878, 6165.352637973038, 6186.381361863778, 6187.690615469209, 6189.381061893775, 6209.0996805462955, 6357.268914074848, 6490.707918143695, 6492.058651495507, 6503.122078519339, 6510.641914694737, 6091.8172454825535, 6132.20254427538, 6154.0, 6198.659073750987, 6207.131001659771, 5656.123300888369, 5660.632058916157, 5678.0915053591225, 5678.734727531686, 5681.801136960186, 6564.081028656087, 6707.1616047994, 6713.899291510631, 6771.559848609824, 6799.762008329783, 5391.676499410048, 6376.39424254695, 6452.032195170575, 6500.349965003462, 6501.934980650322, 6662.433693135944, 6677.098591690254, 6698.196216454056, 6734.326567343226, 6739.292374300628, 6317.873642527215, 6351.777687780906, 6365.236171659245, 6415.903761443676, 6499.3175716549085, 6428.0, 6454.838629034124, 6480.0, 6486.610803351814, 6505.447037001908, 5667.943320566907, 6174.969125154345, 6276.089966954674, 6281.057841323838, 6289.371062893674, 6163.19878415803, 6165.599236049642, 6255.624662520263, 6286.214223222098, 6318.08387783778, 5211.957608478244, 6184.948558744934, 6188.226471691039, 6199.256089269316, 6248.4688801452385, 6179.3202747698615, 6264.185655864709, 6321.810345689637, 6324.3991820776955, 6355.237371515448, 5194.818181363634, 6163.075538669235, 6167.475764559883, 6181.629102253699, 6214.347493513297], "value": 5915.464113562, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.68838664221494, 518.6706441409705, 555.8999380111578, 576.7174084698497, 627.3914303125966, 39179.41230881536, 40167.99999999996, 40195.1960960781, 40219.59780402195, 40256.39615405764, 41269.0, 41794.0, 42417.78791106048, 42501.149977000445, 42539.36190957138, 9760.755981100494, 9970.302078854484, 9976.850347244797, 9977.75055623608, 9995.100440960312, 9814.656487022956, 9869.654562090329, 9925.156361709263, 10000.499975001258, 10005.249606279558, 9809.411435313905, 9952.452615106165, 9962.153216976565, 9972.900270997307, 10034.297599168061, 9939.40363578184, 9961.850572241423, 9984.90015099847, 10001.449920254383, 10001.599936002587, 9787.657431989917, 9835.065668761456, 9876.506174691309, 9897.901020989842, 9907.603695852158, 40076.599234007575, 40095.39856902149, 40172.598274017175, 40301.39547906784, 40742.77771666855, 3185.2992341684794, 3278.7377009839156, 3358.6809253120914, 3391.6947474727144, 3817.828197731109, 27181.320466988287, 27976.0, 28000.439991200266, 28268.43463130726, 28763.56854647182, 2306.988465057681, 2723.677411661829, 2859.8999035033676, 2863.3700585871075, 2878.3811480531576, 369245.0, 426928.0, 439632.0, 444293.7785311085, 444586.0, 37201.06997325034, 37840.62159378371, 62868.371316287165, 64351.67824160849, 64440.35559644437, 32216.516752248735, 35578.644213557534, 36317.455238171446, 36458.0, 36561.26877462489, 16480.34078636865, 16619.6676066478, 16645.0012999218, 16655.167241637868, 16675.91606545595, 13564.93217533906, 13984.930075349761, 14018.299085045706, 14076.648083797987, 14078.366473508717, 7520.774376768706, 8369.702696082117, 8419.200175983271, 8446.704365347183, 8488.575571221414, 2943.499605067144, 3515.1212196950764, 3516.4549494828343, 3530.0, 3533.551243990003, 1018.6371031147561, 1021.6934919524113, 1037.2790910317258, 1052.3054783842626, 1110.439228189759, 30319.0, 30347.48262586862, 30769.69230307668, 30870.69129308723, 30960.535591966138, 1101.1136035491506, 1119.322809700136, 1149.149629274331, 1164.6738913104343, 1218.500414829933, 15563.688726225411, 15681.90226684144, 15733.753352008142, 15736.92131539335, 16107.0, 663257.0, 663263.0, 665229.0, 669284.0, 676962.0, 55247.723761380934, 60602.696986514784, 62183.37816621867, 62555.0, 63097.0, 1537.8308386077522, 1538.0, 1554.5880341709455, 1557.6651020030747, 1614.2897125264847, 29777.0, 30444.0, 30548.541771873883, 30668.0, 30767.773456974952, 51413.7429312851, 52720.9455810874, 52819.47180528146, 52929.0, 52965.7351713239, 574516.0, 574868.0, 590103.0, 596080.0, 596993.0, 26642.0, 27540.89836406521, 27607.58588621132, 45173.54826451825, 45580.772096139306, 44639.10721785481, 44863.32705009362, 45581.77209114066, 45824.770876145405, 46594.0, 31250.374992500478, 35369.292614148086, 36358.8182059088, 37321.880343589735, 38658.6134138655, 33180.0, 33435.66564334326, 34405.82797085999, 37407.0, 37882.43176352412, 38163.80918095392, 38416.0, 38843.80578097091, 39245.01887452837, 39967.60032399639, 30196.54705179468, 33311.66688333086, 33467.82862599797, 34466.13834654053, 34500.0, 25262.74737252604, 25731.742682572934, 25945.0, 26090.86954565215, 26268.0], "value": 19027.911883309796, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.29710600660854, 409.53926832313647, 413.7104027180973, 417.52402261421963, 420.46600816962456, 20714.792852071474, 21081.367558973216, 21696.457588560275, 21715.45711357215, 22030.788306643128, 12167.965722913563, 12181.025517958564, 12188.878111218884, 16867.493975180732, 20575.074121664522, 5526.088195447746, 5690.516306113986, 5716.8856622867725, 5739.684317362543, 5742.97128514359, 6247.125402443661, 6343.555951083426, 6351.9682401587925, 6369.681515924209, 6376.202974628171, 4741.644376671763, 5972.014617588093, 6173.475254603341, 6302.55882088254, 6334.334894836045, 5639.295088113986, 5648.887022259552, 5684.971575142098, 5718.056520674084, 5724.9427505724825, 5501.477359650827, 5526.447355264481, 5579.2746942897165, 5588.91616625751, 5600.0759874620635, 13982.161070335813, 14531.128132312095, 21859.68841869493, 25920.61119083215, 27227.591586126026, 2051.7435320584927, 2167.111484291433, 2213.0705103856417, 2424.9151279705125, 2618.9083382081726, 8610.268127209194, 10126.088652021353, 10313.174946004301, 10483.10893574047, 10497.947510262476, 1749.8425141737305, 1825.8356747892753, 1853.759011328532, 1878.074973152516, 1913.961720765577, 117792.0, 118011.0, 119999.80000199974, 123171.0, 125137.0, 12118.575849845212, 12225.388730563436, 12238.81641775374, 12359.69100772488, 12402.875971240172, 12843.422046007952, 15366.078035317916, 15467.458638947583, 15848.0, 15934.362625495081, 9385.296102792317, 9462.101100395452, 9629.277804164716, 9658.71023869285, 9684.854727179098, 7872.763817085496, 9437.669681561112, 9470.621175153054, 9524.571394287274, 9533.761655958519, 4880.804767809248, 4933.98853235086, 4983.476734942851, 4991.625628077909, 5033.0, 2056.465319017066, 2085.8122768950866, 2126.5534237809925, 2128.616848967201, 2140.860844045132, 947.7204224753714, 961.9759506012406, 971.6842026341326, 993.1409330928839, 1071.3090056913247, 20976.149422423296, 21534.353969380943, 21667.67498487524, 21710.45723856916, 21748.456288592595, 975.3708857786829, 977.5258999385293, 1001.7295330260789, 1005.2360206243308, 1018.2617602238317, 9523.857142142873, 10468.738281543023, 11113.72215694598, 11500.712482187844, 11592.246503977214, 523799.0, 636117.0, 644094.0, 663319.0, 665594.0, 109555.90444095457, 122142.38928805299, 122986.0, 124583.0, 126613.0, 1021.2748948246827, 1039.2673165418362, 1040.3497813866334, 1042.6663467690266, 1076.3272954403342, 18578.721319179953, 18740.81259187445, 19165.520861978563, 19195.61608767845, 19468.31860884862, 36566.26867462689, 51920.22119668283, 52318.95362092813, 53859.73070134624, 55912.720436397554, 77807.0, 78162.82755758782, 78653.21346786458, 78768.60615696885, 81150.59424702839, 8381.16188381157, 8422.284105851071, 8432.0, 8708.433951793113, 8709.0, 9385.38994965325, 12607.243565386107, 12688.936555317534, 13049.0, 13089.67275818074, 10220.335678180894, 11252.987231149236, 11475.311481311148, 11503.884961150281, 11517.769644607228, 8982.550872456482, 10830.783384332111, 11037.172212084286, 11107.44462776874, 11304.095672346357, 11502.309861408343, 11556.479958401724, 11669.474873630537, 11787.528498859949, 11843.348615826213, 8453.027901791373, 8536.31709463229, 8560.186782255676, 8598.82802343962, 8761.824763504566, 10704.625338113128, 10795.244332896622, 10916.7270818227, 10929.726756830825, 11268.323900565993], "value": 9667.715480218178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.481174183165, 1656.1636373631318, 1777.7955535113465, 1859.367814942919, 2009.6884982827667, 8244.340452763765, 8891.510966896834, 9037.096290370959, 9269.21211697005, 9272.304577156716, 7690.384769218463, 8946.881639795025, 8970.461772293667, 8999.82000359994, 9006.95496522518, 2251.795289520107, 2267.2744721689064, 2358.151065616377, 2535.404180017694, 2550.3496608364885, 2517.6601158843505, 2534.771870531652, 2560.8207425480223, 2564.6281289213052, 2572.048342113421, 2524.899004039836, 2527.19129878439, 2550.1457011901034, 2558.539462896678, 2562.525932702447, 2259.621630805216, 2405.446747248125, 2511.623256511529, 2555.488902219545, 2559.4881023795315, 2197.230969160797, 2513.648089267504, 2521.3948652323493, 2522.041624182817, 2560.6543116679195, 9059.547022648907, 9126.81746365069, 9193.494357810318, 9200.309976751703, 9269.258459323239, 5533.723313834292, 5584.357798853143, 5597.720113994284, 5644.887102257973, 5711.428857114297, 3659.0, 3698.7041036716996, 3720.2559488102215, 3738.1962877981364, 3786.450964610116, 1041.387191335024, 1069.9144068474504, 1072.1155047086186, 1073.1736562846565, 1073.9355638661705, 11708.238964467368, 11797.52809887612, 12249.510019599295, 12280.263184208976, 12301.630951071393, 4952.47998960104, 4995.675281106716, 5050.898982020412, 5059.848204553869, 5156.74216289184, 10427.843582346271, 10444.42555659446, 10457.215708821717, 10479.266451348332, 10490.632827850988, 5538.75075621598, 5571.554275657938, 5653.575981801381, 5774.047282198474, 5786.797462088806, 4156.376543518496, 4631.907361852744, 5146.30524879144, 5195.844124676266, 5292.20616907467, 4202.054537728986, 4207.368894665825, 4215.704900656925, 4306.80619372129, 4329.848455304113, 1390.0686540018212, 1415.3843078260784, 1418.036020112152, 1418.3900922603173, 1424.950126745559, 965.6185806606492, 984.4487087231173, 984.5815528400401, 988.6885631026204, 1002.0480543483719, 6039.4262545058145, 6141.324454310023, 6165.907511387333, 6233.34549872266, 6325.841853953688, 460.56016504238374, 475.4888494868031, 475.5696095034, 480.0830413909416, 483.9008003359303, 4022.5374081980362, 4072.0, 4099.262132816122, 4102.671786257092, 4126.690498212646, 10952.0, 11163.27438716497, 11251.324920504796, 11278.774424511628, 11288.379139147426, 8886.4668119913, 10759.193060520493, 10779.02988731018, 10869.782604348027, 11023.503942322615, 8523.147685231428, 8661.696840610548, 8674.956625216833, 8684.0, 8685.218330350172, 5867.706614669335, 6082.60463069899, 6087.786927457518, 6132.2947860996555, 6294.339094395205, 9860.16188623975, 9930.900690992998, 9951.552180151766, 9997.050280223368, 10039.799204016024, 8453.492790432594, 10113.544890480092, 10344.793104137725, 10351.792964140826, 10550.683479495627, 7439.776806695808, 7593.924060759322, 7693.6537855795505, 7822.06135263772, 7848.136704962335, 8252.83494330098, 8486.872696909675, 8518.14818518168, 8556.358273129415, 8556.786080348042, 7442.96278518604, 7569.735059272899, 7590.1650818408825, 7680.308772210527, 7697.8845317319165, 7348.77953661391, 7409.703611855465, 7449.6275186241555, 7467.141278753013, 7570.507916985378, 6995.405390541861, 7044.506884518035, 7127.216006239206, 7141.750038748619, 7151.713931442892, 4929.679570827885, 4936.284238785284, 5055.393352797688, 5057.216131499624, 5132.640715150053, 4372.256716358163, 5032.647714659939, 5132.589392848488, 5149.304843846033, 5192.506711862367], "value": 4677.068737883757, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.9683983181765, 324.8586864713851, 342.1787709497206, 350.50928699820264, 351.24832857684544, 6935.999999999987, 6993.615351155684, 7031.8945215821805, 7158.248383919685, 7223.0, 7065.540739851906, 7129.857402851952, 7143.607101609409, 7163.212046674875, 7177.066981292438, 5225.137852254374, 5227.895442091156, 5228.372595288571, 5232.0, 5253.99999999999, 4415.51429342772, 5066.36670416198, 5232.4767523247565, 5242.318498595197, 5242.449542798008, 5147.124988751922, 5168.948310516903, 5178.637495375326, 5179.4561571035065, 5189.247559103927, 5055.65657013614, 5151.021305951876, 5183.326167598226, 5190.610704197182, 5214.5046220609365, 4400.955990440087, 4438.667099967515, 4438.977805110986, 4461.286194208943, 4465.754383508905, 6791.898121528181, 6829.180498340182, 6833.760818371333, 6843.828904277383, 6874.278200788895, 5949.9107513387335, 6052.394760523956, 6071.908921366183, 6073.817785466443, 6079.635221886657, 7515.361194298491, 7535.208803075653, 7536.057992750906, 7540.17058123606, 7580.507267027626, 4556.248219043887, 4803.231482962744, 4805.13507568641, 4810.759462026885, 4833.661643684944, 7792.688292468294, 7950.284474397275, 7967.004124484497, 7969.800754981114, 8019.157988411192, 4890.339804126397, 4893.070316639827, 4908.165611845923, 4913.091078150554, 4918.631102667314, 4976.850694479172, 4981.427135879348, 5003.774830132653, 5007.549320561167, 5022.347094877642, 5814.127880817911, 6002.0, 6013.308469525973, 6023.969880150571, 6027.216461860018, 7467.663955122032, 7522.059742532184, 7528.360089392353, 7544.547327160388, 7552.924470755332, 1682.3943380383298, 1721.1652348610914, 1723.2331612432597, 1725.6031112843866, 1729.8183690712547, 1013.0780989299702, 1057.7937302226146, 1072.7586293083993, 1073.7852429514128, 1095.9397233152094, 6008.386351936834, 6935.063766391472, 6968.407685346701, 7001.859962800715, 7037.1555413350725, 7696.6536505857375, 7721.729739459092, 7729.497582657109, 7756.991591093235, 7769.223077692185, 6295.18162638854, 6975.267596902354, 7012.964935175393, 7032.929670703227, 7049.436045116378, 3321.8339083045753, 4016.6987475938836, 4046.817893194813, 4078.9184216315507, 4087.795610219477, 8258.339332853357, 8280.792980175544, 8299.128591497927, 8310.168983101763, 8315.501069935703, 6988.0, 8179.304759095544, 8188.713395031145, 8205.0, 8208.958955205306, 7956.920430795618, 8281.503109813431, 8295.087540370676, 8321.126281740451, 8333.0, 7660.463767536219, 7870.881936770838, 7898.921010790048, 7914.129445761077, 7924.088729795917, 7734.342580880688, 7757.883631745642, 7762.107357653942, 7772.417068719756, 7776.883346749916, 8278.875816862632, 8282.50304981703, 8286.337093032422, 8292.212239837207, 8306.0, 4050.007748101734, 4858.82994095205, 4920.975395123001, 4924.990376972641, 4943.184374578154, 7588.886166707393, 7848.489848159851, 7851.685932562634, 7859.214078592095, 7868.685252589832, 7519.774406767806, 7559.886601700869, 7576.583287919218, 7585.658645361083, 7616.657250423634, 7552.584607846401, 7559.20628334017, 7575.545467271982, 7582.924170758442, 7600.695972161273, 7152.892706609301, 7299.197088320387, 7345.8898116527225, 7375.446841487017, 7419.0, 7549.396048316232, 7565.205653406533, 7570.318671319607, 7572.318491335806, 7618.276263754934, 7100.112485939258, 7213.0, 7448.143463501767, 7500.737474188377, 7532.171461139161], "value": 5489.344029057453, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.5791640848307, 753.9999999999993, 773.5242825662218, 773.8761798112299, 781.3944193250234, 12764.0, 15270.465533706323, 15611.453599124034, 15634.921825390886, 15637.609059773511, 14368.425262989467, 14402.27988600571, 14403.63990900228, 14408.991370604062, 14422.278886055681, 744.9478536502447, 901.5266984832982, 916.867054277131, 940.1679513630418, 940.6096469964956, 918.5177781664613, 929.7071422501924, 933.0, 933.883264591926, 936.8688383626263, 952.3428834104445, 976.9902300977005, 987.1757082835804, 989.6338354808731, 990.9306348555604, 951.0299494515556, 973.810107029126, 980.0444566547559, 991.6083147156869, 995.044757033249, 715.7172916697928, 739.0207974433897, 742.2466196810242, 742.8959945607619, 744.0253268218597, 14702.191379474125, 14785.482508112165, 15092.943493955427, 15213.011154274936, 15278.847211527966, 12872.29202393868, 12879.67800804978, 12990.935045324808, 13063.608091757167, 13199.208047517084, 7886.329661978739, 9562.90437095627, 10239.795204095877, 11231.663050108427, 11243.325400475916, 3323.8005719656658, 3465.5321531593163, 3596.892093237207, 3611.3860643690637, 3665.5784584772828, 74494.88257676193, 75309.61106750209, 86307.0, 88956.0, 90840.54579727125, 8235.95882020598, 9098.04470530598, 9651.806963860683, 9723.222142228604, 9893.455859927773, 21712.674309885366, 21927.67108493374, 21954.34136975893, 22106.778932210473, 22197.1121155152, 6792.694328755218, 7591.620418979029, 7617.200193979663, 7637.694492220249, 7677.769666910001, 4075.612816782401, 4169.583041695867, 4237.788110594458, 4245.766482843474, 4269.978650106729, 3777.9433308500393, 3821.44589034594, 3852.9036774080873, 3857.247836671822, 3926.6858651307825, 676.5264314979534, 691.6472598974459, 692.0864458914185, 694.9583025018516, 696.6481926627021, 600.8197540737849, 612.9938700613026, 613.0865011133379, 625.252822876658, 642.9839254018686, 8472.0, 8483.95758021206, 8498.490090594583, 8623.396362254582, 8690.478571285617, 605.5458406195354, 609.834700090235, 617.2716194889983, 630.5334052800895, 631.7094136697079, 3934.272159650474, 3936.9212615747524, 3947.921041579152, 4044.51465824103, 4229.6827737919775, 88594.67107993385, 90549.09450905406, 91033.1793364129, 97380.51309743548, 97622.0, 78870.60564697254, 79296.60351698204, 79966.0, 80385.59807201044, 80933.59533202296, 54816.17775733367, 72075.2792472079, 72593.6370318145, 73415.89876151862, 74424.0, 7607.961960190164, 8633.740987770378, 8794.076621954602, 8807.867881981647, 8833.072527384533, 44485.11029779322, 50495.74752126216, 51085.0, 51563.0, 52153.73923130512, 66040.0, 68968.6551567239, 70957.0, 71715.64142179256, 71881.0, 11072.280301780358, 11348.773024539298, 11354.772904542027, 11522.769544608893, 11554.364509952033, 11926.463309151282, 11956.46195921203, 12142.332171730286, 12184.329861857328, 12325.075619328407, 11161.460995935176, 11529.596464123715, 11638.0, 11774.3524106175, 11782.764344713229, 11157.442127893735, 11463.426828658367, 11606.24559403636, 11627.127965402799, 12306.630801075982, 11500.309981401142, 11516.021138203347, 11579.942100289445, 11782.234154779911, 12464.626061218178, 8215.917840821754, 8998.280137589109, 10052.64815731446, 10076.84884726715, 10346.172306215334, 9924.255680824112, 10165.237607179342, 10167.389956602627, 10171.796564068825, 10188.694339169837], "value": 7083.2672266556965, "unit": "score"}], "name": "dromaeo_css", "value": 7633.858814866208, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 117.0, 115.0, 117.0, 131.0, 114.0, 164.0, 152.0, 118.0], "value": 125.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 114.0, 173.0, 192.0, 113.0, 130.0, 142.0, 151.0, 199.0, 152.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 205.0, 194.0, 199.0, 194.0, 195.0, 235.0, 217.0, 205.0, 193.0], "value": 203.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 72.0, 144.0, 58.0, 56.0, 59.0, 68.0, 124.0, 56.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 132.0, 78.0, 83.0, 83.0, 118.0, 80.0, 79.0, 122.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 91.0, 88.0, 89.0, 86.0, 91.0, 97.0, 121.0, 85.0], "value": 92.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 97.0, 97.0, 132.0, 152.0, 95.0, 94.0, 95.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 147.0, 102.0, 139.0, 148.0, 118.0, 90.0, 87.0, 91.0, 89.0], "value": 113.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 76.0, 94.0, 81.0, 63.0, 64.0, 77.0, 63.0, 59.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 69.0, 66.0, 76.0, 74.0, 102.0, 63.0, 65.0, 65.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 87.0, 87.0, 104.0, 81.0, 80.0, 83.0, 81.0, 88.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 117.0, 146.0, 141.0, 130.0, 148.0, 137.0, 180.0, 147.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 166.0, 170.0, 168.0, 166.0, 168.0, 164.0, 160.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 69.0, 68.0, 71.0, 73.0, 96.0, 91.0, 69.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1568.7, "alertThreshold": 2.0}]} 06:19:37 INFO - Return code: 0 06:19:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:19:37 ERROR - # TBPL SUCCESS # 06:19:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:19:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:19:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:19:37 INFO - 2016-06-27 06:19:37.600 screenresolution[1692:11730] starting screenresolution argv=screenresolution get 06:19:37 INFO - 2016-06-27 06:19:37.603 screenresolution[1692:11730] Display 0: 1600x1200x32@60 06:19:37 INFO - 2016-06-27 06:19:37.609 screenresolution[1693:11733] starting screenresolution argv=screenresolution list 06:19:37 INFO - Available Modes on Display 0 06:19:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:19:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:19:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:19:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:19:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:19:37 INFO - Intel Iris: 06:19:37 INFO - Chipset Model: Intel Iris 06:19:37 INFO - Type: GPU 06:19:37 INFO - Bus: Built-In 06:19:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:19:37 INFO - Vendor: Intel (0x8086) 06:19:37 INFO - Device ID: 0x0a2e 06:19:37 INFO - Revision ID: 0x0009 06:19:37 INFO - Displays: 06:19:37 INFO - Display: 06:19:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:19:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:19:37 INFO - Display Serial Number: 1600x1200 60 06:19:37 INFO - Main Display: Yes 06:19:37 INFO - Mirror: Off 06:19:37 INFO - Online: Yes 06:19:37 INFO - Rotation: Supported 06:19:37 INFO - Return code: 0 06:19:37 INFO - Running post-action listener: _resource_record_post_action 06:19:37 INFO - Running post-run listener: _resource_record_post_run 06:19:38 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 32931328; Write bytes: 498454528; Read time: 326; Write time: 1601 06:19:38 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194810368; Write bytes: 187008512; Read time: 17544; Write time: 400 06:19:38 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 31096320; Write bytes: 301705728; Read time: 300; Write time: 1169 06:19:38 INFO - Running post-run listener: _upload_blobber_files 06:19:38 INFO - Blob upload gear active. 06:19:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:38 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 06:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:19:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:19:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:39 INFO - (blobuploader) - INFO - Done attempting. 06:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:40 INFO - (blobuploader) - INFO - Done attempting. 06:19:40 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:40 INFO - Return code: 0 06:19:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1e2a56cb5bf76ee7133d975bba04e375ae4373ddeedc97a00cfc7fe24c4de6a8a92540260eaa1eca29a8c85da877494352d422f28f404f9c5e05cc73798762a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc33ad4d91d9b2dabce2fb767eb72bfc20410ab68bb7d4d07a5f61b126e6493dcc22ac2ab675c2f12366a32c3886bc3e58c0b041b665a63d47fdfa7ed11533c3"} 06:19:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:40 INFO - Contents: 06:19:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1e2a56cb5bf76ee7133d975bba04e375ae4373ddeedc97a00cfc7fe24c4de6a8a92540260eaa1eca29a8c85da877494352d422f28f404f9c5e05cc73798762a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc33ad4d91d9b2dabce2fb767eb72bfc20410ab68bb7d4d07a5f61b126e6493dcc22ac2ab675c2f12366a32c3886bc3e58c0b041b665a63d47fdfa7ed11533c3"} 06:19:40 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:40 INFO - Copying logs to upload dir... 06:19:40 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.005347 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-06-27 06:19:40.971403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:40.975124) ========= 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.64QeC5eYUI/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.fcUauWfYYq/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1e2a56cb5bf76ee7133d975bba04e375ae4373ddeedc97a00cfc7fe24c4de6a8a92540260eaa1eca29a8c85da877494352d422f28f404f9c5e05cc73798762a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc33ad4d91d9b2dabce2fb767eb72bfc20410ab68bb7d4d07a5f61b126e6493dcc22ac2ab675c2f12366a32c3886bc3e58c0b041b665a63d47fdfa7ed11533c3"} build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1e2a56cb5bf76ee7133d975bba04e375ae4373ddeedc97a00cfc7fe24c4de6a8a92540260eaa1eca29a8c85da877494352d422f28f404f9c5e05cc73798762a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc33ad4d91d9b2dabce2fb767eb72bfc20410ab68bb7d4d07a5f61b126e6493dcc22ac2ab675c2f12366a32c3886bc3e58c0b041b665a63d47fdfa7ed11533c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:41.008561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:41.008885) ========= 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.64QeC5eYUI/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.fcUauWfYYq/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:41.058551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:19:41.059289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:19:41.060042) ========= ========= Total master_lag: 0.18 =========