builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0092 starttime: 1467741990.1 results: success (0) buildid: 20160705084922 builduid: f7e2721f1d984fbd80dcaa716c02b9e2 revision: 6ad50d4d6f7b3c96801a3ecd1afe5464705a0d87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.098316) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.098797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.099135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.123107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.123520) ========= 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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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-07-05 11:06:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-07-05 11:06:30 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.275315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.275982) ========= 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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.021224 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:30.326242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-05 11:06:30.326660) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6ad50d4d6f7b3c96801a3ecd1afe5464705a0d87 --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 6ad50d4d6f7b3c96801a3ecd1afe5464705a0d87 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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-07-05 11:06:30,402 truncating revision to first 12 chars 2016-07-05 11:06:30,402 Setting DEBUG logging. 2016-07-05 11:06:30,402 attempt 1/10 2016-07-05 11:06:30,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6ad50d4d6f7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 11:06:32,187 unpacking tar archive at: mozilla-beta-6ad50d4d6f7b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.061472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-05 11:06:32.411783) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:32.412256) ========= script_repo_revision: 6ad50d4d6f7b3c96801a3ecd1afe5464705a0d87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:32.412811) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:32.413198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:06:32.432184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-05 11:06:32.432835) ========= /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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:06:32 INFO - MultiFileLogger online at 20160705 11:06:32 in /builds/slave/test 11:06:32 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 11:06:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:32 INFO - {'append_to_log': False, 11:06:32 INFO - 'base_work_dir': '/builds/slave/test', 11:06:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:06:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:32 INFO - 'branch': 'Mozilla-Beta', 11:06:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:32 INFO - 'config_files': ('talos/mac_config.py',), 11:06:32 INFO - 'default_actions': ('clobber', 11:06:32 INFO - 'read-buildbot-config', 11:06:32 INFO - 'download-and-extract', 11:06:32 INFO - 'populate-webroot', 11:06:32 INFO - 'create-virtualenv', 11:06:32 INFO - 'install', 11:06:32 INFO - 'run-tests'), 11:06:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:32 INFO - 'download_minidump_stackwalk': True, 11:06:32 INFO - 'download_symbols': 'ondemand', 11:06:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:32 INFO - 'installer_path': 'installer.exe', 11:06:32 INFO - 'log_level': 'info', 11:06:32 INFO - 'log_name': 'talos', 11:06:32 INFO - 'log_to_console': True, 11:06:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:06:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:06:32 INFO - 'opt_config_files': (), 11:06:32 INFO - 'pip_index': False, 11:06:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:06:32 INFO - 'cmd': ('bash', 11:06:32 INFO - '-c', 11:06:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:06:32 INFO - 'enabled': True, 11:06:32 INFO - 'halt_on_failure': False, 11:06:32 INFO - 'name': 'check_screen_resolution'},), 11:06:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:06:32 INFO - 'cmd': ('bash', 11:06:32 INFO - '-c', 11:06:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:06:32 INFO - 'enabled': True, 11:06:32 INFO - 'halt_on_failure': False, 11:06:32 INFO - 'name': 'check_screen_resolution'},), 11:06:32 INFO - 'run_cmd_checks_enabled': True, 11:06:32 INFO - 'sps_profile': False, 11:06:32 INFO - 'sps_profile_interval': 0, 11:06:32 INFO - 'suite': 'dromaeojs-e10s', 11:06:32 INFO - 'system_bits': '32', 11:06:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:32 INFO - 'title': 't-yosemite-r7-0092', 11:06:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:32 INFO - 'use_talos_json': True, 11:06:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:32 INFO - 'work_dir': 'build'} 11:06:32 INFO - ##### 11:06:32 INFO - ##### Running clobber step. 11:06:32 INFO - ##### 11:06:32 INFO - Running pre-action listener: _resource_record_pre_action 11:06:32 INFO - Running main action method: clobber 11:06:32 INFO - rmtree: /builds/slave/test/build 11:06:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:34 INFO - Running post-action listener: _resource_record_post_action 11:06:34 INFO - ##### 11:06:34 INFO - ##### Running read-buildbot-config step. 11:06:34 INFO - ##### 11:06:34 INFO - Running pre-action listener: _resource_record_pre_action 11:06:34 INFO - Running main action method: read_buildbot_config 11:06:34 INFO - Using buildbot properties: 11:06:34 INFO - { 11:06:34 INFO - "project": "", 11:06:34 INFO - "product": "firefox", 11:06:34 INFO - "script_repo_revision": "production", 11:06:34 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:06:34 INFO - "repository": "", 11:06:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:06:34 INFO - "buildid": "20160705084922", 11:06:34 INFO - "pgo_build": "False", 11:06:34 INFO - "basedir": "/builds/slave/test", 11:06:34 INFO - "buildnumber": 38, 11:06:34 INFO - "slavename": "t-yosemite-r7-0092", 11:06:34 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:06:34 INFO - "platform": "yosemite_r7", 11:06:34 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:06:34 INFO - "branch": "mozilla-beta", 11:06:34 INFO - "repo_path": "releases/mozilla-beta", 11:06:34 INFO - "revision": "6ad50d4d6f7b3c96801a3ecd1afe5464705a0d87", 11:06:34 INFO - "stage_platform": "macosx64", 11:06:34 INFO - "builduid": "f7e2721f1d984fbd80dcaa716c02b9e2", 11:06:34 INFO - "slavebuilddir": "test" 11:06:34 INFO - } 11:06:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 11:06:34 INFO - Running post-action listener: _resource_record_post_action 11:06:34 INFO - ##### 11:06:34 INFO - ##### Running download-and-extract step. 11:06:34 INFO - ##### 11:06:34 INFO - Running pre-action listener: _resource_record_pre_action 11:06:34 INFO - Running main action method: download_and_extract 11:06:34 INFO - mkdir: /builds/slave/test/build/tests 11:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:06:34 INFO - https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:35 INFO - Downloaded 1165 bytes. 11:06:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:06:35 INFO - Using the following test package requirements: 11:06:35 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:06:35 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:06:35 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 11:06:35 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:06:35 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 11:06:35 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:06:35 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:06:35 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 11:06:35 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:06:35 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:06:35 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 11:06:35 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:06:35 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 11:06:35 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:06:35 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 11:06:35 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:06:35 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 11:06:35 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 11:06:35 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')]} 11:06:35 INFO - https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:39 INFO - Downloaded 18351444 bytes. 11:06:39 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'] 11:06:39 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 11:06:42 INFO - Return code: 0 11:06:42 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 11:06:42 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')]} 11:06:42 INFO - https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:06:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:06:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:06:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:44 INFO - Downloaded 18351444 bytes. 11:06:44 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'] 11:06:44 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 11:06:47 INFO - Return code: 0 11:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:06:47 INFO - https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:48 INFO - Downloaded 10840145 bytes. 11:06:48 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'] 11:06:48 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 11:06:48 INFO - Return code: 0 11:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:06:48 INFO - https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 11:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 11:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOjKzcLgShqRataDmTP29w/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 11:06:51 INFO - Downloaded 86190093 bytes. 11:06:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:06:51 INFO - mkdir: /builds/slave/test/properties 11:06:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:51 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:51 INFO - Contents: 11:06:51 INFO - build_url:https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:06:51 INFO - Running post-action listener: _resource_record_post_action 11:06:51 INFO - Running post-action listener: set_extra_try_arguments 11:06:51 INFO - ##### 11:06:51 INFO - ##### Running populate-webroot step. 11:06:51 INFO - ##### 11:06:51 INFO - Running pre-action listener: _resource_record_pre_action 11:06:51 INFO - Running main action method: populate_webroot 11:06:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:51 INFO - '--tppagecycles', 11:06:51 INFO - '7'], 11:06:51 INFO - 'tests': ['tsvgm']}}, 11:06:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['damp', 'tps']}, 11:06:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'tests': ['damp', 'tps']}, 11:06:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['dromaeo_dom']}, 11:06:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['a11yr', 11:06:51 INFO - 'ts_paint', 11:06:51 INFO - 'tpaint', 11:06:51 INFO - 'sessionrestore', 11:06:51 INFO - 'sessionrestore_no_auto_restore', 11:06:51 INFO - 'tabpaint']}, 11:06:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:51 INFO - 'ts_paint', 11:06:51 INFO - 'tpaint', 11:06:51 INFO - 'sessionrestore', 11:06:51 INFO - 'sessionrestore_no_auto_restore', 11:06:51 INFO - 'tabpaint']}, 11:06:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:51 INFO - 'ts_paint', 11:06:51 INFO - 'tpaint', 11:06:51 INFO - 'sessionrestore', 11:06:51 INFO - 'sessionrestore_no_auto_restore', 11:06:51 INFO - 'tabpaint']}, 11:06:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:51 INFO - 'ts_paint', 11:06:51 INFO - 'tpaint', 11:06:51 INFO - 'sessionrestore', 11:06:51 INFO - 'sessionrestore_no_auto_restore', 11:06:51 INFO - 'tabpaint']}, 11:06:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['a11yr', 11:06:51 INFO - 'ts_paint', 11:06:51 INFO - 'tpaint', 11:06:51 INFO - 'sessionrestore', 11:06:51 INFO - 'sessionrestore_no_auto_restore', 11:06:51 INFO - 'tabpaint']}, 11:06:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['a11yr', 11:06:51 INFO - 'ts_paint', 11:06:51 INFO - 'tpaint', 11:06:51 INFO - 'sessionrestore', 11:06:51 INFO - 'sessionrestore_no_auto_restore', 11:06:51 INFO - 'tabpaint']}, 11:06:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['tsvgx', 11:06:51 INFO - 'tsvgr_opacity', 11:06:51 INFO - 'tart', 11:06:51 INFO - 'tscrollx', 11:06:51 INFO - 'cart']}, 11:06:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:51 INFO - 'tsvgr_opacity', 11:06:51 INFO - 'tart', 11:06:51 INFO - 'tscrollx', 11:06:51 INFO - 'cart']}, 11:06:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'talos_options': ['--disable-e10s'], 11:06:51 INFO - 'tests': ['tp5o']}, 11:06:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'tests': ['tp5o']}, 11:06:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'talos_options': ['--disable-e10s', 11:06:51 INFO - '--xperf_path', 11:06:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:51 INFO - 'tests': ['tp5n']}, 11:06:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:51 INFO - 'talos_options': ['--xperf_path', 11:06:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:51 INFO - 'tests': ['tp5n']}}, 11:06:51 INFO - 'talos.zip': {'path': '', 11:06:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:51 INFO - Running post-action listener: _resource_record_post_action 11:06:51 INFO - ##### 11:06:51 INFO - ##### Running create-virtualenv step. 11:06:51 INFO - ##### 11:06:51 INFO - Running pre-action listener: _resource_record_pre_action 11:06:51 INFO - Running main action method: create_virtualenv 11:06:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:51 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 11:06:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:52 INFO - Using real prefix '/tools/python27' 11:06:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:55 INFO - Installing pip.................done. 11:06:55 INFO - Return code: 0 11:06:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:06:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:06:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:55 INFO - 'HOME': '/Users/cltbld', 11:06:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:55 INFO - 'LOGNAME': 'cltbld', 11:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:55 INFO - 'MOZ_NO_REMOTE': '1', 11:06:55 INFO - 'NO_EM_RESTART': '1', 11:06:55 INFO - 'PAGER': '/bin/cat', 11:06:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:55 INFO - 'PWD': '/builds/slave/test', 11:06:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:55 INFO - 'SHELL': '/bin/bash', 11:06:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:06:55 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:06:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:55 INFO - 'USER': 'cltbld', 11:06:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:55 INFO - 'XPC_FLAGS': '0x0', 11:06:55 INFO - 'XPC_SERVICE_NAME': '0', 11:06:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:56 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 11:06:56 INFO - Cleaning up... 11:06:56 INFO - Return code: 0 11:06:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:06:56 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')]} 11:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:56 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')]} 11:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:56 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 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:06:56 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 11:06:56 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 11:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:56 INFO - 'HOME': '/Users/cltbld', 11:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:56 INFO - 'LOGNAME': 'cltbld', 11:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:56 INFO - 'MOZ_NO_REMOTE': '1', 11:06:56 INFO - 'NO_EM_RESTART': '1', 11:06:56 INFO - 'PAGER': '/bin/cat', 11:06:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:56 INFO - 'PWD': '/builds/slave/test', 11:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:56 INFO - 'SHELL': '/bin/bash', 11:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:06:56 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:56 INFO - 'USER': 'cltbld', 11:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:56 INFO - 'XPC_FLAGS': '0x0', 11:06:56 INFO - 'XPC_SERVICE_NAME': '0', 11:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:56 INFO - Downloading/unpacking psutil>=0.7.1 11:06:56 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 11:06:56 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 11:06:56 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 11:06:56 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 11:06:56 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 11:06:56 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 11:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:58 INFO - Installing collected packages: psutil 11:06:58 INFO - Running setup.py install for psutil 11:06:59 INFO - building 'psutil._psutil_osx' extension 11:06:59 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 11:06:59 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 11:06:59 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 11:06:59 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 11:06:59 INFO - building 'psutil._psutil_posix' extension 11:06:59 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 11:06:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:06:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:06:59 INFO - ^ 11:06:59 INFO - 1 warning generated. 11:06:59 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 11:06:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:59 INFO - Successfully installed psutil 11:06:59 INFO - Cleaning up... 11:06:59 INFO - Return code: 0 11:06:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:06:59 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')]} 11:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:59 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')]} 11:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:59 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 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:06:59 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 11:06:59 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 11:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:59 INFO - 'HOME': '/Users/cltbld', 11:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:59 INFO - 'LOGNAME': 'cltbld', 11:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:59 INFO - 'MOZ_NO_REMOTE': '1', 11:06:59 INFO - 'NO_EM_RESTART': '1', 11:06:59 INFO - 'PAGER': '/bin/cat', 11:06:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:59 INFO - 'PWD': '/builds/slave/test', 11:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:59 INFO - 'SHELL': '/bin/bash', 11:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:06:59 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:59 INFO - 'USER': 'cltbld', 11:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:59 INFO - 'XPC_FLAGS': '0x0', 11:06:59 INFO - 'XPC_SERVICE_NAME': '0', 11:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07:00 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 11:07:00 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 11:07:00 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 11:07:00 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 11:07:00 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 11:07:00 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 11:07:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:07:02 INFO - Installing collected packages: mozsystemmonitor 11:07:02 INFO - Running setup.py install for mozsystemmonitor 11:07:02 INFO - Successfully installed mozsystemmonitor 11:07:02 INFO - Cleaning up... 11:07:02 INFO - Return code: 0 11:07:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:02 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 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:07:02 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 11:07:02 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 11:07:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:07:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:07:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:07:02 INFO - 'HOME': '/Users/cltbld', 11:07:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:07:02 INFO - 'LOGNAME': 'cltbld', 11:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:02 INFO - 'MOZ_NO_REMOTE': '1', 11:07:02 INFO - 'NO_EM_RESTART': '1', 11:07:02 INFO - 'PAGER': '/bin/cat', 11:07:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:02 INFO - 'PWD': '/builds/slave/test', 11:07:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:07:02 INFO - 'SHELL': '/bin/bash', 11:07:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:07:02 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:07:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:07:02 INFO - 'USER': 'cltbld', 11:07:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:07:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:02 INFO - 'XPC_FLAGS': '0x0', 11:07:02 INFO - 'XPC_SERVICE_NAME': '0', 11:07:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:03 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 11:07:03 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 11:07:03 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 11:07:03 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 11:07:03 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 11:07:03 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 11:07:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:05 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 11:07:05 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 11:07:05 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 11:07:05 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 11:07:05 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 11:07:05 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 11:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:06 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 11:07:06 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 11:07:06 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 11:07:06 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 11:07:06 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 11:07:06 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 11:07:06 INFO - Downloading docopt-0.6.1.tar.gz 11:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:06 INFO - Running setup.py install for blobuploader 11:07:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:07 INFO - Running setup.py install for requests 11:07:07 INFO - Running setup.py install for docopt 11:07:07 INFO - Successfully installed blobuploader requests docopt 11:07:07 INFO - Cleaning up... 11:07:07 INFO - Return code: 0 11:07:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:07 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')]} 11:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:07 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')]} 11:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:07 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 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:07:07 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 11:07:07 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 11:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:07:07 INFO - 'HOME': '/Users/cltbld', 11:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:07:07 INFO - 'LOGNAME': 'cltbld', 11:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:07 INFO - 'MOZ_NO_REMOTE': '1', 11:07:07 INFO - 'NO_EM_RESTART': '1', 11:07:07 INFO - 'PAGER': '/bin/cat', 11:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:07 INFO - 'PWD': '/builds/slave/test', 11:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:07:07 INFO - 'SHELL': '/bin/bash', 11:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:07:07 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:07:07 INFO - 'USER': 'cltbld', 11:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:07 INFO - 'XPC_FLAGS': '0x0', 11:07:07 INFO - 'XPC_SERVICE_NAME': '0', 11:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-FEzw4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-mQLjNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-LOl1wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-UiwCwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-g3A9nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-1OuP0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-ue86tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-WRQ3Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-KqiEPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-dnq5sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-RJoPHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-KtQ9hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-8BtSWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-f0pBvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-xh3oDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-y49Ftf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-YfPA9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:09 INFO - Running setup.py install for manifestparser 11:07:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:09 INFO - Running setup.py install for mozcrash 11:07:10 INFO - Running setup.py install for mozdebug 11:07:10 INFO - Running setup.py install for mozdevice 11:07:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:10 INFO - Running setup.py install for mozfile 11:07:10 INFO - Running setup.py install for mozhttpd 11:07:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:10 INFO - Running setup.py install for mozinfo 11:07:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:10 INFO - Running setup.py install for mozInstall 11:07:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Running setup.py install for mozleak 11:07:11 INFO - Running setup.py install for mozlog 11:07:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Running setup.py install for moznetwork 11:07:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Running setup.py install for mozprocess 11:07:11 INFO - Running setup.py install for mozprofile 11:07:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Running setup.py install for mozrunner 11:07:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:11 INFO - Running setup.py install for mozscreenshot 11:07:12 INFO - Running setup.py install for moztest 11:07:12 INFO - Running setup.py install for mozversion 11:07:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:12 INFO - Cleaning up... 11:07:12 INFO - Return code: 0 11:07:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:12 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')]} 11:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:12 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')]} 11:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:12 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 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:07:12 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 11:07:12 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 11:07:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:07:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:07:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:07:12 INFO - 'HOME': '/Users/cltbld', 11:07:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:07:12 INFO - 'LOGNAME': 'cltbld', 11:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:12 INFO - 'MOZ_NO_REMOTE': '1', 11:07:12 INFO - 'NO_EM_RESTART': '1', 11:07:12 INFO - 'PAGER': '/bin/cat', 11:07:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:12 INFO - 'PWD': '/builds/slave/test', 11:07:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:07:12 INFO - 'SHELL': '/bin/bash', 11:07:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:07:12 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:07:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:07:12 INFO - 'USER': 'cltbld', 11:07:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:07:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:12 INFO - 'XPC_FLAGS': '0x0', 11:07:12 INFO - 'XPC_SERVICE_NAME': '0', 11:07:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-wsbg4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:12 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)) 11:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-S3Lu8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:12 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)) 11:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-wCO1BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-4Wp_ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-vKP83F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-NW9hoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-6KYOao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-4ZLWxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-JwVVIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-AvJTp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-mMxKMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-PFhjHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:13 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)) 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:14 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-LApleH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:14 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)) 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:14 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-irsL42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:14 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)) 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:14 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-lA2XSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:14 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)) 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:14 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-04gqW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:14 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)) 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:14 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-XyDYX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:14 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)) 11:07:14 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)) 11:07:14 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)) 11:07:14 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)) 11:07:14 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)) 11:07:14 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)) 11:07:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:16 INFO - Downloading blessings-1.6.tar.gz 11:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:17 INFO - Installing collected packages: blessings 11:07:17 INFO - Running setup.py install for blessings 11:07:17 INFO - Successfully installed blessings 11:07:17 INFO - Cleaning up... 11:07:17 INFO - Return code: 0 11:07:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:17 INFO - Reading from file tmpfile_stdout 11:07:17 INFO - Current package versions: 11:07:17 INFO - blessings == 1.6 11:07:17 INFO - blobuploader == 1.2.4 11:07:17 INFO - docopt == 0.6.1 11:07:17 INFO - manifestparser == 1.1 11:07:17 INFO - mozInstall == 1.12 11:07:17 INFO - mozcrash == 0.17 11:07:17 INFO - mozdebug == 0.1 11:07:17 INFO - mozdevice == 0.48 11:07:17 INFO - mozfile == 1.2 11:07:17 INFO - mozhttpd == 0.7 11:07:17 INFO - mozinfo == 0.9 11:07:17 INFO - mozleak == 0.1 11:07:17 INFO - mozlog == 3.1 11:07:17 INFO - moznetwork == 0.27 11:07:17 INFO - mozprocess == 0.22 11:07:17 INFO - mozprofile == 0.28 11:07:17 INFO - mozrunner == 6.11 11:07:17 INFO - mozscreenshot == 0.1 11:07:17 INFO - mozsystemmonitor == 0.0 11:07:17 INFO - moztest == 0.7 11:07:17 INFO - mozversion == 1.4 11:07:17 INFO - psutil == 3.1.1 11:07:17 INFO - requests == 1.2.3 11:07:17 INFO - wsgiref == 0.1.2 11:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:17 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 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:07:17 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 11:07:17 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 11:07:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:07:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:07:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:07:17 INFO - 'HOME': '/Users/cltbld', 11:07:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:07:17 INFO - 'LOGNAME': 'cltbld', 11:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:17 INFO - 'MOZ_NO_REMOTE': '1', 11:07:17 INFO - 'NO_EM_RESTART': '1', 11:07:17 INFO - 'PAGER': '/bin/cat', 11:07:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:17 INFO - 'PWD': '/builds/slave/test', 11:07:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:07:17 INFO - 'SHELL': '/bin/bash', 11:07:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:07:17 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:07:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:07:17 INFO - 'USER': 'cltbld', 11:07:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:07:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:17 INFO - 'XPC_FLAGS': '0x0', 11:07:17 INFO - 'XPC_SERVICE_NAME': '0', 11:07:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 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)) 11:07:17 INFO - Cleaning up... 11:07:17 INFO - Return code: 0 11:07:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:07:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:07:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:07:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:07:17 INFO - 'HOME': '/Users/cltbld', 11:07:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:07:17 INFO - 'LOGNAME': 'cltbld', 11:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:17 INFO - 'MOZ_NO_REMOTE': '1', 11:07:17 INFO - 'NO_EM_RESTART': '1', 11:07:17 INFO - 'PAGER': '/bin/cat', 11:07:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:17 INFO - 'PWD': '/builds/slave/test', 11:07:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:07:17 INFO - 'SHELL': '/bin/bash', 11:07:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:07:17 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:07:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:07:17 INFO - 'USER': 'cltbld', 11:07:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:07:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:17 INFO - 'XPC_FLAGS': '0x0', 11:07:17 INFO - 'XPC_SERVICE_NAME': '0', 11:07:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:18 INFO - Downloading/unpacking jsonschema 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:20 INFO - Downloading/unpacking functools32 (from jsonschema) 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:20 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:21 INFO - warning: no files found matching '*.txt' 11:07:21 INFO - no previously-included directories found matching 'build' 11:07:21 INFO - no previously-included directories found matching 'dist' 11:07:21 INFO - no previously-included directories found matching '.git*' 11:07:21 INFO - Installing collected packages: jsonschema, functools32 11:07:21 INFO - Running setup.py install for functools32 11:07:21 INFO - warning: no files found matching '*.txt' 11:07:21 INFO - no previously-included directories found matching 'build' 11:07:21 INFO - no previously-included directories found matching 'dist' 11:07:21 INFO - no previously-included directories found matching '.git*' 11:07:21 INFO - Successfully installed jsonschema functools32 11:07:21 INFO - Cleaning up... 11:07:21 INFO - Return code: 0 11:07:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10850ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10851e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6c1cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, '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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 11:07: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', 'flake8'] in /builds/slave/test/build 11:07: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 flake8 11:07:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:07:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:07:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:07:21 INFO - 'HOME': '/Users/cltbld', 11:07:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:07:21 INFO - 'LOGNAME': 'cltbld', 11:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:21 INFO - 'MOZ_NO_REMOTE': '1', 11:07:21 INFO - 'NO_EM_RESTART': '1', 11:07:21 INFO - 'PAGER': '/bin/cat', 11:07:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:21 INFO - 'PWD': '/builds/slave/test', 11:07:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:07:21 INFO - 'SHELL': '/bin/bash', 11:07:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:07:21 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:07:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:07:21 INFO - 'USER': 'cltbld', 11:07:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:07:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:21 INFO - 'XPC_FLAGS': '0x0', 11:07:21 INFO - 'XPC_SERVICE_NAME': '0', 11:07:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:21 INFO - Downloading/unpacking flake8 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:25 INFO - no previously-included directories found matching 'docs/_build' 11:07:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:25 INFO - Running setup.py install for pep8 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:25 INFO - no previously-included directories found matching 'docs/_build' 11:07:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:25 INFO - Cleaning up... 11:07:25 INFO - Return code: 0 11:07:25 INFO - Running post-action listener: _resource_record_post_action 11:07:25 INFO - Running post-action listener: _start_resource_monitoring 11:07:25 INFO - Starting resource monitoring. 11:07:25 INFO - ##### 11:07:25 INFO - ##### Running install step. 11:07:25 INFO - ##### 11:07:25 INFO - Running pre-action listener: _resource_record_pre_action 11:07:25 INFO - Running main action method: install 11:07:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:26 INFO - Reading from file tmpfile_stdout 11:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:26 INFO - Reading from file tmpfile_stdout 11:07:26 INFO - Output received: 11:07:26 INFO - Usage: mozinstall [options] installer 11:07:26 INFO - Options: 11:07:26 INFO - -h, --help show this help message and exit 11:07:26 INFO - -d DEST, --destination=DEST 11:07:26 INFO - Directory to install application into. [default: 11:07:26 INFO - "/builds/slave/test"] 11:07:26 INFO - --app=APP Application being installed. [default: firefox] 11:07:26 INFO - mkdir: /builds/slave/test/build/application 11:07:26 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'] 11:07:26 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 11:07:48 INFO - Reading from file tmpfile_stdout 11:07:48 INFO - Output received: 11:07:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:07:48 INFO - Running post-action listener: _resource_record_post_action 11:07:48 INFO - ##### 11:07:48 INFO - ##### Running run-tests step. 11:07:48 INFO - ##### 11:07:48 INFO - Running pre-action listener: _resource_record_pre_action 11:07:48 INFO - Running main action method: run_tests 11:07:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:07:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:07:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:07:48 INFO - 2016-07-05 11:07:48.279 screenresolution[1926:18674] starting screenresolution argv=screenresolution get 11:07:48 INFO - 2016-07-05 11:07:48.282 screenresolution[1926:18674] Display 0: 1600x1200x32@60 11:07:48 INFO - 2016-07-05 11:07:48.287 screenresolution[1927:18676] starting screenresolution argv=screenresolution list 11:07:48 INFO - Available Modes on Display 0 11:07:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:07:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:07:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:07:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:07:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:07:48 INFO - Intel Iris: 11:07:48 INFO - Chipset Model: Intel Iris 11:07:48 INFO - Type: GPU 11:07:48 INFO - Bus: Built-In 11:07:48 INFO - VRAM (Dynamic, Max): 1536 MB 11:07:48 INFO - Vendor: Intel (0x8086) 11:07:48 INFO - Device ID: 0x0a2e 11:07:48 INFO - Revision ID: 0x0009 11:07:48 INFO - Displays: 11:07:48 INFO - Display: 11:07:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:07:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:07:48 INFO - Display Serial Number: 1600x1200 60 11:07:48 INFO - Main Display: Yes 11:07:48 INFO - Mirror: Off 11:07:48 INFO - Online: Yes 11:07:48 INFO - Rotation: Supported 11:07:48 INFO - Return code: 0 11:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:48 INFO - Python 2.7.3 11:07:48 INFO - Return code: 0 11:07:48 INFO - grabbing minidump binary from tooltool 11:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:07:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083ade00>, '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 0x108216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083a8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:07:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:07:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:48 INFO - Return code: 0 11:07:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:07:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:07:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:07:49 INFO - Return code: 0 11:07:49 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/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 11:07:49 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/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0092 --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 11:07:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dn6OQme2Gy/Render', 11:07:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:07:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:07:49 INFO - 'HOME': '/Users/cltbld', 11:07:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:07:49 INFO - 'LOGNAME': 'cltbld', 11:07:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:49 INFO - 'MOZ_NO_REMOTE': '1', 11:07:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:49 INFO - 'NO_EM_RESTART': '1', 11:07:49 INFO - 'PAGER': '/bin/cat', 11:07:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:49 INFO - 'PWD': '/builds/slave/test', 11:07:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:07:49 INFO - 'SHELL': '/bin/bash', 11:07:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5DCSaqiB4/Listeners', 11:07:49 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 11:07:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:07:49 INFO - 'USER': 'cltbld', 11:07:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:07:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:49 INFO - 'XPC_FLAGS': '0x0', 11:07:49 INFO - 'XPC_SERVICE_NAME': '0', 11:07:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:07:49 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/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 11:07:49 INFO - mozversion application_buildid: 20160705084922 11:07:49 INFO - mozversion application_changeset: 6ad50d4d6f7b3c96801a3ecd1afe5464705a0d87 11:07:49 INFO - mozversion application_display_name: Firefox 11:07:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:49 INFO - mozversion application_name: Firefox 11:07:49 INFO - mozversion application_remotingname: firefox 11:07:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:07:49 INFO - mozversion application_vendor: Mozilla 11:07:49 INFO - mozversion application_version: 48.0 11:07:49 INFO - mozversion platform_buildid: 20160705084922 11:07:49 INFO - mozversion platform_changeset: 6ad50d4d6f7b3c96801a3ecd1afe5464705a0d87 11:07:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:07:49 INFO - mozversion platform_version: 48.0 11:07:49 INFO - using testdate: 1467742069 11:07:49 INFO - actual date: 1467742069 11:07:49 INFO - starting webserver on 'localhost:57334' 11:07:49 INFO - SUITE-START | Running 2 tests 11:07:49 INFO - TEST-START | dromaeo_css 11:07:49 INFO - operating with platform_type : mac_ 11:07:49 INFO - Initialising browser for dromaeo_css test... 11:07:49 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpUN0svK/profile http://localhost:57334/getInfo.html) 11:07:52 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 11:07:52 INFO - PROCESS | 1945 | colorDepth:24 11:07:52 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 11:07:52 INFO - PROCESS | 1945 | __metrics 11:07:52 ERROR - PROCESS | 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:07:53 INFO - TEST-INFO | 1945: exit 0 11:07:53 INFO - Browser initialized. 11:07:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:53 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpUN0svK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:05 INFO - PROCESS | 1949 | RSS: Main: 171081728 11:08:05 INFO - PROCESS | 1949 | 11:08:54 INFO - PROCESS | 1949 | 1467742134623 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] 11:11:04 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57334/tests/dromaeo/cssquery-ext.html) 11:11:06 INFO - PROCESS | 1949 | RSS: Main: 181706752 11:11:06 INFO - PROCESS | 1949 | 11:14:08 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-ext.html (next: http://localhost:57334/tests/dromaeo/cssquery-jquery.html) 11:14:08 INFO - PROCESS | 1949 | RSS: Main: 192516096 11:14:08 INFO - PROCESS | 1949 | 11:17:10 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57334/tests/dromaeo/cssquery-mootools.html) 11:17:11 INFO - PROCESS | 1949 | RSS: Main: 194625536 11:17:11 INFO - PROCESS | 1949 | 11:20:12 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57334/tests/dromaeo/cssquery-prototype.html) 11:20:13 INFO - PROCESS | 1949 | RSS: Main: 198389760 11:20:13 INFO - PROCESS | 1949 | 11:23:15 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57334/tests/dromaeo/cssquery-yui.html) 11:23:16 INFO - PROCESS | 1949 | RSS: Main: 197574656 11:23:16 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-yui.html (next: http://localhost:57334/tests/dromaeo/cssquery-dojo.html) 11:26:18 INFO - PROCESS | 1949 | RSS: Main: 202407936 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | __start_tp_report 11:26:18 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 11:26:18 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 11:26:18 INFO - PROCESS | 1949 | |i|pagename|runs| 11:26:18 INFO - PROCESS | 1949 | |0;dojo.html;3367.107716455139;3650.5071815304927;3678.6689197972187;3693.372126738454;3700.463432802242;5191.948080519193;5758.617931696394;6013.789517366893;6092.543059270556;6097.878042439149;4789.736564488951;5858.297004359483;5963.880722385549;6053.152558641794;6143.293521245058;5381.165919282517;5400.621956463049;5435.0488664483555;5461;5480.862978425552;5357.517823395893;5386.703731294777;5450.264214331074;5503.174523821439;5576.721163941807;4636.4899861015265;5308.230306605559;5489.313835770528;5519.282493275869;5544.16837474378;4033.1731994941115;4574.1080489304595;5464.754086066137;5512.283403157604;5526.944730552683;5269.789208431658;5320.76056577455;5331.653442526263;5436.537894278991;5470.17947307903;5404.135338345845;5733.451967968666;5886.852828679274;5932.080527518242;5949.315828679714;6309.242890853081;6340.968295158541;6353.174087368659;6374.235091788969;6382;6257.124002639634;6364.904526432061;6372.2671892732005;6402.294313679488;6430.93569064308;6150.8769824603705;6164.476019538344;6170;6194.380561943814;6197.132401463754;6607.702653380609;6620.768273110514;6642.83392915181;6653.767118150841;6674.632895190811;6209.844753881099;6224.564280500322;6237.064440333987;6252.749890004349;6296.590721603081;6380.298167201604;6426.678666066771;6449.774257901045;6468.676566171766;6469.223693156851;6316.368363163647;6318.273398559132;6323.620582765049;6327.525435592257;6352.523560732963;6212.596181248205;6266.467350275278;6286.654234017082;6322.968385158045;6347.587406818634;5078.187490001582;5110.591152707774;5125.359330083739;5132.43543210254;5148.33071700684;3862.478565393692;4558.791920141165;4633.189191891405;4638.675292729544;4650.023495066006;5914.615549989237;6119.350229749466;6161.876762464725;6228.22147231596;6289.339619339995;6359.20509936258;6449.516286278548;6466.935330646727;6490.318516555693;6498.122753428227;4889.608831293488;6106.542009349228;6283.497320214372;6308.621482711052;6311.274203466568;5619.606627536115;5659.349174844946;5668.064769313017;5710.486056254957;5732;6725.730970761213;6756.69594868242;6768.83077923046;6769.255381907986;6783.118194634863;6283.088952102011;6390.712417941111;6469.385408386384;6476.740930362921;6481.546291759531;6638.137042184485;6727.327267273234;6782.93217067823;6782.966085169543;6800.6599670017295;5927.347991720821;6369.267534233437;6387.552871298964;6392.904106438315;6402.935970640234;6342.429181373698;6386.616802991835;6432.195975503062;6461.870762584816;6500.674966251574;6262.561620686691;6317.747290108528;6327.493800495858;6329.367063293634;6350.587211831216;5659.434056594308;6192.2569291683485;6265.248170219421;6284.685765711788;6304.968475157595;5846.684495988368;6111.04482360895;6159.876802464015;6165.938340616716;6233.625982441068;5678.488935995781;6297.905531416941;6298.212723409574;6304.6847657617855;6304.747810087545;5059.848204553869;6225.035119556476;6228.4705800005695;6272.184616000073;6276.811695649138 11:26:18 INFO - PROCESS | 1949 | |1;ext.html;531.9734013299335;543.2584522127295;544.0913674164145;588.6879953624575;590.5629833922899;29433.852830735843;39960.40059399104;39976.600233997655;39985.200295994066;40035;35245.47131793025;43133.7843310783;43996.780016099874;44006;44166.77916610413;9753.609855605784;9843.310968232227;9860.556274967643;9957.203423726085;9996.600135994551;9843.655472058479;9851.113399794018;9879.703608891745;9888.307818452711;9950.800983980316;9856.802863942718;9860.70417887461;9907.554160062778;9975.102240798327;10001.749956251115;9848.50757462124;9952.850707239397;9954.601815927354;9975.800483990351;9996.650117245934;9805.068518490803;9814.46020468874;9851.704448866545;9935.801283974351;9986.400815951067;39798.801005995076;39936.801895943165;40640.39039414411;40873.18253634911;41001.79499102486;2818.788590855694;2872.310645445099;3364.192593777476;3759.793211373373;3868.400397938296;23684.934177962034;27450.725492745016;28199;28564.857175714194;28565.428691426056;2624.475104979012;2752.119321817019;2759.282586527497;2774.8473833939124;2960.363521842814;342394;344190;348335;350781;350808;37512;60223.69888150531;64199.35800642027;64419;64621.03068453977;37219;37240.44139337912;37395;37482.250354993295;37582.8120859394;16065.11641859709;16077.758833617505;16096.919515402347;16533.58666033359;16708.41520546775;13691;13730.862691373159;14099.224542650047;14228.359723812453;14238.2168980705;8320.334373250247;8326.25063744266;8378.664853405917;8412.411131220879;8578.056413794478;3492.650734926487;3547.095490649919;3551.975374036826;3588.3002814450933;3609.639036096422;1059.5761695321933;1061.9787604247872;1068.9893101069044;1102.4400473330147;1167.095500986725;30530.84734576313;30794.846025769726;31247.906323278577;31365.90219342358;31469.05592832173;1120.5181771838024;1133.54091592905;1137.2664631312757;1159.4260840883649;1219.030870457988;15864.60338491547;16067.598310042342;16079.598010049842;16100.363326344372;16395.344186232654;747249;749594;757622;758055.2097239478;765406;63751;64775;65196.34803651998;65684.34315656878;65985.01022484667;1554.8678362339328;1559.664672095505;1562.3750499799944;1564.765285207228;1574.7716780910907;27810.304742381602;30744.231394215323;31619.683803161675;32288.83855580707;32573;56720;56815.431845681014;57344.71327643335;57416.71291643515;57606.4239357601;576286;581733;585309;586126;587016;28386.006489772757;28553.857230713715;29114;29396.265093372836;29412.55881161827;47495.050098998516;47594.04811903812;47989;49013;49443.75278123586;38585.42121868118;38995.41506877342;39679.801600991814;40080.1983960325;40440.79779601083;37976.81011594924;38441.80779096087;39021.02447438723;39494.2101157981;39896.401553977295;34824.82587587046;39176;39325.60674393219;39730.80134599309;41043;31136.881752403788;32355.35289294248;36826.8158659205;36970.89087327384;37313.440298395006;25259.494810103326;25276.49447011086;25373.238802835946;25564.616530752424;26624.600630990164 11:26:18 INFO - PROCESS | 1949 | |2;jquery.html;418.0030626954716;418.57723699063934;419.20978954670454;424.0120519190285;424.33379594037353;17320.480385588453;20533.38399848005;21079.262225822098;21183.94080295985;21962;18181.545461363472;21972.670409943865;22229.55540889181;22334.664980025314;22720.318390448272;5933.792317268896;6064.727087281083;6114.633122012682;6225.501959843202;6268.780592679257;5976.312724036727;6150.138980542728;6204.596701214429;6253.593516421441;6379.234491860983;6277;6338.33447488014;6367.554271201017;6371.808845734636;6377.234731832186;6248.2814476335125;6251.249850017982;6312.652804095773;6335.239771227436;6345.809625711236;6065.302490213638;6115.571909966304;6136.23297087864;6187.350328215518;6196.380361963813;13728.93135534316;13932;13977.510787122503;14240.572782816533;14494.71010579793;2323.4772176260376;2422.9394265143337;2473.6784218051716;2638.8152829301957;2916.0814343481734;10106.545205465773;10233.334833235891;10584.947075264574;10611.310264832839;10745.892541074567;1826.8264514871066;1842.7051671732593;1852.0647073228067;1915.3009151659683;1920.2894928876265;105943.47028264886;126317.73682263243;126862;129028.35485822604;129712;12022.218555793845;12128.211666241667;12361.814572781415;12384.380780960915;12525.248485090924;15536.689266214613;15583.922080389526;15732.60668483297;15983.041017538984;16025.919870400574;9459.952700236454;9567.091126342986;9597.280203984728;9631.807363852684;9714.125728684452;9199.954000229956;9651.758706032406;9687.17658998979;9707.077827606367;9777.41335519871;4244.87265382039;4901.754912254373;4942.2092465206115;4952.925706114411;4979;2018.9394318170478;2100.9369718908456;2112.4402033461147;2121.257559854039;2172.5546263016045;972.3582435592475;997.9600815967425;1005.5776573839005;1023.8771347438355;1073.173656284672;19299.228030878607;19880.801191987895;21063.68404473934;21497;21571.460713482287;889.6352495476953;1006.7986402719486;1017.0439786600572;1027.2347101409498;1048.580567772897;8293.024185488779;9462.911765146959;10660.040596346365;11214.943925280322;11607.593734219261;604924;642751;664791;665272;675457;127658;131076.3446182763;133721.66278337286;134504;140661;892.7946572288411;1053.3890343600692;1076.983845242322;1081.6646839479786;1087.3530249501534;18699.878007319603;19076;19090.23639054478;19108.808911910703;19715.901420492806;49352;52071.95856082933;52144;52442.73778631083;56220;72735;76558;76802.84795727956;77362;77607;8406.32749380036;8459.238668519863;8495.830083398174;8603.311735061056;8866.512341821004;12335.75328493443;13075.869241307466;13082.411291492095;13248.933755331162;13455.327233638474;11012;11189.664310070712;11400;11425.600103996652;11439.08487321029;11092.722681933015;11231;11329.773404532029;11394.145439091935;11589.594364197214;11412.48643811047;11586.826197606873;11594.826077608674;12035.217710848767;12039.337836419081;8049.476784009021;8583.313334933066;8632.352573556882;8653.740387788377;9073.319501037317;10767.730806729895;11523.078153747847;11612.071034317065;11788.823167652663;11796.997255233402 11:26:18 INFO - PROCESS | 1949 | |3;mootools.html;1338.5047532413005;1355.8101865738795;1796.4790210838858;2027.3512476007675;2039.2862498125648;8390.66437342507;9086.637004449327;9119;9340.252779777618;9342.71971840845;7565.962170189141;9114.31642626804;9138.817223655524;9183.77040573986;9198.356115071947;2187.1579441914896;2558.2964684711715;2571.0872640212738;2576.1241177999477;2580.8967641294325;2174.8803815790125;2529.304441278645;2567.460833225025;2574.8197626166175;2594.7794437472744;2310.3992961829877;2554.6551215585937;2555.2845203343095;2590.106413287413;2608.9086881959133;2564.0897481394118;2583.5220484210386;2589.1714651311586;2597.1039991203193;2604.843709377434;2548.872556372174;2558.884850181728;2562.564364058096;2595.5457794886006;2604.869756512167;9232.169104780534;9260.583273752698;9299.953500232523;9331.253499720005;9342.813143737156;5652.434756524314;5675.801346952878;5791.131330300446;5827.708614569297;5866.530677545786;3680.3743363628246;3766.2655782122497;3775.4714339992424;3812.6759225465867;3815.923681526354;1064.914806815453;1070.5610699613121;1083.967480975564;1088.8530048443438;1095.2223921016089;12430.937845310806;12545.937270313681;12565.246085234916;12569.434375453127;12600.621981340575;5025.748712564357;5027.296178535008;5093;5115.948840511547;5143.794248230104;10488.528016239288;10559.208059395576;10560.788784224273;10632.681019569425;10643;5565.916511252334;5697.116946873241;5708;5737.110747834093;5753.424657534297;4675.13510000651;5085.694858308513;5195.142801437721;5207.895842083137;5214.426413094557;3692.8707495237536;4175.331946888544;4278.72188307759;4311.137772445523;4389.604935555815;1131.4003578103618;1423.1318895473753;1441.8990670653163;1457.985420145785;1474.3586539855198;911.1844898815656;915.9816803663889;964.3972517176765;990.6285143071349;1006.4917216805612;6027.276726792726;6086.756529738761;6125.356837532084;6258.15514905491;6259.186305780219;1016.5476363018386;1018.1752780248023;1022.197574903697;1056.3556230699267;1066.8026415113075;4026.1746342000406;4074.633283004544;4149.149424367997;4179.331306990867;4183.1215444756945;10972.067374273116;11406.885931140749;11420.42897855104;11537.423128843524;11569.958703716706;10951.288166269167;11215.55137794479;11295.774084518263;11309.886901130883;11409.942950285362;8533.402661813738;8831.425957312755;8871.334649901282;8927.553622318988;8951.955240223888;6026.608270462406;6036.396360363929;6052.394760523913;6083.513318934563;6114.113453549122;9735.318527703275;9879.950600246953;9960.800783984134;9978.850317245102;10146.086852183338;10044.547995340374;10416.895831041593;10430.322029068086;10613.787724245318;10634.361938283728;6743.1908171019795;6925.411340036153;7143.964280178774;7384.224656410999;7466.178720340867;8552.230299273095;8552.615132319184;8619.827603447771;8630.78423039429;8646.82706345857;7512.173660897188;7645;7662.770116896502;7682.116556596063;7768.572728499987;6413.967930160319;7372.778816635509;7373.668184931584;7427.517211381243;7438.330550250504;6964.512484126265;7260;7316.378107860892;7323.890141647773;7328.670209840463;4674.22875225584;4802.759862006956;5026.974865125651;5111.488851114858;5127.1540195867265;5038.622103342191;5071.2139618359215;5116.15583428745;5150.356205474316;5257.447967963309 11:26:18 INFO - PROCESS | 1949 | |4;prototype.html;296.75369443362007;326.34079160096604;343.32193917013893;344.44716230450126;347.72529701535785;5817.807349493354;6754.763583274574;6789.966050169743;6898;7107.6446177691105;6998.8250293742685;7003.789886303419;7047.823804404892;7073.434125269979;7084.149902011753;5118.28344031834;5129.846104616868;5130.050940575987;5144.536991670749;5147.794088236466;4195.769232692201;5116.360454943114;5155.639105262633;5170.405403378622;5172.482751724816;5052.115879721053;5064.139096353629;5068.847934561969;5070.974645126769;5076.84769456915;4953.207486802113;5024.799008039692;5097.541221290065;5098.158803797369;5111.4121875984365;4338.414314067592;4348.108637729258;4356.411884395629;4385.144896745136;4385.429894113745;6715.832104197385;6721.865562688768;6750.527463077587;6753.15585551806;6754.2907994660345;4434.93347599783;5253.579713622901;5433.9675461662155;6045.516358691338;6054.788082417138;7438.73964411243;7445.069366329209;7445.627718614048;7459.888101678479;7509.324160825552;4346.782660866944;4581.977090114561;4761.714297142183;4794.832180873687;4868.707877527324;6329.430351268362;7826.726064587769;7843.098043724987;7877.645505952246;7883.3299169570655;4829.66192366538;4831.275308703723;4842.201036828884;4847.175980083394;4857.684250523705;4941.851744447672;4945.653804233741;4955.1823949048;4959.876003099879;4960.131976904027;4803.711777293373;5899.321578018497;5911.9113213301835;5942.376050514634;5981.581289309794;6433.292337842833;7422.443316751265;7430.517016393917;7435.107787065586;7480.401567874557;1678.404166520892;1686.4856218853367;1699.4137022727139;1703.5996540812898;1715.8589537957118;1013.159077965287;1057.8571892794528;1062.3201151263197;1071.4374953149502;1083.9349639021527;7033.191183014019;7050.506464547432;7065.788026359218;7068.646567671596;7160.892586611205;6167.352427994996;7672.079350477979;7720;7736.226377362219;7754.883676744853;7081.575105493584;7089.82275443118;7102.183248926336;7104.6447677615915;7126.251743566954;3290.4899740540254;3961.564227934925;4075.572064933199;4090.5091389033505;4099.221147981874;6823.658817059128;8115.823205635268;8225.95639613335;8231.629576669064;8306.044804847399;7946.721864734822;8075.5558444286125;8097.757067287991;8112.513249205066;8130.715424960098;8209.71266005687;8236.546989915492;8246.257836794717;8280.420370574002;8292.087870334259;6109.541784366102;7688.577128258;7714.498557593738;7782.805429864298;7799.298063174341;6388.776392826228;7451.764470658889;7618.200088990576;7670.232976702285;7696.191899850435;8251.793705157419;8259.793505162419;8263.586820659064;8275.62759675828;8293.917060829315;4824.614030877591;4876.268559716071;4880.92678609814;4883.804647814048;4908.239222920453;7561.508501947355;7790.688372465038;7808.921910781047;7813.609319534115;7816.765497035098;7413.777586672409;7507.924920750723;7513.737019204302;7533.284337987882;7554.131274903457;7513.586752728653;7515.060617422822;7515.511491753018;7524.05949256343;7527.247275272429;7123.7506687265695;7292.088488938883;7339.339459448675;7341.229170937188;7354.852902941804;7451.44114191427;7506.624668766649;7520.285572870568;7548.471606987678;7555;7010.789676309719;7126.35862772353;7351.191368949519;7355.411567074728;7381.224971377928 11:26:18 INFO - PROCESS | 1949 | |5;yui.html;751.1249394455458;751.8120469882529;762.9275218854207;764.9082110146783;778.9610519474024;12564.371781410915;14975;15162.696746065087;15381.615459613515;15387.769183462256;14274.928625356859;14355.71288574228;14365.78451323231;14366;14383.568492945202;763.2215140556629;797.832455184412;964.0118878149917;968.3124981263312;968.6416026070328;955.44106697582;962.0139357158934;964.2189826240732;964.7877466957293;964.898685638005;984.2618036472645;999.1656966433037;1027.1679939249195;1028.9073983341498;1029.5572903651428;980.5342462330372;980.8332583460829;991.4299277915192;995.7261753017978;1023.0945613132357;731.6890321613294;733.9376153026999;751.0799270893167;764.0067911714804;766.4558163703776;15004.874634402355;15060.096394216382;15123.243837808066;15474.303656335493;15474.922625386802;13260.20438773667;13276.269805160713;13331.800022999663;13444.529441469502;13471.595852124452;10391.948040259826;10419.270651054429;10453.32053416533;10457.320274182153;10783.245172837904;3538.716902647782;3546.733994950389;3570.071781336845;3611.7291203159607;3664;77606;78754.21245787526;78869.21130788734;78931.60534197293;82545;9975.900240997642;10003.349782264275;10115.342502737298;10155.64455244063;10549.9472502637;22606.321810345715;22781.430464238525;23114.768852311263;23418.414539636644;23422.297331080095;6747.325267473311;7664.9616751917;7831.2560306770765;7854.2145785421;7933.56365399897;4100.6924480664065;4112.239235741397;4176.477940257468;4187.832486700559;4215.252414627008;3154.1010811918495;3314.734821214297;3668.3763760160837;3672.3022625701033;3715.6098609646137;673.6564352180424;683.3269229808634;685.5064353665352;694.6908625661633;695.2630211975322;531.9202119682001;535.5913946321228;559.739721029715;567.8410045187354;607.2500461929513;8281.875771863426;8323.916760832435;8398.622062007224;8400.873986890201;8479.565775860787;600.0369407101626;613.8066509049635;613.9120225266914;614.9569530132937;626.5301024231826;3770.208256266215;3779.6976241900584;3793.5827059023486;3943.7633741975574;3965.940510892339;89244.21511569733;91565;92045;92635;96604;65431.34568654348;68352.26590936306;76837;77621.83567246496;78168;53688;69318.30681693219;70196.64901675459;70234.64882675554;71126.64436677784;7461.589612571361;7657.502262352929;7698.846023079619;7775.844483110419;8001;49844.50466486011;50200;50409.74795126001;51086.48913510966;51331;51304.48695512997;62466.375336246056;62512.37487625066;65462.69074618386;67277;10396.532156053147;10461.163106951273;10956.616518421817;11372.886271137513;11430.885691142983;11773.47019384147;11811.645650630495;11848.696643369394;11922.701932451759;12024.398780060787;10951.233413660968;11121.610743623934;11242.269252498561;11270.83093753578;11631.59289424866;11023.944880275547;11035.944820275847;11141.387223702774;11385.658430247106;12262.20295680778;10895.455227238765;11185.66443006711;11243.269187502787;11414.201005929504;11466.140039496904;9297.581608827484;9341.2994025447;9366.531673416439;9522.809543809224;9525.90474095278;9757.853632195382;9798;9892.653757118755;9992.450415227233;10019.849702254327 11:26:18 INFO - PROCESS | 1949 | __end_tp_report 11:26:18 INFO - PROCESS | 1949 | __start_cc_report 11:26:18 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,393 11:26:18 INFO - PROCESS | 1949 | __end_cc_report 11:26:18 INFO - PROCESS | 1949 | __startTimestamp1467743178828__endTimestamp 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | ------- Summary: start ------- 11:26:18 INFO - PROCESS | 1949 | Number of tests: 6 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | [#0] dojo.html Cycles:165 Average:5928.41 Median:6225.04 stddev:702.91 (11.3%) stddev-sans-first:675.73 11:26:18 INFO - PROCESS | 1949 | Values: 3367.1 3650.5 3678.7 3693.4 3700.5 5191.9 5758.6 6013.8 6092.5 6097.9 4789.7 5858.3 5963.9 6053.2 6143.3 5381.2 5400.6 5435.0 5461.0 5480.9 5357.5 5386.7 5450.3 5503.2 5576.7 4636.5 5308.2 5489.3 5519.3 5544.2 4033.2 4574.1 5464.8 5512.3 5526.9 5269.8 5320.8 5331.7 5436.5 5470.2 5404.1 5733.5 5886.9 5932.1 5949.3 6309.2 6341.0 6353.2 6374.2 6382.0 6257.1 6364.9 6372.3 6402.3 6430.9 6150.9 6164.5 6170.0 6194.4 6197.1 6607.7 6620.8 6642.8 6653.8 6674.6 6209.8 6224.6 6237.1 6252.7 6296.6 6380.3 6426.7 6449.8 6468.7 6469.2 6316.4 6318.3 6323.6 6327.5 6352.5 6212.6 6266.5 6286.7 6323.0 6347.6 5078.2 5110.6 5125.4 5132.4 5148.3 3862.5 4558.8 4633.2 4638.7 4650.0 5914.6 6119.4 6161.9 6228.2 6289.3 6359.2 6449.5 6466.9 6490.3 6498.1 4889.6 6106.5 6283.5 6308.6 6311.3 5619.6 5659.3 5668.1 5710.5 5732.0 6725.7 6756.7 6768.8 6769.3 6783.1 6283.1 6390.7 6469.4 6476.7 6481.5 6638.1 6727.3 6782.9 6783.0 6800.7 5927.3 6369.3 6387.6 6392.9 6402.9 6342.4 6386.6 6432.2 6461.9 6500.7 6262.6 6317.7 6327.5 6329.4 6350.6 5659.4 6192.3 6265.2 6284.7 6305.0 5846.7 6111.0 6159.9 6165.9 6233.6 5678.5 6297.9 6298.2 6304.7 6304.7 5059.8 6225.0 6228.5 6272.2 6276.8 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | [#1] ext.html Cycles:180 Average:69092.98 Median:38513.61 stddev:157750.81 (409.6%) stddev-sans-first:158109.35 11:26:18 INFO - PROCESS | 1949 | Values: 532.0 543.3 544.1 588.7 590.6 29433.9 39960.4 39976.6 39985.2 40035.0 35245.5 43133.8 43996.8 44006.0 44166.8 9753.6 9843.3 9860.6 9957.2 9996.6 9843.7 9851.1 9879.7 9888.3 9950.8 9856.8 9860.7 9907.6 9975.1 10001.7 9848.5 9952.9 9954.6 9975.8 9996.7 9805.1 9814.5 9851.7 9935.8 9986.4 39798.8 39936.8 40640.4 40873.2 41001.8 2818.8 2872.3 3364.2 3759.8 3868.4 23684.9 27450.7 28199.0 28564.9 28565.4 2624.5 2752.1 2759.3 2774.8 2960.4 342394.0 344190.0 348335.0 350781.0 350808.0 37512.0 60223.7 64199.4 64419.0 64621.0 37219.0 37240.4 37395.0 37482.3 37582.8 16065.1 16077.8 16096.9 16533.6 16708.4 13691.0 13730.9 14099.2 14228.4 14238.2 8320.3 8326.3 8378.7 8412.4 8578.1 3492.7 3547.1 3552.0 3588.3 3609.6 1059.6 1062.0 1069.0 1102.4 1167.1 30530.8 30794.8 31247.9 31365.9 31469.1 1120.5 1133.5 1137.3 1159.4 1219.0 15864.6 16067.6 16079.6 16100.4 16395.3 747249.0 749594.0 757622.0 758055.2 765406.0 63751.0 64775.0 65196.3 65684.3 65985.0 1554.9 1559.7 1562.4 1564.8 1574.8 27810.3 30744.2 31619.7 32288.8 32573.0 56720.0 56815.4 57344.7 57416.7 57606.4 576286.0 581733.0 585309.0 586126.0 587016.0 28386.0 28553.9 29114.0 29396.3 29412.6 47495.1 47594.0 47989.0 49013.0 49443.8 38585.4 38995.4 39679.8 40080.2 40440.8 37976.8 38441.8 39021.0 39494.2 39896.4 34824.8 39176.0 39325.6 39730.8 41043.0 31136.9 32355.4 36826.8 36970.9 37313.4 25259.5 25276.5 25373.2 25564.6 26624.6 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | [#2] jquery.html Cycles:180 Average:36724.92 Median:11809.13 stddev:108433.71 (918.2%) stddev-sans-first:108703.62 11:26:18 INFO - PROCESS | 1949 | Values: 418.0 418.6 419.2 424.0 424.3 17320.5 20533.4 21079.3 21183.9 21962.0 18181.5 21972.7 22229.6 22334.7 22720.3 5933.8 6064.7 6114.6 6225.5 6268.8 5976.3 6150.1 6204.6 6253.6 6379.2 6277.0 6338.3 6367.6 6371.8 6377.2 6248.3 6251.2 6312.7 6335.2 6345.8 6065.3 6115.6 6136.2 6187.4 6196.4 13728.9 13932.0 13977.5 14240.6 14494.7 2323.5 2422.9 2473.7 2638.8 2916.1 10106.5 10233.3 10584.9 10611.3 10745.9 1826.8 1842.7 1852.1 1915.3 1920.3 105943.5 126317.7 126862.0 129028.4 129712.0 12022.2 12128.2 12361.8 12384.4 12525.2 15536.7 15583.9 15732.6 15983.0 16025.9 9460.0 9567.1 9597.3 9631.8 9714.1 9200.0 9651.8 9687.2 9707.1 9777.4 4244.9 4901.8 4942.2 4952.9 4979.0 2018.9 2100.9 2112.4 2121.3 2172.6 972.4 998.0 1005.6 1023.9 1073.2 19299.2 19880.8 21063.7 21497.0 21571.5 889.6 1006.8 1017.0 1027.2 1048.6 8293.0 9462.9 10660.0 11214.9 11607.6 604924.0 642751.0 664791.0 665272.0 675457.0 127658.0 131076.3 133721.7 134504.0 140661.0 892.8 1053.4 1077.0 1081.7 1087.4 18699.9 19076.0 19090.2 19108.8 19715.9 49352.0 52072.0 52144.0 52442.7 56220.0 72735.0 76558.0 76802.8 77362.0 77607.0 8406.3 8459.2 8495.8 8603.3 8866.5 12335.8 13075.9 13082.4 13248.9 13455.3 11012.0 11189.7 11400.0 11425.6 11439.1 11092.7 11231.0 11329.8 11394.1 11589.6 11412.5 11586.8 11594.8 12035.2 12039.3 8049.5 8583.3 8632.4 8653.7 9073.3 10767.7 11523.1 11612.1 11788.8 11797.0 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | [#3] mootools.html Cycles:180 Average:5965.35 Median:5026.36 stddev:3326.43 (66.2%) stddev-sans-first:3317.58 11:26:18 INFO - PROCESS | 1949 | Values: 1338.5 1355.8 1796.5 2027.4 2039.3 8390.7 9086.6 9119.0 9340.3 9342.7 7566.0 9114.3 9138.8 9183.8 9198.4 2187.2 2558.3 2571.1 2576.1 2580.9 2174.9 2529.3 2567.5 2574.8 2594.8 2310.4 2554.7 2555.3 2590.1 2608.9 2564.1 2583.5 2589.2 2597.1 2604.8 2548.9 2558.9 2562.6 2595.5 2604.9 9232.2 9260.6 9300.0 9331.3 9342.8 5652.4 5675.8 5791.1 5827.7 5866.5 3680.4 3766.3 3775.5 3812.7 3815.9 1064.9 1070.6 1084.0 1088.9 1095.2 12430.9 12545.9 12565.2 12569.4 12600.6 5025.7 5027.3 5093.0 5115.9 5143.8 10488.5 10559.2 10560.8 10632.7 10643.0 5565.9 5697.1 5708.0 5737.1 5753.4 4675.1 5085.7 5195.1 5207.9 5214.4 3692.9 4175.3 4278.7 4311.1 4389.6 1131.4 1423.1 1441.9 1458.0 1474.4 911.2 916.0 964.4 990.6 1006.5 6027.3 6086.8 6125.4 6258.2 6259.2 1016.5 1018.2 1022.2 1056.4 1066.8 4026.2 4074.6 4149.1 4179.3 4183.1 10972.1 11406.9 11420.4 11537.4 11570.0 10951.3 11215.6 11295.8 11309.9 11409.9 8533.4 8831.4 8871.3 8927.6 8952.0 6026.6 6036.4 6052.4 6083.5 6114.1 9735.3 9880.0 9960.8 9978.9 10146.1 10044.5 10416.9 10430.3 10613.8 10634.4 6743.2 6925.4 7144.0 7384.2 7466.2 8552.2 8552.6 8619.8 8630.8 8646.8 7512.2 7645.0 7662.8 7682.1 7768.6 6414.0 7372.8 7373.7 7427.5 7438.3 6964.5 7260.0 7316.4 7323.9 7328.7 4674.2 4802.8 5027.0 5111.5 5127.2 5038.6 5071.2 5116.2 5150.4 5257.4 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | [#4] prototype.html Cycles:180 Average:6069.73 Median:7001.31 stddev:1993.73 (28.5%) stddev-sans-first:1951.67 11:26:18 INFO - PROCESS | 1949 | Values: 296.8 326.3 343.3 344.4 347.7 5817.8 6754.8 6790.0 6898.0 7107.6 6998.8 7003.8 7047.8 7073.4 7084.1 5118.3 5129.8 5130.1 5144.5 5147.8 4195.8 5116.4 5155.6 5170.4 5172.5 5052.1 5064.1 5068.8 5071.0 5076.8 4953.2 5024.8 5097.5 5098.2 5111.4 4338.4 4348.1 4356.4 4385.1 4385.4 6715.8 6721.9 6750.5 6753.2 6754.3 4434.9 5253.6 5434.0 6045.5 6054.8 7438.7 7445.1 7445.6 7459.9 7509.3 4346.8 4582.0 4761.7 4794.8 4868.7 6329.4 7826.7 7843.1 7877.6 7883.3 4829.7 4831.3 4842.2 4847.2 4857.7 4941.9 4945.7 4955.2 4959.9 4960.1 4803.7 5899.3 5911.9 5942.4 5981.6 6433.3 7422.4 7430.5 7435.1 7480.4 1678.4 1686.5 1699.4 1703.6 1715.9 1013.2 1057.9 1062.3 1071.4 1083.9 7033.2 7050.5 7065.8 7068.6 7160.9 6167.4 7672.1 7720.0 7736.2 7754.9 7081.6 7089.8 7102.2 7104.6 7126.3 3290.5 3961.6 4075.6 4090.5 4099.2 6823.7 8115.8 8226.0 8231.6 8306.0 7946.7 8075.6 8097.8 8112.5 8130.7 8209.7 8236.5 8246.3 8280.4 8292.1 6109.5 7688.6 7714.5 7782.8 7799.3 6388.8 7451.8 7618.2 7670.2 7696.2 8251.8 8259.8 8263.6 8275.6 8293.9 4824.6 4876.3 4880.9 4883.8 4908.2 7561.5 7790.7 7808.9 7813.6 7816.8 7413.8 7507.9 7513.7 7533.3 7554.1 7513.6 7515.1 7515.5 7524.1 7527.2 7123.8 7292.1 7339.3 7341.2 7354.9 7451.4 7506.6 7520.3 7548.5 7555.0 7010.8 7126.4 7351.2 7355.4 7381.2 11:26:18 INFO - PROCESS | 1949 | 11:26:18 INFO - PROCESS | 1949 | [#5] yui.html Cycles:180 Average:17991.28 Median:533.76 stddev:24891.08 (4663.4%) stddev-sans-first:24927.24 11:26:18 INFO - PROCESS | 1949 | Values: 751.1 751.8 762.9 764.9 779.0 12564.4 14975.0 15162.7 15381.6 15387.8 14274.9 14355.7 14365.8 14366.0 14383.6 763.2 797.8 964.0 968.3 968.6 955.4 962.0 964.2 964.8 964.9 984.3 999.2 1027.2 1028.9 1029.6 980.5 980.8 991.4 995.7 1023.1 731.7 733.9 751.1 764.0 766.5 15004.9 15060.1 15123.2 15474.3 15474.9 13260.2 13276.3 13331.8 13444.5 13471.6 10391.9 10419.3 10453.3 10457.3 10783.2 3538.7 3546.7 3570.1 3611.7 3664.0 77606.0 78754.2 78869.2 78931.6 82545.0 9975.9 10003.3 10115.3 10155.6 10549.9 22606.3 22781.4 23114.8 23418.4 23422.3 6747.3 7665.0 7831.3 7854.2 7933.6 4100.7 4112.2 4176.5 4187.8 4215.3 3154.1 3314.7 3668.4 3672.3 3715.6 673.7 683.3 685.5 694.7 695.3 531.9 535.6 559.7 567.8 607.3 8281.9 8323.9 8398.6 8400.9 8479.6 600.0 613.8 613.9 615.0 626.5 3770.2 3779.7 3793.6 3943.8 3965.9 89244.2 91565.0 92045.0 92635.0 96604.0 65431.3 68352.3 76837.0 77621.8 78168.0 53688.0 69318.3 70196.6 70234.6 71126.6 7461.6 7657.5 7698.8 7775.8 8001.0 49844.5 50200.0 50409.7 51086.5 51331.0 51304.5 62466.4 62512.4 65462.7 67277.0 10396.5 10461.2 10956.6 11372.9 11430.9 11773.5 11811.6 11848.7 11922.7 12024.4 10951.2 11121.6 11242.3 11270.8 11631.6 11023.9 11035.9 11141.4 11385.7 12262.2 10895.5 11185.7 11243.3 11414.2 11466.1 9297.6 9341.3 9366.5 9522.8 9525.9 9757.9 9798.0 9892.7 9992.5 10019.8 11:26:18 INFO - PROCESS | 1949 | -------- Summary: end -------- 11:26:18 INFO - PROCESS | 1949 | 11:26:19 INFO - TEST-INFO | 1949: exit 0 11:26:19 INFO - TEST-OK | dromaeo_css | took 1109485ms 11:26:19 INFO - TEST-START | kraken 11:26:19 INFO - operating with platform_type : mac_ 11:26:19 INFO - Initialising browser for kraken test... 11:26:19 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpj5vGXQ/profile http://localhost:57334/getInfo.html) 11:26:21 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 11:26:21 INFO - PROCESS | 1955 | colorDepth:24 11:26:21 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 11:26:21 INFO - PROCESS | 1955 | __metrics 11:26:21 ERROR - PROCESS | 1955 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:26:22 INFO - TEST-INFO | 1955: exit 0 11:26:22 INFO - Browser initialized. 11:26:22 INFO - Running cycle 1/1 for kraken test... 11:26:22 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpj5vGXQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:34 INFO - PROCESS | 1959 | RSS: Main: 171003904 11:26:34 INFO - PROCESS | 1959 | 11:26:37 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:38 INFO - PROCESS | 1959 | RSS: Main: 183775232 11:26:38 INFO - PROCESS | 1959 | 11:26:40 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-dft) 11:26:41 INFO - PROCESS | 1959 | RSS: Main: 192425984 11:26:41 INFO - PROCESS | 1959 | 11:26:44 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-fft) 11:26:45 INFO - PROCESS | 1959 | RSS: Main: 196538368 11:26:45 INFO - PROCESS | 1959 | 11:26:47 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-oscillator) 11:26:48 INFO - PROCESS | 1959 | RSS: Main: 196739072 11:26:48 INFO - PROCESS | 1959 | 11:26:50 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:50 INFO - PROCESS | 1959 | RSS: Main: 196960256 11:26:50 INFO - PROCESS | 1959 | 11:26:53 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57334/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:54 INFO - PROCESS | 1959 | RSS: Main: 196669440 11:26:54 INFO - PROCESS | 1959 | 11:26:57 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57334/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:57 INFO - PROCESS | 1959 | RSS: Main: 198053888 11:26:57 INFO - PROCESS | 1959 | 11:27:00 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57334/tests/kraken/driver.html?testName=json-parse-financial) 11:27:01 INFO - PROCESS | 1959 | RSS: Main: 198225920 11:27:01 INFO - PROCESS | 1959 | 11:27:02 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:03 INFO - PROCESS | 1959 | RSS: Main: 198049792 11:27:03 INFO - PROCESS | 1959 | 11:27:05 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:05 INFO - PROCESS | 1959 | RSS: Main: 197906432 11:27:05 INFO - PROCESS | 1959 | 11:27:07 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:08 INFO - PROCESS | 1959 | RSS: Main: 198103040 11:27:08 INFO - PROCESS | 1959 | 11:27:11 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:12 INFO - PROCESS | 1959 | RSS: Main: 198242304 11:27:12 INFO - PROCESS | 1959 | 11:27:14 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:15 INFO - PROCESS | 1959 | RSS: Main: 198213632 11:27:15 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57334/tests/kraken/driver.html?testName=ai-astar) 11:27:17 INFO - PROCESS | 1959 | RSS: Main: 200212480 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | __start_tp_report 11:27:17 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 11:27:17 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 11:27:17 INFO - PROCESS | 1959 | |i|pagename|runs| 11:27:17 INFO - PROCESS | 1959 | |0;ai-astar;117;114;116;116;136;198;152;116;116;116 11:27:17 INFO - PROCESS | 1959 | |1;audio-beat-detection;154;125;141;160;135;140;120;162;188;151 11:27:17 INFO - PROCESS | 1959 | |2;audio-dft;198;195;193;204;268;268;199;260;194;195 11:27:17 INFO - PROCESS | 1959 | |3;audio-fft;66;70;90;153;58;56;58;69;129;63 11:27:17 INFO - PROCESS | 1959 | |4;audio-oscillator;75;84;120;65;84;143;159;120;89;126 11:27:17 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;90;87;89;86;128;130;128;86;90;88 11:27:17 INFO - PROCESS | 1959 | |6;imaging-darkroom;96;96;97;96;118;95;95;96;94;95 11:27:17 INFO - PROCESS | 1959 | |7;imaging-desaturate;138;96;89;89;92;89;91;93;91;90 11:27:17 INFO - PROCESS | 1959 | |8;json-parse-financial;59;64;65;65;66;64;65;79;62;61 11:27:17 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;65;63;65;72;77;68;65;64;65;86 11:27:17 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;81;79;79;80;89;75;80;82;82;85 11:27:17 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;124;128;126;126;128;127;127;125;181;172 11:27:17 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;165;210;167;167;163;166;210;167;174;165 11:27:17 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;67;103;101;83;69;66;69;69;67;69 11:27:17 INFO - PROCESS | 1959 | __end_tp_report 11:27:17 INFO - PROCESS | 1959 | __start_cc_report 11:27:17 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,1037 11:27:17 INFO - PROCESS | 1959 | __end_cc_report 11:27:17 INFO - PROCESS | 1959 | __startTimestamp1467743237518__endTimestamp 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | ------- Summary: start ------- 11:27:17 INFO - PROCESS | 1959 | Number of tests: 14 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:129.70 Median:116.50 stddev:26.97 (23.2%) stddev-sans-first:28.22 11:27:17 INFO - PROCESS | 1959 | Values: 117.0 114.0 116.0 116.0 136.0 198.0 152.0 116.0 116.0 116.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.50 stddev:19.94 (13.1%) stddev-sans-first:21.01 11:27:17 INFO - PROCESS | 1959 | Values: 154.0 125.0 141.0 160.0 135.0 140.0 120.0 162.0 188.0 151.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:217.40 Median:201.50 stddev:33.29 (16.5%) stddev-sans-first:34.57 11:27:17 INFO - PROCESS | 1959 | Values: 198.0 195.0 193.0 204.0 268.0 268.0 199.0 260.0 194.0 195.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:81.20 Median:64.50 stddev:33.44 (51.8%) stddev-sans-first:35.02 11:27:17 INFO - PROCESS | 1959 | Values: 66.0 70.0 90.0 153.0 58.0 56.0 58.0 69.0 129.0 63.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:70.00 stddev:31.39 (44.8%) stddev-sans-first:31.15 11:27:17 INFO - PROCESS | 1959 | Values: 75.0 84.0 120.0 65.0 84.0 143.0 159.0 120.0 89.0 126.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:100.20 Median:87.50 stddev:19.70 (22.5%) stddev-sans-first:20.55 11:27:17 INFO - PROCESS | 1959 | Values: 90.0 87.0 89.0 86.0 128.0 130.0 128.0 86.0 90.0 88.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:96.00 stddev:7.15 (7.4%) stddev-sans-first:7.55 11:27:17 INFO - PROCESS | 1959 | Values: 96.0 96.0 97.0 96.0 118.0 95.0 95.0 96.0 94.0 95.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:91.00 stddev:14.99 (16.5%) stddev-sans-first:2.32 11:27:17 INFO - PROCESS | 1959 | Values: 138.0 96.0 89.0 89.0 92.0 89.0 91.0 93.0 91.0 90.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:5.37 (8.3%) stddev-sans-first:5.24 11:27:17 INFO - PROCESS | 1959 | Values: 59.0 64.0 65.0 65.0 66.0 64.0 65.0 79.0 62.0 61.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:66.50 stddev:7.36 (11.1%) stddev-sans-first:7.67 11:27:17 INFO - PROCESS | 1959 | Values: 65.0 63.0 65.0 72.0 77.0 68.0 65.0 64.0 65.0 86.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:3.77 (4.6%) stddev-sans-first:3.99 11:27:17 INFO - PROCESS | 1959 | Values: 81.0 79.0 79.0 80.0 89.0 75.0 80.0 82.0 82.0 85.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:127.50 stddev:21.28 (16.7%) stddev-sans-first:22.09 11:27:17 INFO - PROCESS | 1959 | Values: 124.0 128.0 126.0 126.0 128.0 127.0 127.0 125.0 181.0 172.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:167.00 stddev:18.46 (11.1%) stddev-sans-first:19.19 11:27:17 INFO - PROCESS | 1959 | Values: 165.0 210.0 167.0 167.0 163.0 166.0 210.0 167.0 174.0 165.0 11:27:17 INFO - PROCESS | 1959 | 11:27:17 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:69.00 stddev:14.38 (20.8%) stddev-sans-first:14.85 11:27:17 INFO - PROCESS | 1959 | Values: 67.0 103.0 101.0 83.0 69.0 66.0 69.0 69.0 67.0 69.0 11:27:17 INFO - PROCESS | 1959 | -------- Summary: end -------- 11:27:17 INFO - PROCESS | 1959 | 11:27:18 INFO - TEST-INFO | 1959: exit 0 11:27:18 INFO - TEST-OK | kraken | took 58860ms 11:27:18 INFO - SUITE-END | took 1168s 11:27:18 INFO - Completed test suite (00:19:28) 11:27:18 INFO - javascript benchmark 11:27:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.107716455139, 3650.5071815304927, 3678.6689197972187, 3693.372126738454, 3700.463432802242, 5191.948080519193, 5758.617931696394, 6013.789517366893, 6092.543059270556, 6097.878042439149, 4789.736564488951, 5858.297004359483, 5963.880722385549, 6053.152558641794, 6143.293521245058, 5381.165919282517, 5400.621956463049, 5435.0488664483555, 5461.0, 5480.862978425552, 5357.517823395893, 5386.703731294777, 5450.264214331074, 5503.174523821439, 5576.721163941807, 4636.4899861015265, 5308.230306605559, 5489.313835770528, 5519.282493275869, 5544.16837474378, 4033.1731994941115, 4574.1080489304595, 5464.754086066137, 5512.283403157604, 5526.944730552683, 5269.789208431658, 5320.76056577455, 5331.653442526263, 5436.537894278991, 5470.17947307903, 5404.135338345845, 5733.451967968666, 5886.852828679274, 5932.080527518242, 5949.315828679714, 6309.242890853081, 6340.968295158541, 6353.174087368659, 6374.235091788969, 6382.0, 6257.124002639634, 6364.904526432061, 6372.2671892732005, 6402.294313679488, 6430.93569064308, 6150.8769824603705, 6164.476019538344, 6170.0, 6194.380561943814, 6197.132401463754, 6607.702653380609, 6620.768273110514, 6642.83392915181, 6653.767118150841, 6674.632895190811, 6209.844753881099, 6224.564280500322, 6237.064440333987, 6252.749890004349, 6296.590721603081, 6380.298167201604, 6426.678666066771, 6449.774257901045, 6468.676566171766, 6469.223693156851, 6316.368363163647, 6318.273398559132, 6323.620582765049, 6327.525435592257, 6352.523560732963, 6212.596181248205, 6266.467350275278, 6286.654234017082, 6322.968385158045, 6347.587406818634, 5078.187490001582, 5110.591152707774, 5125.359330083739, 5132.43543210254, 5148.33071700684, 3862.478565393692, 4558.791920141165, 4633.189191891405, 4638.675292729544, 4650.023495066006, 5914.615549989237, 6119.350229749466, 6161.876762464725, 6228.22147231596, 6289.339619339995, 6359.20509936258, 6449.516286278548, 6466.935330646727, 6490.318516555693, 6498.122753428227, 4889.608831293488, 6106.542009349228, 6283.497320214372, 6308.621482711052, 6311.274203466568, 5619.606627536115, 5659.349174844946, 5668.064769313017, 5710.486056254957, 5732.0, 6725.730970761213, 6756.69594868242, 6768.83077923046, 6769.255381907986, 6783.118194634863, 6283.088952102011, 6390.712417941111, 6469.385408386384, 6476.740930362921, 6481.546291759531, 6638.137042184485, 6727.327267273234, 6782.93217067823, 6782.966085169543, 6800.6599670017295, 5927.347991720821, 6369.267534233437, 6387.552871298964, 6392.904106438315, 6402.935970640234, 6342.429181373698, 6386.616802991835, 6432.195975503062, 6461.870762584816, 6500.674966251574, 6262.561620686691, 6317.747290108528, 6327.493800495858, 6329.367063293634, 6350.587211831216, 5659.434056594308, 6192.2569291683485, 6265.248170219421, 6284.685765711788, 6304.968475157595, 5846.684495988368, 6111.04482360895, 6159.876802464015, 6165.938340616716, 6233.625982441068, 5678.488935995781, 6297.905531416941, 6298.212723409574, 6304.6847657617855, 6304.747810087545, 5059.848204553869, 6225.035119556476, 6228.4705800005695, 6272.184616000073, 6276.811695649138], "value": 5885.535039466476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.9734013299335, 543.2584522127295, 544.0913674164145, 588.6879953624575, 590.5629833922899, 29433.852830735843, 39960.40059399104, 39976.600233997655, 39985.200295994066, 40035.0, 35245.47131793025, 43133.7843310783, 43996.780016099874, 44006.0, 44166.77916610413, 9753.609855605784, 9843.310968232227, 9860.556274967643, 9957.203423726085, 9996.600135994551, 9843.655472058479, 9851.113399794018, 9879.703608891745, 9888.307818452711, 9950.800983980316, 9856.802863942718, 9860.70417887461, 9907.554160062778, 9975.102240798327, 10001.749956251115, 9848.50757462124, 9952.850707239397, 9954.601815927354, 9975.800483990351, 9996.650117245934, 9805.068518490803, 9814.46020468874, 9851.704448866545, 9935.801283974351, 9986.400815951067, 39798.801005995076, 39936.801895943165, 40640.39039414411, 40873.18253634911, 41001.79499102486, 2818.788590855694, 2872.310645445099, 3364.192593777476, 3759.793211373373, 3868.400397938296, 23684.934177962034, 27450.725492745016, 28199.0, 28564.857175714194, 28565.428691426056, 2624.475104979012, 2752.119321817019, 2759.282586527497, 2774.8473833939124, 2960.363521842814, 342394.0, 344190.0, 348335.0, 350781.0, 350808.0, 37512.0, 60223.69888150531, 64199.35800642027, 64419.0, 64621.03068453977, 37219.0, 37240.44139337912, 37395.0, 37482.250354993295, 37582.8120859394, 16065.11641859709, 16077.758833617505, 16096.919515402347, 16533.58666033359, 16708.41520546775, 13691.0, 13730.862691373159, 14099.224542650047, 14228.359723812453, 14238.2168980705, 8320.334373250247, 8326.25063744266, 8378.664853405917, 8412.411131220879, 8578.056413794478, 3492.650734926487, 3547.095490649919, 3551.975374036826, 3588.3002814450933, 3609.639036096422, 1059.5761695321933, 1061.9787604247872, 1068.9893101069044, 1102.4400473330147, 1167.095500986725, 30530.84734576313, 30794.846025769726, 31247.906323278577, 31365.90219342358, 31469.05592832173, 1120.5181771838024, 1133.54091592905, 1137.2664631312757, 1159.4260840883649, 1219.030870457988, 15864.60338491547, 16067.598310042342, 16079.598010049842, 16100.363326344372, 16395.344186232654, 747249.0, 749594.0, 757622.0, 758055.2097239478, 765406.0, 63751.0, 64775.0, 65196.34803651998, 65684.34315656878, 65985.01022484667, 1554.8678362339328, 1559.664672095505, 1562.3750499799944, 1564.765285207228, 1574.7716780910907, 27810.304742381602, 30744.231394215323, 31619.683803161675, 32288.83855580707, 32573.0, 56720.0, 56815.431845681014, 57344.71327643335, 57416.71291643515, 57606.4239357601, 576286.0, 581733.0, 585309.0, 586126.0, 587016.0, 28386.006489772757, 28553.857230713715, 29114.0, 29396.265093372836, 29412.55881161827, 47495.050098998516, 47594.04811903812, 47989.0, 49013.0, 49443.75278123586, 38585.42121868118, 38995.41506877342, 39679.801600991814, 40080.1983960325, 40440.79779601083, 37976.81011594924, 38441.80779096087, 39021.02447438723, 39494.2101157981, 39896.401553977295, 34824.82587587046, 39176.0, 39325.60674393219, 39730.80134599309, 41043.0, 31136.881752403788, 32355.35289294248, 36826.8158659205, 36970.89087327384, 37313.440298395006, 25259.494810103326, 25276.49447011086, 25373.238802835946, 25564.616530752424, 26624.600630990164], "value": 19235.2944210855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.0030626954716, 418.57723699063934, 419.20978954670454, 424.0120519190285, 424.33379594037353, 17320.480385588453, 20533.38399848005, 21079.262225822098, 21183.94080295985, 21962.0, 18181.545461363472, 21972.670409943865, 22229.55540889181, 22334.664980025314, 22720.318390448272, 5933.792317268896, 6064.727087281083, 6114.633122012682, 6225.501959843202, 6268.780592679257, 5976.312724036727, 6150.138980542728, 6204.596701214429, 6253.593516421441, 6379.234491860983, 6277.0, 6338.33447488014, 6367.554271201017, 6371.808845734636, 6377.234731832186, 6248.2814476335125, 6251.249850017982, 6312.652804095773, 6335.239771227436, 6345.809625711236, 6065.302490213638, 6115.571909966304, 6136.23297087864, 6187.350328215518, 6196.380361963813, 13728.93135534316, 13932.0, 13977.510787122503, 14240.572782816533, 14494.71010579793, 2323.4772176260376, 2422.9394265143337, 2473.6784218051716, 2638.8152829301957, 2916.0814343481734, 10106.545205465773, 10233.334833235891, 10584.947075264574, 10611.310264832839, 10745.892541074567, 1826.8264514871066, 1842.7051671732593, 1852.0647073228067, 1915.3009151659683, 1920.2894928876265, 105943.47028264886, 126317.73682263243, 126862.0, 129028.35485822604, 129712.0, 12022.218555793845, 12128.211666241667, 12361.814572781415, 12384.380780960915, 12525.248485090924, 15536.689266214613, 15583.922080389526, 15732.60668483297, 15983.041017538984, 16025.919870400574, 9459.952700236454, 9567.091126342986, 9597.280203984728, 9631.807363852684, 9714.125728684452, 9199.954000229956, 9651.758706032406, 9687.17658998979, 9707.077827606367, 9777.41335519871, 4244.87265382039, 4901.754912254373, 4942.2092465206115, 4952.925706114411, 4979.0, 2018.9394318170478, 2100.9369718908456, 2112.4402033461147, 2121.257559854039, 2172.5546263016045, 972.3582435592475, 997.9600815967425, 1005.5776573839005, 1023.8771347438355, 1073.173656284672, 19299.228030878607, 19880.801191987895, 21063.68404473934, 21497.0, 21571.460713482287, 889.6352495476953, 1006.7986402719486, 1017.0439786600572, 1027.2347101409498, 1048.580567772897, 8293.024185488779, 9462.911765146959, 10660.040596346365, 11214.943925280322, 11607.593734219261, 604924.0, 642751.0, 664791.0, 665272.0, 675457.0, 127658.0, 131076.3446182763, 133721.66278337286, 134504.0, 140661.0, 892.7946572288411, 1053.3890343600692, 1076.983845242322, 1081.6646839479786, 1087.3530249501534, 18699.878007319603, 19076.0, 19090.23639054478, 19108.808911910703, 19715.901420492806, 49352.0, 52071.95856082933, 52144.0, 52442.73778631083, 56220.0, 72735.0, 76558.0, 76802.84795727956, 77362.0, 77607.0, 8406.32749380036, 8459.238668519863, 8495.830083398174, 8603.311735061056, 8866.512341821004, 12335.75328493443, 13075.869241307466, 13082.411291492095, 13248.933755331162, 13455.327233638474, 11012.0, 11189.664310070712, 11400.0, 11425.600103996652, 11439.08487321029, 11092.722681933015, 11231.0, 11329.773404532029, 11394.145439091935, 11589.594364197214, 11412.48643811047, 11586.826197606873, 11594.826077608674, 12035.217710848767, 12039.337836419081, 8049.476784009021, 8583.313334933066, 8632.352573556882, 8653.740387788377, 9073.319501037317, 10767.730806729895, 11523.078153747847, 11612.071034317065, 11788.823167652663, 11796.997255233402], "value": 9887.382160095449, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.5047532413005, 1355.8101865738795, 1796.4790210838858, 2027.3512476007675, 2039.2862498125648, 8390.66437342507, 9086.637004449327, 9119.0, 9340.252779777618, 9342.71971840845, 7565.962170189141, 9114.31642626804, 9138.817223655524, 9183.77040573986, 9198.356115071947, 2187.1579441914896, 2558.2964684711715, 2571.0872640212738, 2576.1241177999477, 2580.8967641294325, 2174.8803815790125, 2529.304441278645, 2567.460833225025, 2574.8197626166175, 2594.7794437472744, 2310.3992961829877, 2554.6551215585937, 2555.2845203343095, 2590.106413287413, 2608.9086881959133, 2564.0897481394118, 2583.5220484210386, 2589.1714651311586, 2597.1039991203193, 2604.843709377434, 2548.872556372174, 2558.884850181728, 2562.564364058096, 2595.5457794886006, 2604.869756512167, 9232.169104780534, 9260.583273752698, 9299.953500232523, 9331.253499720005, 9342.813143737156, 5652.434756524314, 5675.801346952878, 5791.131330300446, 5827.708614569297, 5866.530677545786, 3680.3743363628246, 3766.2655782122497, 3775.4714339992424, 3812.6759225465867, 3815.923681526354, 1064.914806815453, 1070.5610699613121, 1083.967480975564, 1088.8530048443438, 1095.2223921016089, 12430.937845310806, 12545.937270313681, 12565.246085234916, 12569.434375453127, 12600.621981340575, 5025.748712564357, 5027.296178535008, 5093.0, 5115.948840511547, 5143.794248230104, 10488.528016239288, 10559.208059395576, 10560.788784224273, 10632.681019569425, 10643.0, 5565.916511252334, 5697.116946873241, 5708.0, 5737.110747834093, 5753.424657534297, 4675.13510000651, 5085.694858308513, 5195.142801437721, 5207.895842083137, 5214.426413094557, 3692.8707495237536, 4175.331946888544, 4278.72188307759, 4311.137772445523, 4389.604935555815, 1131.4003578103618, 1423.1318895473753, 1441.8990670653163, 1457.985420145785, 1474.3586539855198, 911.1844898815656, 915.9816803663889, 964.3972517176765, 990.6285143071349, 1006.4917216805612, 6027.276726792726, 6086.756529738761, 6125.356837532084, 6258.15514905491, 6259.186305780219, 1016.5476363018386, 1018.1752780248023, 1022.197574903697, 1056.3556230699267, 1066.8026415113075, 4026.1746342000406, 4074.633283004544, 4149.149424367997, 4179.331306990867, 4183.1215444756945, 10972.067374273116, 11406.885931140749, 11420.42897855104, 11537.423128843524, 11569.958703716706, 10951.288166269167, 11215.55137794479, 11295.774084518263, 11309.886901130883, 11409.942950285362, 8533.402661813738, 8831.425957312755, 8871.334649901282, 8927.553622318988, 8951.955240223888, 6026.608270462406, 6036.396360363929, 6052.394760523913, 6083.513318934563, 6114.113453549122, 9735.318527703275, 9879.950600246953, 9960.800783984134, 9978.850317245102, 10146.086852183338, 10044.547995340374, 10416.895831041593, 10430.322029068086, 10613.787724245318, 10634.361938283728, 6743.1908171019795, 6925.411340036153, 7143.964280178774, 7384.224656410999, 7466.178720340867, 8552.230299273095, 8552.615132319184, 8619.827603447771, 8630.78423039429, 8646.82706345857, 7512.173660897188, 7645.0, 7662.770116896502, 7682.116556596063, 7768.572728499987, 6413.967930160319, 7372.778816635509, 7373.668184931584, 7427.517211381243, 7438.330550250504, 6964.512484126265, 7260.0, 7316.378107860892, 7323.890141647773, 7328.670209840463, 4674.22875225584, 4802.759862006956, 5026.974865125651, 5111.488851114858, 5127.1540195867265, 5038.622103342191, 5071.2139618359215, 5116.15583428745, 5150.356205474316, 5257.447967963309], "value": 4820.494088230196, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.75369443362007, 326.34079160096604, 343.32193917013893, 344.44716230450126, 347.72529701535785, 5817.807349493354, 6754.763583274574, 6789.966050169743, 6898.0, 7107.6446177691105, 6998.8250293742685, 7003.789886303419, 7047.823804404892, 7073.434125269979, 7084.149902011753, 5118.28344031834, 5129.846104616868, 5130.050940575987, 5144.536991670749, 5147.794088236466, 4195.769232692201, 5116.360454943114, 5155.639105262633, 5170.405403378622, 5172.482751724816, 5052.115879721053, 5064.139096353629, 5068.847934561969, 5070.974645126769, 5076.84769456915, 4953.207486802113, 5024.799008039692, 5097.541221290065, 5098.158803797369, 5111.4121875984365, 4338.414314067592, 4348.108637729258, 4356.411884395629, 4385.144896745136, 4385.429894113745, 6715.832104197385, 6721.865562688768, 6750.527463077587, 6753.15585551806, 6754.2907994660345, 4434.93347599783, 5253.579713622901, 5433.9675461662155, 6045.516358691338, 6054.788082417138, 7438.73964411243, 7445.069366329209, 7445.627718614048, 7459.888101678479, 7509.324160825552, 4346.782660866944, 4581.977090114561, 4761.714297142183, 4794.832180873687, 4868.707877527324, 6329.430351268362, 7826.726064587769, 7843.098043724987, 7877.645505952246, 7883.3299169570655, 4829.66192366538, 4831.275308703723, 4842.201036828884, 4847.175980083394, 4857.684250523705, 4941.851744447672, 4945.653804233741, 4955.1823949048, 4959.876003099879, 4960.131976904027, 4803.711777293373, 5899.321578018497, 5911.9113213301835, 5942.376050514634, 5981.581289309794, 6433.292337842833, 7422.443316751265, 7430.517016393917, 7435.107787065586, 7480.401567874557, 1678.404166520892, 1686.4856218853367, 1699.4137022727139, 1703.5996540812898, 1715.8589537957118, 1013.159077965287, 1057.8571892794528, 1062.3201151263197, 1071.4374953149502, 1083.9349639021527, 7033.191183014019, 7050.506464547432, 7065.788026359218, 7068.646567671596, 7160.892586611205, 6167.352427994996, 7672.079350477979, 7720.0, 7736.226377362219, 7754.883676744853, 7081.575105493584, 7089.82275443118, 7102.183248926336, 7104.6447677615915, 7126.251743566954, 3290.4899740540254, 3961.564227934925, 4075.572064933199, 4090.5091389033505, 4099.221147981874, 6823.658817059128, 8115.823205635268, 8225.95639613335, 8231.629576669064, 8306.044804847399, 7946.721864734822, 8075.5558444286125, 8097.757067287991, 8112.513249205066, 8130.715424960098, 8209.71266005687, 8236.546989915492, 8246.257836794717, 8280.420370574002, 8292.087870334259, 6109.541784366102, 7688.577128258, 7714.498557593738, 7782.805429864298, 7799.298063174341, 6388.776392826228, 7451.764470658889, 7618.200088990576, 7670.232976702285, 7696.191899850435, 8251.793705157419, 8259.793505162419, 8263.586820659064, 8275.62759675828, 8293.917060829315, 4824.614030877591, 4876.268559716071, 4880.92678609814, 4883.804647814048, 4908.239222920453, 7561.508501947355, 7790.688372465038, 7808.921910781047, 7813.609319534115, 7816.765497035098, 7413.777586672409, 7507.924920750723, 7513.737019204302, 7533.284337987882, 7554.131274903457, 7513.586752728653, 7515.060617422822, 7515.511491753018, 7524.05949256343, 7527.247275272429, 7123.7506687265695, 7292.088488938883, 7339.339459448675, 7341.229170937188, 7354.852902941804, 7451.44114191427, 7506.624668766649, 7520.285572870568, 7548.471606987678, 7555.0, 7010.789676309719, 7126.35862772353, 7351.191368949519, 7355.411567074728, 7381.224971377928], "value": 5395.202110827352, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.1249394455458, 751.8120469882529, 762.9275218854207, 764.9082110146783, 778.9610519474024, 12564.371781410915, 14975.0, 15162.696746065087, 15381.615459613515, 15387.769183462256, 14274.928625356859, 14355.71288574228, 14365.78451323231, 14366.0, 14383.568492945202, 763.2215140556629, 797.832455184412, 964.0118878149917, 968.3124981263312, 968.6416026070328, 955.44106697582, 962.0139357158934, 964.2189826240732, 964.7877466957293, 964.898685638005, 984.2618036472645, 999.1656966433037, 1027.1679939249195, 1028.9073983341498, 1029.5572903651428, 980.5342462330372, 980.8332583460829, 991.4299277915192, 995.7261753017978, 1023.0945613132357, 731.6890321613294, 733.9376153026999, 751.0799270893167, 764.0067911714804, 766.4558163703776, 15004.874634402355, 15060.096394216382, 15123.243837808066, 15474.303656335493, 15474.922625386802, 13260.20438773667, 13276.269805160713, 13331.800022999663, 13444.529441469502, 13471.595852124452, 10391.948040259826, 10419.270651054429, 10453.32053416533, 10457.320274182153, 10783.245172837904, 3538.716902647782, 3546.733994950389, 3570.071781336845, 3611.7291203159607, 3664.0, 77606.0, 78754.21245787526, 78869.21130788734, 78931.60534197293, 82545.0, 9975.900240997642, 10003.349782264275, 10115.342502737298, 10155.64455244063, 10549.9472502637, 22606.321810345715, 22781.430464238525, 23114.768852311263, 23418.414539636644, 23422.297331080095, 6747.325267473311, 7664.9616751917, 7831.2560306770765, 7854.2145785421, 7933.56365399897, 4100.6924480664065, 4112.239235741397, 4176.477940257468, 4187.832486700559, 4215.252414627008, 3154.1010811918495, 3314.734821214297, 3668.3763760160837, 3672.3022625701033, 3715.6098609646137, 673.6564352180424, 683.3269229808634, 685.5064353665352, 694.6908625661633, 695.2630211975322, 531.9202119682001, 535.5913946321228, 559.739721029715, 567.8410045187354, 607.2500461929513, 8281.875771863426, 8323.916760832435, 8398.622062007224, 8400.873986890201, 8479.565775860787, 600.0369407101626, 613.8066509049635, 613.9120225266914, 614.9569530132937, 626.5301024231826, 3770.208256266215, 3779.6976241900584, 3793.5827059023486, 3943.7633741975574, 3965.940510892339, 89244.21511569733, 91565.0, 92045.0, 92635.0, 96604.0, 65431.34568654348, 68352.26590936306, 76837.0, 77621.83567246496, 78168.0, 53688.0, 69318.30681693219, 70196.64901675459, 70234.64882675554, 71126.64436677784, 7461.589612571361, 7657.502262352929, 7698.846023079619, 7775.844483110419, 8001.0, 49844.50466486011, 50200.0, 50409.74795126001, 51086.48913510966, 51331.0, 51304.48695512997, 62466.375336246056, 62512.37487625066, 65462.69074618386, 67277.0, 10396.532156053147, 10461.163106951273, 10956.616518421817, 11372.886271137513, 11430.885691142983, 11773.47019384147, 11811.645650630495, 11848.696643369394, 11922.701932451759, 12024.398780060787, 10951.233413660968, 11121.610743623934, 11242.269252498561, 11270.83093753578, 11631.59289424866, 11023.944880275547, 11035.944820275847, 11141.387223702774, 11385.658430247106, 12262.20295680778, 10895.455227238765, 11185.66443006711, 11243.269187502787, 11414.201005929504, 11466.140039496904, 9297.581608827484, 9341.2994025447, 9366.531673416439, 9522.809543809224, 9525.90474095278, 9757.853632195382, 9798.0, 9892.653757118755, 9992.450415227233, 10019.849702254327], "value": 6980.742504250096, "unit": "score"}], "name": "dromaeo_css", "value": 7667.728176389294, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 116.0, 116.0, 136.0, 198.0, 152.0, 116.0, 116.0, 116.0], "value": 129.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 141.0, 160.0, 135.0, 140.0, 120.0, 162.0, 188.0, 151.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 195.0, 193.0, 204.0, 268.0, 268.0, 199.0, 260.0, 194.0, 195.0], "value": 217.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 90.0, 153.0, 58.0, 56.0, 58.0, 69.0, 129.0, 63.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 120.0, 65.0, 84.0, 143.0, 159.0, 120.0, 89.0, 126.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 86.0, 128.0, 130.0, 128.0, 86.0, 90.0, 88.0], "value": 100.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 118.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 96.0, 89.0, 89.0, 92.0, 89.0, 91.0, 93.0, 91.0, 90.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0, 79.0, 62.0, 61.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 72.0, 77.0, 68.0, 65.0, 64.0, 65.0, 86.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 80.0, 89.0, 75.0, 80.0, 82.0, 82.0, 85.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 126.0, 126.0, 128.0, 127.0, 127.0, 125.0, 181.0, 172.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 210.0, 167.0, 167.0, 163.0, 166.0, 210.0, 167.0, 174.0, 165.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 103.0, 101.0, 83.0, 69.0, 66.0, 69.0, 69.0, 67.0, 69.0], "value": 76.3, "unit": "score"}], "name": "kraken", "value": 1579.5, "alertThreshold": 2.0}]} 11:27:18 INFO - Return code: 0 11:27:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:18 ERROR - # TBPL SUCCESS # 11:27:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:27:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:27:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:27:18 INFO - 2016-07-05 11:27:18.842 screenresolution[1964:21490] starting screenresolution argv=screenresolution get 11:27:18 INFO - 2016-07-05 11:27:18.844 screenresolution[1964:21490] Display 0: 1600x1200x32@60 11:27:18 INFO - 2016-07-05 11:27:18.850 screenresolution[1965:21494] starting screenresolution argv=screenresolution list 11:27:18 INFO - Available Modes on Display 0 11:27:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:27:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:27:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:27:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:27:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:27:19 INFO - Intel Iris: 11:27:19 INFO - Chipset Model: Intel Iris 11:27:19 INFO - Type: GPU 11:27:19 INFO - Bus: Built-In 11:27:19 INFO - VRAM (Dynamic, Max): 1536 MB 11:27:19 INFO - Vendor: Intel (0x8086) 11:27:19 INFO - Device ID: 0x0a2e 11:27:19 INFO - Revision ID: 0x0009 11:27:19 INFO - Displays: 11:27:19 INFO - Display: 11:27:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:27:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:27:19 INFO - Display Serial Number: 1600x1200 60 11:27:19 INFO - Main Display: Yes 11:27:19 INFO - Mirror: Off 11:27:19 INFO - Online: Yes 11:27:19 INFO - Rotation: Supported 11:27:19 INFO - Return code: 0 11:27:19 INFO - Running post-action listener: _resource_record_post_action 11:27:19 INFO - Running post-run listener: _resource_record_post_run 11:27:20 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 331776; Write bytes: 497226240; Read time: 8; Write time: 1653 11:27:20 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189010432; Write bytes: 187123200; Read time: 17199; Write time: 390 11:27:20 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 331776; Write bytes: 299310080; Read time: 8; Write time: 1227 11:27:20 INFO - Running post-run listener: _upload_blobber_files 11:27:20 INFO - Blob upload gear active. 11:27:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:20 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 11:27:20 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'] 11:27:20 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 11:27:20 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:27:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:27:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:21 INFO - (blobuploader) - INFO - Done attempting. 11:27:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:27:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:27:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:22 INFO - (blobuploader) - INFO - Done attempting. 11:27:22 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:22 INFO - Return code: 0 11:27:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cec0332073db7242662757940f6ed33ee404e563cc861e22c2606660a9bdb9baec91b90d72dac17dfd608959a140f80be3ca3d17774459d1ca7ecc06be5e2c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7beadc25881241713f4c93e0b2f625577e7ce6b916f9876c6e0925e8a227f53c0d5226861204a3713eb6aca431956407bde5801c95adc5726b87cecc982eb86"} 11:27:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:22 INFO - Contents: 11:27:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cec0332073db7242662757940f6ed33ee404e563cc861e22c2606660a9bdb9baec91b90d72dac17dfd608959a140f80be3ca3d17774459d1ca7ecc06be5e2c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7beadc25881241713f4c93e0b2f625577e7ce6b916f9876c6e0925e8a227f53c0d5226861204a3713eb6aca431956407bde5801c95adc5726b87cecc982eb86"} 11:27:22 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:22 INFO - Copying logs to upload dir... 11:27:22 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.371731 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-05 11:27:22.842934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:27:22.848167) ========= 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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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/cec0332073db7242662757940f6ed33ee404e563cc861e22c2606660a9bdb9baec91b90d72dac17dfd608959a140f80be3ca3d17774459d1ca7ecc06be5e2c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7beadc25881241713f4c93e0b2f625577e7ce6b916f9876c6e0925e8a227f53c0d5226861204a3713eb6aca431956407bde5801c95adc5726b87cecc982eb86"} build_url:https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/YOjKzcLgShqRataDmTP29w/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/cec0332073db7242662757940f6ed33ee404e563cc861e22c2606660a9bdb9baec91b90d72dac17dfd608959a140f80be3ca3d17774459d1ca7ecc06be5e2c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7beadc25881241713f4c93e0b2f625577e7ce6b916f9876c6e0925e8a227f53c0d5226861204a3713eb6aca431956407bde5801c95adc5726b87cecc982eb86"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:27:22.881568) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:27:22.881918) ========= 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.Dn6OQme2Gy/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.i5DCSaqiB4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.004852 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:27:22.930965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:27:22.931292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:27:22.931614) ========= ========= Total master_lag: 0.18 =========