builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1467949335.63 results: success (0) buildid: 20160707183926 builduid: 328b1b0c396c47e78703d0d1de60df83 revision: f4e161a1dd38df3f4679d7b647371e2388e7eb72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.632089) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.632578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.632954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.684830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.685357) ========= 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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-07 20:42:15-- 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% 6.25M=0.002s 2016-07-07 20:42:15 (6.25 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.816289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.816725) ========= 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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.020996 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:15.866087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 20:42:15.866529) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f4e161a1dd38df3f4679d7b647371e2388e7eb72 --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 f4e161a1dd38df3f4679d7b647371e2388e7eb72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9tRtVH8RzU/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.iJdHd8Qq39/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-07 20:42:15,940 truncating revision to first 12 chars 2016-07-07 20:42:15,940 Setting DEBUG logging. 2016-07-07 20:42:15,940 attempt 1/10 2016-07-07 20:42:15,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f4e161a1dd38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 20:42:16,654 unpacking tar archive at: mozilla-beta-f4e161a1dd38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.980634 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 20:42:16.869650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:16.870030) ========= script_repo_revision: f4e161a1dd38df3f4679d7b647371e2388e7eb72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:16.870466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:16.870798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:16.889135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-07-07 20:42:16.889592) ========= /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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:42:17 INFO - MultiFileLogger online at 20160707 20:42:17 in /builds/slave/test 20:42:17 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 20:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:42:17 INFO - {'append_to_log': False, 20:42:17 INFO - 'base_work_dir': '/builds/slave/test', 20:42:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:42:17 INFO - 'branch': 'Mozilla-Beta', 20:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 20:42:17 INFO - 'config_files': ('talos/mac_config.py',), 20:42:17 INFO - 'default_actions': ('clobber', 20:42:17 INFO - 'read-buildbot-config', 20:42:17 INFO - 'download-and-extract', 20:42:17 INFO - 'populate-webroot', 20:42:17 INFO - 'create-virtualenv', 20:42:17 INFO - 'install', 20:42:17 INFO - 'run-tests'), 20:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:42:17 INFO - 'download_minidump_stackwalk': True, 20:42:17 INFO - 'download_symbols': 'ondemand', 20:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 20:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 20:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:42:17 INFO - 'installer_path': 'installer.exe', 20:42:17 INFO - 'log_level': 'info', 20:42:17 INFO - 'log_name': 'talos', 20:42:17 INFO - 'log_to_console': True, 20:42:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:42:17 INFO - 'opt_config_files': (), 20:42:17 INFO - 'pip_index': False, 20:42:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:42:17 INFO - 'cmd': ('bash', 20:42:17 INFO - '-c', 20:42:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:42:17 INFO - 'enabled': True, 20:42:17 INFO - 'halt_on_failure': False, 20:42:17 INFO - 'name': 'check_screen_resolution'},), 20:42:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:42:17 INFO - 'cmd': ('bash', 20:42:17 INFO - '-c', 20:42:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:42:17 INFO - 'enabled': True, 20:42:17 INFO - 'halt_on_failure': False, 20:42:17 INFO - 'name': 'check_screen_resolution'},), 20:42:17 INFO - 'run_cmd_checks_enabled': True, 20:42:17 INFO - 'sps_profile': False, 20:42:17 INFO - 'sps_profile_interval': 0, 20:42:17 INFO - 'suite': 'dromaeojs-e10s', 20:42:17 INFO - 'system_bits': '32', 20:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:42:17 INFO - 'title': 't-yosemite-r7-0083', 20:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:42:17 INFO - 'use_talos_json': True, 20:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:42:17 INFO - 'work_dir': 'build'} 20:42:17 INFO - ##### 20:42:17 INFO - ##### Running clobber step. 20:42:17 INFO - ##### 20:42:17 INFO - Running pre-action listener: _resource_record_pre_action 20:42:17 INFO - Running main action method: clobber 20:42:17 INFO - rmtree: /builds/slave/test/build 20:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:42:17 INFO - Running post-action listener: _resource_record_post_action 20:42:17 INFO - ##### 20:42:17 INFO - ##### Running read-buildbot-config step. 20:42:17 INFO - ##### 20:42:17 INFO - Running pre-action listener: _resource_record_pre_action 20:42:17 INFO - Running main action method: read_buildbot_config 20:42:17 INFO - Using buildbot properties: 20:42:17 INFO - { 20:42:17 INFO - "project": "", 20:42:17 INFO - "product": "firefox", 20:42:17 INFO - "script_repo_revision": "production", 20:42:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 20:42:17 INFO - "repository": "", 20:42:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 20:42:17 INFO - "buildid": "20160707183926", 20:42:17 INFO - "pgo_build": "False", 20:42:17 INFO - "basedir": "/builds/slave/test", 20:42:17 INFO - "buildnumber": 19, 20:42:17 INFO - "slavename": "t-yosemite-r7-0083", 20:42:17 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:42:17 INFO - "platform": "yosemite_r7", 20:42:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:42:17 INFO - "branch": "mozilla-beta", 20:42:17 INFO - "repo_path": "releases/mozilla-beta", 20:42:17 INFO - "revision": "f4e161a1dd38df3f4679d7b647371e2388e7eb72", 20:42:17 INFO - "stage_platform": "macosx64", 20:42:17 INFO - "builduid": "328b1b0c396c47e78703d0d1de60df83", 20:42:17 INFO - "slavebuilddir": "test" 20:42:17 INFO - } 20:42:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 20:42:17 INFO - Running post-action listener: _resource_record_post_action 20:42:17 INFO - ##### 20:42:17 INFO - ##### Running download-and-extract step. 20:42:17 INFO - ##### 20:42:17 INFO - Running pre-action listener: _resource_record_pre_action 20:42:17 INFO - Running main action method: download_and_extract 20:42:17 INFO - mkdir: /builds/slave/test/build/tests 20:42: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')]} 20:42:17 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 20:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 20:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:25 INFO - Downloaded 1165 bytes. 20:42:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:42:25 INFO - Using the following test package requirements: 20:42:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:42:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 20:42:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 20:42:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:42:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 20:42:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:42:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 20:42:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 20:42:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 20:42:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 20:42:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 20:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:42:25 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:29 INFO - Downloaded 18351528 bytes. 20:42:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:42:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:42:32 INFO - Return code: 0 20:42:32 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:32 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:42:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:46 INFO - Downloaded 18351528 bytes. 20:42:46 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'] 20:42:46 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 20:42:49 INFO - Return code: 0 20:42:49 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')]} 20:42:49 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:42:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 20:42:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 20:42:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:50 INFO - Downloaded 10840145 bytes. 20:42:50 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'] 20:42:50 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 20:42:50 INFO - Return code: 0 20:42:50 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')]} 20:42:50 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 20:42:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 20:42:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:54 INFO - Downloaded 86190245 bytes. 20:42:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:54 INFO - mkdir: /builds/slave/test/properties 20:42:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:42:54 INFO - Writing to file /builds/slave/test/properties/build_url 20:42:54 INFO - Contents: 20:42:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:55 INFO - Running post-action listener: _resource_record_post_action 20:42:55 INFO - Running post-action listener: set_extra_try_arguments 20:42:55 INFO - ##### 20:42:55 INFO - ##### Running populate-webroot step. 20:42:55 INFO - ##### 20:42:55 INFO - Running pre-action listener: _resource_record_pre_action 20:42:55 INFO - Running main action method: populate_webroot 20:42:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:42:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:42:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:42:55 INFO - '--tppagecycles', 20:42:55 INFO - '7'], 20:42:55 INFO - 'tests': ['tsvgm']}}, 20:42:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:42:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:42:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:42:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:42:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['damp', 'tps']}, 20:42:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'tests': ['damp', 'tps']}, 20:42:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['dromaeo_dom']}, 20:42:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:42:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['a11yr', 20:42:55 INFO - 'ts_paint', 20:42:55 INFO - 'tpaint', 20:42:55 INFO - 'sessionrestore', 20:42:55 INFO - 'sessionrestore_no_auto_restore', 20:42:55 INFO - 'tabpaint']}, 20:42:55 INFO - 'other-e10s': {'tests': ['a11yr', 20:42:55 INFO - 'ts_paint', 20:42:55 INFO - 'tpaint', 20:42:55 INFO - 'sessionrestore', 20:42:55 INFO - 'sessionrestore_no_auto_restore', 20:42:55 INFO - 'tabpaint']}, 20:42:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:42:55 INFO - 'ts_paint', 20:42:55 INFO - 'tpaint', 20:42:55 INFO - 'sessionrestore', 20:42:55 INFO - 'sessionrestore_no_auto_restore', 20:42:55 INFO - 'tabpaint']}, 20:42:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:42:55 INFO - 'ts_paint', 20:42:55 INFO - 'tpaint', 20:42:55 INFO - 'sessionrestore', 20:42:55 INFO - 'sessionrestore_no_auto_restore', 20:42:55 INFO - 'tabpaint']}, 20:42:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['a11yr', 20:42:55 INFO - 'ts_paint', 20:42:55 INFO - 'tpaint', 20:42:55 INFO - 'sessionrestore', 20:42:55 INFO - 'sessionrestore_no_auto_restore', 20:42:55 INFO - 'tabpaint']}, 20:42:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['a11yr', 20:42:55 INFO - 'ts_paint', 20:42:55 INFO - 'tpaint', 20:42:55 INFO - 'sessionrestore', 20:42:55 INFO - 'sessionrestore_no_auto_restore', 20:42:55 INFO - 'tabpaint']}, 20:42:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['tsvgx', 20:42:55 INFO - 'tsvgr_opacity', 20:42:55 INFO - 'tart', 20:42:55 INFO - 'tscrollx', 20:42:55 INFO - 'cart']}, 20:42:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:42:55 INFO - 'tsvgr_opacity', 20:42:55 INFO - 'tart', 20:42:55 INFO - 'tscrollx', 20:42:55 INFO - 'cart']}, 20:42:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'talos_options': ['--disable-e10s'], 20:42:55 INFO - 'tests': ['tp5o']}, 20:42:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'tests': ['tp5o']}, 20:42:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'talos_options': ['--disable-e10s', 20:42:55 INFO - '--xperf_path', 20:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:55 INFO - 'tests': ['tp5n']}, 20:42:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:55 INFO - 'talos_options': ['--xperf_path', 20:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:55 INFO - 'tests': ['tp5n']}}, 20:42:55 INFO - 'talos.zip': {'path': '', 20:42:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:42:55 INFO - Running post-action listener: _resource_record_post_action 20:42:55 INFO - ##### 20:42:55 INFO - ##### Running create-virtualenv step. 20:42:55 INFO - ##### 20:42:55 INFO - Running pre-action listener: _resource_record_pre_action 20:42:55 INFO - Running main action method: create_virtualenv 20:42:55 INFO - Creating virtualenv /builds/slave/test/build/venv 20:42:55 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 20:42:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:42:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:42:55 INFO - Using real prefix '/tools/python27' 20:42:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:42:56 INFO - Installing distribute.............................................................................................................................................................................................done. 20:42:59 INFO - Installing pip.................done. 20:42:59 INFO - Return code: 0 20:42:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:42: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')]} 20:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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')]} 20:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:42: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', 'pip>=1.5'] in /builds/slave/test/build 20:42: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 pip>=1.5 20:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:42:59 INFO - 'HOME': '/Users/cltbld', 20:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:42:59 INFO - 'LOGNAME': 'cltbld', 20:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:59 INFO - 'MOZ_NO_REMOTE': '1', 20:42:59 INFO - 'NO_EM_RESTART': '1', 20:42:59 INFO - 'PAGER': '/bin/cat', 20:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:59 INFO - 'PWD': '/builds/slave/test', 20:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:42:59 INFO - 'SHELL': '/bin/bash', 20:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:42:59 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:42:59 INFO - 'USER': 'cltbld', 20:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:59 INFO - 'XPC_FLAGS': '0x0', 20:42:59 INFO - 'XPC_SERVICE_NAME': '0', 20:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:59 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 20:42:59 INFO - Cleaning up... 20:42:59 INFO - Return code: 0 20:42:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:42: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')]} 20:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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')]} 20:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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', '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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:42: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', 'psutil>=0.7.1'] in /builds/slave/test/build 20:42: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 psutil>=0.7.1 20:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:42:59 INFO - 'HOME': '/Users/cltbld', 20:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:42:59 INFO - 'LOGNAME': 'cltbld', 20:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:59 INFO - 'MOZ_NO_REMOTE': '1', 20:42:59 INFO - 'NO_EM_RESTART': '1', 20:42:59 INFO - 'PAGER': '/bin/cat', 20:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:59 INFO - 'PWD': '/builds/slave/test', 20:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:42:59 INFO - 'SHELL': '/bin/bash', 20:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:42:59 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:42:59 INFO - 'USER': 'cltbld', 20:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:59 INFO - 'XPC_FLAGS': '0x0', 20:42:59 INFO - 'XPC_SERVICE_NAME': '0', 20:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:59 INFO - Downloading/unpacking psutil>=0.7.1 20:42:59 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 20:42:59 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 20:42:59 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 20:42:59 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 20:42:59 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 20:42:59 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 20:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:43:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:43:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:43:02 INFO - Installing collected packages: psutil 20:43:02 INFO - Running setup.py install for psutil 20:43:02 INFO - building 'psutil._psutil_osx' extension 20:43:02 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 20:43:02 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 20:43:02 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 20:43:03 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 20:43:03 INFO - building 'psutil._psutil_posix' extension 20:43:03 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 20:43:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:43:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:43:03 INFO - ^ 20:43:03 INFO - 1 warning generated. 20:43:03 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 20:43:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:43:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:43:03 INFO - Successfully installed psutil 20:43:03 INFO - Cleaning up... 20:43:03 INFO - Return code: 0 20:43:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:03 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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:43:03 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 20:43:03 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 20:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:03 INFO - 'HOME': '/Users/cltbld', 20:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:03 INFO - 'LOGNAME': 'cltbld', 20:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:03 INFO - 'MOZ_NO_REMOTE': '1', 20:43:03 INFO - 'NO_EM_RESTART': '1', 20:43:03 INFO - 'PAGER': '/bin/cat', 20:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:03 INFO - 'PWD': '/builds/slave/test', 20:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:03 INFO - 'SHELL': '/bin/bash', 20:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:03 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:03 INFO - 'USER': 'cltbld', 20:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:03 INFO - 'XPC_FLAGS': '0x0', 20:43:03 INFO - 'XPC_SERVICE_NAME': '0', 20:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:43:06 INFO - Installing collected packages: mozsystemmonitor 20:43:06 INFO - Running setup.py install for mozsystemmonitor 20:43:06 INFO - Successfully installed mozsystemmonitor 20:43:06 INFO - Cleaning up... 20:43:06 INFO - Return code: 0 20:43:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:06 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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:43:06 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 20:43:06 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 20:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:06 INFO - 'HOME': '/Users/cltbld', 20:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:06 INFO - 'LOGNAME': 'cltbld', 20:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:06 INFO - 'MOZ_NO_REMOTE': '1', 20:43:06 INFO - 'NO_EM_RESTART': '1', 20:43:06 INFO - 'PAGER': '/bin/cat', 20:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:06 INFO - 'PWD': '/builds/slave/test', 20:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:06 INFO - 'SHELL': '/bin/bash', 20:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:06 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:06 INFO - 'USER': 'cltbld', 20:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:06 INFO - 'XPC_FLAGS': '0x0', 20:43:06 INFO - 'XPC_SERVICE_NAME': '0', 20:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:06 INFO - Downloading/unpacking blobuploader==1.2.4 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43:09 INFO - Downloading blobuploader-1.2.4.tar.gz 20:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:43:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:43:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:10 INFO - Downloading docopt-0.6.1.tar.gz 20:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:43:10 INFO - Installing collected packages: blobuploader, requests, docopt 20:43:10 INFO - Running setup.py install for blobuploader 20:43:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:43:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:43:10 INFO - Running setup.py install for requests 20:43:11 INFO - Running setup.py install for docopt 20:43:11 INFO - Successfully installed blobuploader requests docopt 20:43:11 INFO - Cleaning up... 20:43:11 INFO - Return code: 0 20:43:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:11 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')]} 20:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:11 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')]} 20:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:11 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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:43:11 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 20:43:11 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 20:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:11 INFO - 'HOME': '/Users/cltbld', 20:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:11 INFO - 'LOGNAME': 'cltbld', 20:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:11 INFO - 'MOZ_NO_REMOTE': '1', 20:43:11 INFO - 'NO_EM_RESTART': '1', 20:43:11 INFO - 'PAGER': '/bin/cat', 20:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:11 INFO - 'PWD': '/builds/slave/test', 20:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:11 INFO - 'SHELL': '/bin/bash', 20:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:11 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:11 INFO - 'USER': 'cltbld', 20:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:11 INFO - 'XPC_FLAGS': '0x0', 20:43:11 INFO - 'XPC_SERVICE_NAME': '0', 20:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:43:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-R5wOPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:43:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-rkQRHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:43:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Ng2s8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:43:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-7pRHlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-h_y8s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-UPsPZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-qnSQzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-mxSK0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-747sj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Jw0VzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RvuAE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-uNSDxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Ww3Aid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:43:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-I5kP6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:13 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-5YjQck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:43:13 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-yajiz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:43:13 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ZRha1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:43:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:43:13 INFO - Running setup.py install for manifestparser 20:43:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:43:13 INFO - Running setup.py install for mozcrash 20:43:13 INFO - Running setup.py install for mozdebug 20:43:13 INFO - Running setup.py install for mozdevice 20:43:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:43:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:43:13 INFO - Running setup.py install for mozfile 20:43:14 INFO - Running setup.py install for mozhttpd 20:43:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:43:14 INFO - Running setup.py install for mozinfo 20:43:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:43:14 INFO - Running setup.py install for mozInstall 20:43:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:43:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:43:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:43:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:43:14 INFO - Running setup.py install for mozleak 20:43:14 INFO - Running setup.py install for mozlog 20:43:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:43:14 INFO - Running setup.py install for moznetwork 20:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:43:15 INFO - Running setup.py install for mozprocess 20:43:15 INFO - Running setup.py install for mozprofile 20:43:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:43:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:43:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:43:15 INFO - Running setup.py install for mozrunner 20:43:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:43:15 INFO - Running setup.py install for mozscreenshot 20:43:15 INFO - Running setup.py install for moztest 20:43:15 INFO - Running setup.py install for mozversion 20:43:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:43:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:43:15 INFO - Cleaning up... 20:43:15 INFO - Return code: 0 20:43:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:15 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')]} 20:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:16 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')]} 20:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:16 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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:43:16 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 20:43:16 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 20:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:16 INFO - 'HOME': '/Users/cltbld', 20:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:16 INFO - 'LOGNAME': 'cltbld', 20:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:16 INFO - 'MOZ_NO_REMOTE': '1', 20:43:16 INFO - 'NO_EM_RESTART': '1', 20:43:16 INFO - 'PAGER': '/bin/cat', 20:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:16 INFO - 'PWD': '/builds/slave/test', 20:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:16 INFO - 'SHELL': '/bin/bash', 20:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:16 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:16 INFO - 'USER': 'cltbld', 20:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:16 INFO - 'XPC_FLAGS': '0x0', 20:43:16 INFO - 'XPC_SERVICE_NAME': '0', 20:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:43:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-kUlc5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:43:16 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)) 20:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:43:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dbvg_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:43:16 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)) 20:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:43:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-4p1Fza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wWCIn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Qs_akx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-DZ83c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-09s88T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-az8HFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-a8ss02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-0KMccc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-PrxEqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:43:17 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)) 20:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:43:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-r5lMUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:43:18 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)) 20:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:43:18 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-57kWyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:43:18 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)) 20:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:43:18 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-muE4MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:43:18 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)) 20:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:18 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-3uiyjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:18 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)) 20:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:43:18 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-I188ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:43:18 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)) 20:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:43:18 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-2Ld45k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:43:18 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)) 20:43:18 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)) 20:43:18 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)) 20:43:18 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)) 20:43:18 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)) 20:43:18 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)) 20:43:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43:21 INFO - Downloading blessings-1.6.tar.gz 20:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:43:21 INFO - Installing collected packages: blessings 20:43:21 INFO - Running setup.py install for blessings 20:43:22 INFO - Successfully installed blessings 20:43:22 INFO - Cleaning up... 20:43:22 INFO - Return code: 0 20:43:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:43:22 INFO - Reading from file tmpfile_stdout 20:43:22 INFO - Current package versions: 20:43:22 INFO - blessings == 1.6 20:43:22 INFO - blobuploader == 1.2.4 20:43:22 INFO - docopt == 0.6.1 20:43:22 INFO - manifestparser == 1.1 20:43:22 INFO - mozInstall == 1.12 20:43:22 INFO - mozcrash == 0.17 20:43:22 INFO - mozdebug == 0.1 20:43:22 INFO - mozdevice == 0.48 20:43:22 INFO - mozfile == 1.2 20:43:22 INFO - mozhttpd == 0.7 20:43:22 INFO - mozinfo == 0.9 20:43:22 INFO - mozleak == 0.1 20:43:22 INFO - mozlog == 3.1 20:43:22 INFO - moznetwork == 0.27 20:43:22 INFO - mozprocess == 0.22 20:43:22 INFO - mozprofile == 0.28 20:43:22 INFO - mozrunner == 6.11 20:43:22 INFO - mozscreenshot == 0.1 20:43:22 INFO - mozsystemmonitor == 0.0 20:43:22 INFO - moztest == 0.7 20:43:22 INFO - mozversion == 1.4 20:43:22 INFO - psutil == 3.1.1 20:43:22 INFO - requests == 1.2.3 20:43:22 INFO - wsgiref == 0.1.2 20:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:22 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')]} 20:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:22 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')]} 20:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:22 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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:43:22 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 20:43:22 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 20:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:22 INFO - 'HOME': '/Users/cltbld', 20:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:22 INFO - 'LOGNAME': 'cltbld', 20:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:22 INFO - 'MOZ_NO_REMOTE': '1', 20:43:22 INFO - 'NO_EM_RESTART': '1', 20:43:22 INFO - 'PAGER': '/bin/cat', 20:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:22 INFO - 'PWD': '/builds/slave/test', 20:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:22 INFO - 'SHELL': '/bin/bash', 20:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:22 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:22 INFO - 'USER': 'cltbld', 20:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:22 INFO - 'XPC_FLAGS': '0x0', 20:43:22 INFO - 'XPC_SERVICE_NAME': '0', 20:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 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)) 20:43:22 INFO - Cleaning up... 20:43:22 INFO - Return code: 0 20:43:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:43:22 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')]} 20:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:22 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')]} 20:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:22 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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:43:22 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 20:43:22 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 20:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:22 INFO - 'HOME': '/Users/cltbld', 20:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:22 INFO - 'LOGNAME': 'cltbld', 20:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:22 INFO - 'MOZ_NO_REMOTE': '1', 20:43:22 INFO - 'NO_EM_RESTART': '1', 20:43:22 INFO - 'PAGER': '/bin/cat', 20:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:22 INFO - 'PWD': '/builds/slave/test', 20:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:22 INFO - 'SHELL': '/bin/bash', 20:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:22 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:22 INFO - 'USER': 'cltbld', 20:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:22 INFO - 'XPC_FLAGS': '0x0', 20:43:22 INFO - 'XPC_SERVICE_NAME': '0', 20:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:22 INFO - Downloading/unpacking jsonschema 20:43:22 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 20:43:22 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 20:43:22 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 20:43:22 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 20:43:22 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 20:43:22 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 20:43:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:43:25 INFO - Downloading/unpacking functools32 (from jsonschema) 20:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:25 INFO - Downloading functools32-3.2.3-2.tar.gz 20:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:43:25 INFO - warning: no files found matching '*.txt' 20:43:25 INFO - no previously-included directories found matching 'build' 20:43:25 INFO - no previously-included directories found matching 'dist' 20:43:25 INFO - no previously-included directories found matching '.git*' 20:43:25 INFO - Installing collected packages: jsonschema, functools32 20:43:25 INFO - Running setup.py install for functools32 20:43:26 INFO - warning: no files found matching '*.txt' 20:43:26 INFO - no previously-included directories found matching 'build' 20:43:26 INFO - no previously-included directories found matching 'dist' 20:43:26 INFO - no previously-included directories found matching '.git*' 20:43:26 INFO - Successfully installed jsonschema functools32 20:43:26 INFO - Cleaning up... 20:43:26 INFO - Return code: 0 20:43:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:26 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 0x102312a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102322420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0335a2010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, '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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 20:43:26 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 20:43:26 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 20:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:26 INFO - 'HOME': '/Users/cltbld', 20:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:26 INFO - 'LOGNAME': 'cltbld', 20:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:26 INFO - 'MOZ_NO_REMOTE': '1', 20:43:26 INFO - 'NO_EM_RESTART': '1', 20:43:26 INFO - 'PAGER': '/bin/cat', 20:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:26 INFO - 'PWD': '/builds/slave/test', 20:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:26 INFO - 'SHELL': '/bin/bash', 20:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:26 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:26 INFO - 'USER': 'cltbld', 20:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:26 INFO - 'XPC_FLAGS': '0x0', 20:43:26 INFO - 'XPC_SERVICE_NAME': '0', 20:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:26 INFO - Downloading/unpacking flake8 20:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:43:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:43:28 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 20:43:28 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 20:43:28 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 20:43:28 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 20:43:28 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 20:43:28 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 20:43:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:43:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:43:29 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 20:43:29 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 20:43:29 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 20:43:29 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 20:43:29 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 20:43:29 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 20:43:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:43:29 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 20:43:29 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 20:43:29 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 20:43:29 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 20:43:29 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 20:43:29 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 20:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:43:30 INFO - no previously-included directories found matching 'docs/_build' 20:43:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:43:30 INFO - Running setup.py install for pep8 20:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:43:30 INFO - no previously-included directories found matching 'docs/_build' 20:43:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:43:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:43:30 INFO - Cleaning up... 20:43:30 INFO - Return code: 0 20:43:30 INFO - Running post-action listener: _resource_record_post_action 20:43:30 INFO - Running post-action listener: _start_resource_monitoring 20:43:30 INFO - Starting resource monitoring. 20:43:30 INFO - ##### 20:43:30 INFO - ##### Running install step. 20:43:30 INFO - ##### 20:43:30 INFO - Running pre-action listener: _resource_record_pre_action 20:43:30 INFO - Running main action method: install 20:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:43:30 INFO - Reading from file tmpfile_stdout 20:43:30 INFO - Detecting whether we're running mozinstall >=1.0... 20:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:43:30 INFO - Reading from file tmpfile_stdout 20:43:30 INFO - Output received: 20:43:30 INFO - Usage: mozinstall [options] installer 20:43:30 INFO - Options: 20:43:30 INFO - -h, --help show this help message and exit 20:43:30 INFO - -d DEST, --destination=DEST 20:43:30 INFO - Directory to install application into. [default: 20:43:30 INFO - "/builds/slave/test"] 20:43:30 INFO - --app=APP Application being installed. [default: firefox] 20:43:30 INFO - mkdir: /builds/slave/test/build/application 20:43:30 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'] 20:43:30 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 20:43:53 INFO - Reading from file tmpfile_stdout 20:43:53 INFO - Output received: 20:43:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:43:53 INFO - Running post-action listener: _resource_record_post_action 20:43:53 INFO - ##### 20:43:53 INFO - ##### Running run-tests step. 20:43:53 INFO - ##### 20:43:53 INFO - Running pre-action listener: _resource_record_pre_action 20:43:53 INFO - Running main action method: run_tests 20:43:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:43:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:43:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:43:53 INFO - 2016-07-07 20:43:53.111 screenresolution[1905:9792] starting screenresolution argv=screenresolution get 20:43:53 INFO - 2016-07-07 20:43:53.114 screenresolution[1905:9792] Display 0: 1600x1200x32@60 20:43:53 INFO - 2016-07-07 20:43:53.119 screenresolution[1906:9794] starting screenresolution argv=screenresolution list 20:43:53 INFO - Available Modes on Display 0 20:43:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:43:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:43:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:43:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:43:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:43:53 INFO - Intel Iris: 20:43:53 INFO - Chipset Model: Intel Iris 20:43:53 INFO - Type: GPU 20:43:53 INFO - Bus: Built-In 20:43:53 INFO - VRAM (Dynamic, Max): 1536 MB 20:43:53 INFO - Vendor: Intel (0x8086) 20:43:53 INFO - Device ID: 0x0a2e 20:43:53 INFO - Revision ID: 0x0009 20:43:53 INFO - Displays: 20:43:53 INFO - Display: 20:43:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:43:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:43:53 INFO - Display Serial Number: 1600x1200 60 20:43:53 INFO - Main Display: Yes 20:43:53 INFO - Mirror: Off 20:43:53 INFO - Online: Yes 20:43:53 INFO - Rotation: Supported 20:43:53 INFO - Return code: 0 20:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:43:53 INFO - Python 2.7.3 20:43:53 INFO - Return code: 0 20:43:53 INFO - grabbing minidump binary from tooltool 20:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b1e00>, '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 0x10201adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021acb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:43:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:43:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:43:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:43:53 INFO - Return code: 0 20:43:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:43:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:43:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:43:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:43:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:43:54 INFO - Return code: 0 20:43:54 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/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 20:43:54 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/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --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 20:43:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9tRtVH8RzU/Render', 20:43:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:54 INFO - 'HOME': '/Users/cltbld', 20:43:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:54 INFO - 'LOGNAME': 'cltbld', 20:43:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:43:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:54 INFO - 'MOZ_NO_REMOTE': '1', 20:43:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:43:54 INFO - 'NO_EM_RESTART': '1', 20:43:54 INFO - 'PAGER': '/bin/cat', 20:43:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:54 INFO - 'PWD': '/builds/slave/test', 20:43:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:43:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:54 INFO - 'SHELL': '/bin/bash', 20:43:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJdHd8Qq39/Listeners', 20:43:54 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 20:43:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:54 INFO - 'USER': 'cltbld', 20:43:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:54 INFO - 'XPC_FLAGS': '0x0', 20:43:54 INFO - 'XPC_SERVICE_NAME': '0', 20:43:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:54 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/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 20:43:54 INFO - mozversion application_buildid: 20160707183926 20:43:54 INFO - mozversion application_changeset: f4e161a1dd38df3f4679d7b647371e2388e7eb72 20:43:54 INFO - mozversion application_display_name: Firefox 20:43:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:43:54 INFO - mozversion application_name: Firefox 20:43:54 INFO - mozversion application_remotingname: firefox 20:43:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:43:54 INFO - mozversion application_vendor: Mozilla 20:43:54 INFO - mozversion application_version: 48.0 20:43:54 INFO - mozversion platform_buildid: 20160707183926 20:43:54 INFO - mozversion platform_changeset: f4e161a1dd38df3f4679d7b647371e2388e7eb72 20:43:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:43:54 INFO - mozversion platform_version: 48.0 20:43:54 INFO - using testdate: 1467949434 20:43:54 INFO - actual date: 1467949434 20:43:54 INFO - starting webserver on 'localhost:49473' 20:43:54 INFO - SUITE-START | Running 2 tests 20:43:54 INFO - TEST-START | dromaeo_css 20:43:54 INFO - operating with platform_type : mac_ 20:43:54 INFO - Initialising browser for dromaeo_css test... 20:43:54 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp4zQpNO/profile http://localhost:49473/getInfo.html) 20:43:57 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 20:43:57 INFO - PROCESS | 1924 | colorDepth:24 20:43:57 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 20:43:57 INFO - PROCESS | 1924 | __metrics 20:43:57 ERROR - PROCESS | 1924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:43:58 INFO - TEST-INFO | 1924: exit 0 20:43:58 INFO - Browser initialized. 20:43:58 INFO - Running cycle 1/1 for dromaeo_css test... 20:43:58 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp4zQpNO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:44:10 INFO - PROCESS | 1928 | RSS: Main: 171405312 20:44:10 INFO - PROCESS | 1928 | 20:44:59 INFO - PROCESS | 1928 | 1467949499637 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] 20:47:10 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49473/tests/dromaeo/cssquery-ext.html) 20:47:11 INFO - PROCESS | 1928 | RSS: Main: 182239232 20:47:11 INFO - PROCESS | 1928 | 20:50:13 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-ext.html (next: http://localhost:49473/tests/dromaeo/cssquery-jquery.html) 20:50:14 INFO - PROCESS | 1928 | RSS: Main: 192868352 20:50:14 INFO - PROCESS | 1928 | 20:53:16 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49473/tests/dromaeo/cssquery-mootools.html) 20:53:16 INFO - PROCESS | 1928 | RSS: Main: 194867200 20:53:16 INFO - PROCESS | 1928 | 20:56:18 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49473/tests/dromaeo/cssquery-prototype.html) 20:56:19 INFO - PROCESS | 1928 | RSS: Main: 198733824 20:56:19 INFO - PROCESS | 1928 | 20:59:21 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49473/tests/dromaeo/cssquery-yui.html) 20:59:22 INFO - PROCESS | 1928 | RSS: Main: 198164480 20:59:22 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-yui.html (next: http://localhost:49473/tests/dromaeo/cssquery-dojo.html) 21:02:24 INFO - PROCESS | 1928 | RSS: Main: 203169792 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | __start_tp_report 21:02:24 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 21:02:24 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 21:02:24 INFO - PROCESS | 1928 | |i|pagename|runs| 21:02:24 INFO - PROCESS | 1928 | |0;dojo.html;2884.35102102027;3658.9817050914726;3686.981565092174;3706.2216934443763;3734.551853777547;5950.37521060289;5961.612495187821;5966.284045914491;5982.282126144869;5989.431004054613;5978.8804223915495;6001.039833626621;6023.638581685102;6053.273607167146;6062.9090563641585;4087.366458198969;5092.567131793793;5375.6774593524315;5395.973020134914;5397.4062853086125;5329.413764485904;5393.1101368274185;5418.972905135469;5437;5461.563074954014;5398.6220964532495;5425.701586412746;5433.673979561219;5438.374586922495;5438.456154384569;4460.509343972193;5380;5381.219723140142;5408.107662235727;5443.938432005761;5235.188545775411;5334.546563542103;5356.7321633918145;5407.540359069484;5426.674399536001;5548.72256387179;5555.3611334696625;5947.702614869239;5989.131575921467;5992.101184822268;6160.5687601867885;6170.167027451282;6206.975848984957;6225.564210505267;6238.1266622672865;6348.587341822813;6360.745570177188;6379.106925030499;6401.359864013608;6416.550841441101;5968.522518198533;6107.725152368154;6120.846978825521;6121;6126.693665316761;6376.521760867953;6422.743090276336;6493.285738568754;6502.707378167994;6611.33886611335;5194.896102077937;6202.937970620236;6220.160278362454;6227.501799856092;6240.344763799826;6281.685915704196;6301.117843501914;6322.747090116436;6328.272248691367;6337;6170.228721409824;6221.844453888689;6235.158253635792;6264.248290205204;6331.398517140957;6231.034189700513;6252.781152659726;6255;6258.968705156445;6285.2457705075685;5011.373578302712;5070.61970352225;5077.593792496666;5087.23691446286;5090.745462726849;4577.359169716243;4577.931331030038;4585.518520555361;4610.10103029906;4664;6120.821161151463;6190.628562286277;6203.193584833943;6212.968935155386;6223.813285601439;6220.066989951453;6303.527235457267;6352.174217351715;6368.331325210786;6485.0272459130565;6106.694665266719;6142.631442113398;6153.815385538441;6195.721192546346;6206.224221972254;5630.380658127603;5651.773929042874;5657.349404818498;5657.830265092054;5679.176519404663;6505.0892874997535;6571.474282057424;6660.300668429939;6689.832754181184;6698.296678848748;6345.936540634534;6355.968220158869;6377.553571250153;6379.649119298483;6389.584676995981;6662.600243985376;6666.333366663295;6696.1629796275465;6712.093867327848;6715.395614394728;6145.9692701536205;6187;6238.064290356301;6239.532035097477;6305.180326557702;6345.016522438845;6362.172917520693;6374.203224596926;6382.96808515973;6458.903116453351;5432.565394768488;5532.723363831873;6173.98129308677;6233.719482623384;6252.812415627356;4991.975040124777;6118.040554665315;6148.954677704712;6214.937850621617;6248.156498872594;4977.203647416396;6064.605800622945;6187.752489900354;6234.688265586612;6282.780102696383;6184.381561843959;6196.442320191204;6199.907001394892;6221.3156552780065;6266.154069200599;4526.366308716716;4969.850904472872;5143.3570803649545;6137.009281402588;6219.720112595034 21:02:24 INFO - PROCESS | 1928 | |1;ext.html;519.9350081239845;520.6927912531605;537.1995726367713;556.6993823335398;570.57207094679;34378.31243375131;38121.80939095304;39571.40642890359;39755.80122099385;39840.40239396411;41165.17669646605;41812.954676133115;41822;41831.37252941208;41947.37078943818;9522.761930951747;9658.661946831862;9763.463009534473;9773.511324433786;9805.803883922317;9736.853947190797;9898.35660682057;9902.158316543102;9955.153811925959;9962.950185249063;9870.186996705905;9886.50567471627;9955.352902061379;9979.550920208572;10014.048665376778;9832.508374581243;9903.10872021518;10003.79992400148;10003.949980250125;10025.749356266078;9778.559964801601;9782.266330025277;9798.65704700332;9906;9907.207423406182;39057.21885562301;39370.803145984086;39478;39643.60356396457;39677.40483892744;2988.9551656725166;3396.8301584920655;3518.36669399508;3877.670398016172;3926;23839.523209535884;28407.147785566467;28759.56860647092;29617.851910740523;30212;2663.853488058156;2717.790583190481;2781.8191817531797;2810.227187523427;2856.985715071432;467080;472107;473234.99999999657;473819;485331;37202;37930.86207413782;37962.430563541566;38042.66850660214;60367.39632603706;35653.8217308917;35708;35799.46300805438;36006.27987440237;36016.45975310372;15573.454929077428;15601.609959751097;16032.679346413006;16043.919780401024;16082.517524474284;13592.592222233348;13618.727625447436;13630.659233519242;13654.795178072336;13717.17696938187;8322;8394.076651568323;8401.579921003926;8415.452995555392;8484.533350665773;3425.6745609167087;3494.336076145524;3497.300539892032;3519.9472007919903;3535.4343305071066;965.6958058211641;966.7244835222068;996.14829320931;1065.174489770434;1151.83874257604;30675.84662076675;30681;30878.304033298;30916.69083309183;31151.065468035995;1092.5575142067476;1136.5794655977177;1249.4689756853302;1277.1672649747643;1302.8827405533548;15398.615034624;15403;15868.60328491797;15876;16743.827932044638;621619;631462;633791;639357;640082;62409;63213;63282.36717632857;63296.36703632997;63307.6834615824;1506.6007508010387;1527.9312430940413;1531.5175719648498;1539.3765524962184;1545.1656105703019;30316.938907138145;30702.539461907643;30768.384632307676;30788.94873329326;31117.066488005396;51810;52352;52357.47642523678;52435;52519.68700782511;441595;442078;442710;444636;445956;25682.84427200743;26612.866935665974;26727.19818405451;26849.328766780985;27056.05303814357;44165.77917110394;44623.33065003963;45405.772971136255;45412.864678381986;45532.54467455283;37160.88517344484;37313.06717332089;37461.81269093637;37569.62430375661;38122.237555249296;28779;36057.27885442224;36302.455463168604;36728.449073264455;37067.814660926524;35889.64110358863;35915.46126808152;36041;36118.8194059028;38080.42879356757;32386;32645.673543264264;32664.83667581647;32855.34289314248;32939.83530082334;24912;24923;25055.87472062628;25542.36144096338;25813.870930645226 21:02:24 INFO - PROCESS | 1928 | |2;jquery.html;409.9385092236164;414.28122207969176;415.4993233154046;418.5605114629639;419.230711644133;18282.81717182828;20342.796572034276;21133.68299475509;21190.682139767898;22404.439889002784;17642.558936026606;19064.237430502762;20585;20668.793312066875;20670.17319307226;4960.503949605047;5815.185873977646;5862.120681897707;6001.429864162919;6053.939460605404;5898.292204935414;5915.290165180184;5992.670403127826;6017.48851347636;6021.42796434338;5294.497022782849;5811.796587119452;5905.30359726587;5969.910451343233;6004.3395226525045;5912.852178695524;6004.819855404301;6005.2193214882;6007.309159446632;6022.2773267207995;5162.148245539482;5199.740012999373;5253.238280449352;5260.605454590921;5277.076511610491;13013.609591712264;13753.312334383241;13754.65613359664;26462.470750585075;26647.333816654544;2278.9658155127686;2375.3467796355967;2471.851688898672;2766.432881259337;2843.516602177635;7592.785154375273;9680.322377433513;9952.253580981456;10278.280520363578;10309.742256443575;1820.1718218210815;1823.872328936975;1842.9539261518435;1883.0396497786091;1910.3409323783274;106712.46643766809;109027.81944361147;111517;113008.43495782634;114270;9339.719808405758;11858.584949526725;12068.215565988183;12139.878601214052;12242.081843861568;14364.281785910664;15254.694906101815;15418.768718469231;15460.608545230984;15733.292001859943;8945.329100317502;8965.237954773787;8980.46117232968;9057.77355566103;9268.72193834186;9016.053314402025;9093.04523025086;9132.22376098039;9203.815923681623;9251;4803.639727020487;4818.8795280118275;4836.081144582518;4924.409070911442;4937.8271760488215;2057.6399130152163;2124.968125478119;2130.499332656824;2174.9891250543646;2184.803367696915;948.6395169835419;1012.9414761574026;1065.5631191211567;1077.42357838556;1095.7370231144469;17986.640267194583;18864.868107913568;19916.00419979024;20704.792952070286;20994.37016889496;973.7224890906058;985.9161971232526;1005.8943810899897;1020.7805321855836;1042.280826229899;9528.19010384125;10588.629397971034;10945.522354482202;10988.450577471254;11179.280161474064;622208;626354;635268;647322;650434;105749.88500229952;121788;127189.36405317915;130371.34814326058;136267;1032.442481060234;1054.0460882900986;1069.8662667166604;1070.6937536205817;1076.311160857052;17902.83631563944;17945;18016;18278.451646450627;18451.538711531783;41060;42114.789426052674;50134.24798627951;50859.72850678763;55502.72248638731;54729;66807.66596167182;70521.29478705148;71430;73522.63238683772;7946.40401969843;8071.71748988806;8148.674053037812;8171.182881711781;8221.095679475373;12044.21712588679;12098.939505302416;12237.510499579917;12296;12475.875241247471;9508.429494230368;10124.59501619927;10150.796984060426;10598.47007649599;10961.561537538728;10494.10800081971;10579.523921423708;10607.41659208751;10741.301815381976;10861.131109511061;10745.301555399186;11184.049355804847;11287.887121129012;11410.201285910238;11553.942230288794;6896.517243793087;8149.103598604031;8263.628136733741;8272.420930534805;8385.1195624461;7885;8212.589370531568;10885.564577416815;11004.009639132517;11064.336139831636 21:02:24 INFO - PROCESS | 1928 | |3;mootools.html;1610.3961014619517;1628.641698826258;1906.8474522038239;1997.5305803136268;2058.7838276980906;8323.292520135781;8982.326325525595;9161.770955726102;9355.06449355065;9391.71824845255;9080.091990800916;9089.181973622373;9240.168384845363;9242.95378523108;9249.953750231256;2544.198577448098;2556.5653838847347;2561.4748976459828;2584.9741502585016;2587.5342438361085;2513.434477242624;2579.32937436267;2581.1224183777513;2586.159498163095;2586.822995537026;2538.073603134861;2554.3741783263126;2561.3852675357966;2582.4705935283314;2590.093467286444;2542.567763480222;2549.987250063747;2556.8593727344987;2584.030988379358;2584.44434446593;2168.642174041281;2539.492101579673;2565.230430870731;2566.396896729267;2584.4055867150473;9157.633694652273;9232.538373081386;9237;9280.628774848998;9285.350025498217;5591.916121258185;5663.5186009189265;5763.942360576382;5792.536597072224;5801.854953626151;3653.5798383186007;3769.2838360711376;3809.7523660962224;3820.541535015788;3832.6550610445192;1060.0883240413239;1071.4535586850684;1076.1390887290136;1097.6871591596437;1103.4813637590319;12143.574974875924;12235;12402.503899843996;12410.627681169579;12419.689507762288;4991.975040124777;5022.347094877642;5089.287499750038;5097.464766199496;5135.024345374367;10250.231232657581;10412.843807342895;10564.524596393181;10596.894031059745;10605.09856662177;5558.166275058693;5569;5577.637453565505;5654.575906806924;5792.7103644818435;4328.307470804656;4599.172149013143;4623.052274283764;5014.473480284591;5152.227165925141;3621.3300539400293;3890.7471014383973;4242.045539753531;4249.553796851348;4302.741835489881;1053.6364954090827;1128.7798879218474;1201.3512703140207;1364.3110229334122;1421.3532842556613;957.9281553883486;977.5845265762023;978.1929907826072;981.7840075183448;994.5673631970116;6023.909641355383;6027;6143.894099062211;6182.887080325585;6266.968665156736;480.0590841949817;487.8390131256748;488.27978731370945;491.9483454237325;495.9479254678279;3954.5056867891512;4013.518377794683;4062.532808727034;4067.3288907330552;4138.730982486129;10672.786544269227;11088.944555277172;11092;11102.500387482583;11138.33170009802;10541.209409294333;10632.521536530874;10807.513661885234;10845.674629761119;10895.400752958505;8285.50286982783;8353.707620233263;8606.31149508038;8613.267872230805;8658.740237792876;6020.668863212565;6026.638401695912;6107.297660769068;6173.38266173397;6196.845078873064;10026.598936042768;10090.394576325443;10180.898191017995;10249.077583017564;10271.332363396356;10054.899451005396;10334.689959301233;10367.585296588353;10458.006489383497;10661.733456663334;5735.684537350319;7098.148222213367;7550.697972081055;7759.262870027338;7981.680732770624;8496.32029437656;8518.531480768617;8545.572721364031;8566.871496927426;8599.355048371272;7487.9516867637485;7605.163432022362;7644;7646.852972054014;7754.224577542201;7173.10336207974;7231.204567497466;7235.204127546071;7304.598247096461;7326.3040011198855;7231.240719724564;7241.674124664298;7245.601491917995;7258.237885022208;7279.8180045497165;4959.256111583291;5088.618353623419;5094.108531007133;5257.132573125392;5274.548541135082;5306.336707911511;5334.439883812299;5364.222187782828;5418.593605479526;5449.673019618677 21:02:24 INFO - PROCESS | 1928 | |4;prototype.html;324.76616835878167;333.72134267886315;335.73476953206966;341.93161367726464;342.0252280999154;5647.43525647435;6318.715657795393;6499.927511960521;6857.417119544838;6876.656167191639;6709.597424154555;6773.695183716733;6815.6592170391405;6841.7947461576105;6845.247022827498;4794.328793968838;4879.609631229511;5013.147764879979;5020.0963826511215;5032.723200223986;4935.457099719028;5013.523715247045;5020.472850350716;5029.698218106925;5036.4208116066575;4935.728534930578;4936.284238785374;4959.752012399365;4976.253561965698;4993.226049962262;3830.693544516432;4584.739196720911;4957.330760347343;4964.87587810304;5021.472745361721;3527.805970671612;4348.434703488558;4349.739015659071;4361.105973275471;4361.8441113105055;6359.682015899233;6548.541602087856;6554.180727409074;6590.538662293641;6672.132622759059;5893.79371721992;5948.37542058082;5953.613015154001;5954.97022514889;5970.940290597082;7338.596377199252;7341.082364704412;7345.963270183614;7346.853062938711;7356.742514012038;4013.5986401359924;4893.584045356149;4894.632902532288;4897.559219670246;4909.607231421478;6199.87600247997;7564.130125035581;7794.10367807698;7797.805054873674;7821.882671759929;4898.559129678346;4937.308776771255;5024.346834911438;5026.346574945233;5030.748462576857;4372.934405983913;5085.211792172219;5090.363704536933;5110.821121260812;5111.821086261963;5930.614510056833;5996.610220335664;6009.098635204667;6014.699265036731;6019.819405417845;7286.344229019413;7311.305425984523;7324.743633972786;7359.264073592598;7373.078365204349;1739.2955852879604;1773.157750068707;1773.973390399145;1779.7864256289329;1780.1010489702617;1052.7420781908481;1085.0505807418508;1088.4176965323513;1088.5101704233127;1094.9781004379868;5625.240592520039;6995.93004069963;7026;7048.400885924651;7052.929470705228;7174.892376614355;7336.669849856769;7619.885701714478;7633.122190948001;7703.268189521987;5718.656880587178;6916.688749006306;7075.044868942729;7116.893246601305;7122.323379278961;4046.615571520701;4085.775282359439;4085.836566537365;4103.2409004334295;4112.527059388149;7175.748848790267;7887.250711182429;8118.431709780259;8120;8157.510549367057;7675.654595543102;7970.855155319202;7973.920260797434;7980.920190798134;7988.800279993046;6507.674616269168;6761.830954226184;7886.132525422199;8096.190380961974;8153.388495862834;6925.27284635106;7060.117485314336;7751.6511756972195;7755.06939167281;7767.184445633127;7533.209013053551;7534.924650753423;7550.244975502405;7558.395328373607;7564.394848412004;7760.417968652261;8122.675092996214;8124.83750325002;8130.796730081795;8137.877931830909;4813.879653008703;4855.781489832895;4859.173940430064;4863.708177509361;4870.318155458168;6477.643729594917;7651.961740191264;7653.808654783675;7658.349040331412;7672.961635191788;7334.193238743841;7341.70633174667;7346.449016323904;7364.153122390993;7408.518446300973;7084.2915708428745;7309.853802923805;7335.486515943832;7343.926560734538;7358.080239970004;7167.498275120692;7174.139103307636;7186.281371862772;7197.568145911262;7200.855982880208;6634.83412914681;7280.126384833854;7328.523645962995;7345.632718364167;7348.191698913009;6905.202138823526;7186.676599553137;7196.676149573177;7200.423966082805;7209.6395180241825 21:02:24 INFO - PROCESS | 1928 | |5;yui.html;609.9695015249238;650.2976785072119;655.4265018109154;666.1340257665034;669.1869378704872;15385.384584616615;15631.983921045125;15793.210339483037;15802.367905283803;15816.841831581694;14621.707565848677;14817.18505482198;14823;14836;14837.183954882477;816.1145157504116;960.3901522533207;972.4602845420789;983.3853841349156;988.2588058955783;947.4504787223394;977.1108291454777;985.6796541124128;988.3822610868208;995.7012896131132;1035.5081336365242;1037.4294138223984;1037.891021442749;1038.4703801061476;1043.2488608202082;1001.6894762623574;1030.0780801182975;1032.9793404131876;1035.5702383510834;1040.9739756506071;751.9661615227328;759.965801538932;764.8699721047435;765.8512231652521;770.7803276066294;15181.696366072727;15222;15226.619334516725;15285.235738213045;15384.461543846024;13351.599452016359;13377.331133443386;13450.192988420726;13502.324883755871;13654;10336.483175841178;10436.686899393031;10440.947795260976;10506.632267870587;10764.677059688222;3602.8018458984743;3605.3330133925306;3657.122290650251;3672.769622176574;3879.2241551689776;79947.40105197922;81812;81922.59038704827;82533;82992;9701.805963880683;9748.415095094317;9828.754281143028;9923.751906202258;10169.288149829588;22496.43758906008;22524.54950900973;22662.093516259494;23408.297751067494;23502.294931152093;7691.730789422455;7726.266004729542;7799.1031031430975;7810.336121429742;7904.589100324456;4137.213929353413;4199.979000105041;4203.369494575777;4208.305629571087;4283.186194623012;3728.850845966131;3776.905577360533;3781.8843441184918;3800.144967382372;3802.391617341212;661.765073398946;668.1147479589563;671.9731210751613;676.577139287945;692.4633409107881;522.4409881426913;568.6417556939102;579.5537436174207;585.8330375842864;604.8548348396441;6584.440322572635;6658.3341665834;7193.884947833094;8102.797430064177;8284.792880177924;506.3139446050622;526.3525863188223;606.142308633279;610.5634471353004;626.3517259636254;3786.413105968579;3847.03824043989;3869;3882.107115363482;3903.59012303704;81651.18348816555;92722.0727792727;94864;96413;96934;79197.60401197957;79245.60377198076;79417.60291198622;80015.59992200002;80330.5983470079;50892.727681808254;69171;69379;70684;71904.20239494159;8065.516069035877;8353.916460835313;8385.706500272461;8420.915790842259;8481.53351565645;49405;50307;50670.74664626653;50836.491635084654;51285.230721539956;47599;63641;68932;69014;69960;10925.344479331265;10977.506012229309;11018.724531886766;11066.778664426827;11098.056665183227;11540.826887596524;11569.826452603385;11737.237079589799;11777.764444711229;11994.520219191134;10977.231593788358;11038.116950643769;11078.833817492583;11485.19603627738;11687.240329378563;11048.613298534512;11055.72360690957;11106.333619982826;11173.050290725054;11261.605843795427;10699;11251.7749645005;11260.211785175286;11522.135839812216;11671.88328116708;9442.85835712451;9473.810523789623;9474.00462073538;9478.241740660593;9515.476648784383;9362.204212642002;9552.23582113443;9575.856362154434;9577.473238971923;9635.903640963781 21:02:24 INFO - PROCESS | 1928 | __end_tp_report 21:02:24 INFO - PROCESS | 1928 | __start_cc_report 21:02:24 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,401 21:02:24 INFO - PROCESS | 1928 | __end_cc_report 21:02:24 INFO - PROCESS | 1928 | __startTimestamp1467950544516__endTimestamp 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | ------- Summary: start ------- 21:02:24 INFO - PROCESS | 1928 | Number of tests: 6 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | [#0] dojo.html Cycles:165 Average:5864.81 Median:6160.57 stddev:682.96 (11.1%) stddev-sans-first:643.79 21:02:24 INFO - PROCESS | 1928 | Values: 2884.4 3659.0 3687.0 3706.2 3734.6 5950.4 5961.6 5966.3 5982.3 5989.4 5978.9 6001.0 6023.6 6053.3 6062.9 4087.4 5092.6 5375.7 5396.0 5397.4 5329.4 5393.1 5419.0 5437.0 5461.6 5398.6 5425.7 5433.7 5438.4 5438.5 4460.5 5380.0 5381.2 5408.1 5443.9 5235.2 5334.5 5356.7 5407.5 5426.7 5548.7 5555.4 5947.7 5989.1 5992.1 6160.6 6170.2 6207.0 6225.6 6238.1 6348.6 6360.7 6379.1 6401.4 6416.6 5968.5 6107.7 6120.8 6121.0 6126.7 6376.5 6422.7 6493.3 6502.7 6611.3 5194.9 6202.9 6220.2 6227.5 6240.3 6281.7 6301.1 6322.7 6328.3 6337.0 6170.2 6221.8 6235.2 6264.2 6331.4 6231.0 6252.8 6255.0 6259.0 6285.2 5011.4 5070.6 5077.6 5087.2 5090.7 4577.4 4577.9 4585.5 4610.1 4664.0 6120.8 6190.6 6203.2 6213.0 6223.8 6220.1 6303.5 6352.2 6368.3 6485.0 6106.7 6142.6 6153.8 6195.7 6206.2 5630.4 5651.8 5657.3 5657.8 5679.2 6505.1 6571.5 6660.3 6689.8 6698.3 6345.9 6356.0 6377.6 6379.6 6389.6 6662.6 6666.3 6696.2 6712.1 6715.4 6146.0 6187.0 6238.1 6239.5 6305.2 6345.0 6362.2 6374.2 6383.0 6458.9 5432.6 5532.7 6174.0 6233.7 6252.8 4992.0 6118.0 6149.0 6214.9 6248.2 4977.2 6064.6 6187.8 6234.7 6282.8 6184.4 6196.4 6199.9 6221.3 6266.2 4526.4 4969.9 5143.4 6137.0 6219.7 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | [#1] ext.html Cycles:180 Average:64151.70 Median:37257.53 stddev:139987.48 (375.7%) stddev-sans-first:140298.65 21:02:24 INFO - PROCESS | 1928 | Values: 519.9 520.7 537.2 556.7 570.6 34378.3 38121.8 39571.4 39755.8 39840.4 41165.2 41813.0 41822.0 41831.4 41947.4 9522.8 9658.7 9763.5 9773.5 9805.8 9736.9 9898.4 9902.2 9955.2 9963.0 9870.2 9886.5 9955.4 9979.6 10014.0 9832.5 9903.1 10003.8 10003.9 10025.7 9778.6 9782.3 9798.7 9906.0 9907.2 39057.2 39370.8 39478.0 39643.6 39677.4 2989.0 3396.8 3518.4 3877.7 3926.0 23839.5 28407.1 28759.6 29617.9 30212.0 2663.9 2717.8 2781.8 2810.2 2857.0 467080.0 472107.0 473235.0 473819.0 485331.0 37202.0 37930.9 37962.4 38042.7 60367.4 35653.8 35708.0 35799.5 36006.3 36016.5 15573.5 15601.6 16032.7 16043.9 16082.5 13592.6 13618.7 13630.7 13654.8 13717.2 8322.0 8394.1 8401.6 8415.5 8484.5 3425.7 3494.3 3497.3 3519.9 3535.4 965.7 966.7 996.1 1065.2 1151.8 30675.8 30681.0 30878.3 30916.7 31151.1 1092.6 1136.6 1249.5 1277.2 1302.9 15398.6 15403.0 15868.6 15876.0 16743.8 621619.0 631462.0 633791.0 639357.0 640082.0 62409.0 63213.0 63282.4 63296.4 63307.7 1506.6 1527.9 1531.5 1539.4 1545.2 30316.9 30702.5 30768.4 30788.9 31117.1 51810.0 52352.0 52357.5 52435.0 52519.7 441595.0 442078.0 442710.0 444636.0 445956.0 25682.8 26612.9 26727.2 26849.3 27056.1 44165.8 44623.3 45405.8 45412.9 45532.5 37160.9 37313.1 37461.8 37569.6 38122.2 28779.0 36057.3 36302.5 36728.4 37067.8 35889.6 35915.5 36041.0 36118.8 38080.4 32386.0 32645.7 32664.8 32855.3 32939.8 24912.0 24923.0 25055.9 25542.4 25813.9 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | [#2] jquery.html Cycles:180 Average:35080.40 Median:12294.62 stddev:105583.50 (858.8%) stddev-sans-first:105847.60 21:02:24 INFO - PROCESS | 1928 | Values: 409.9 414.3 415.5 418.6 419.2 18282.8 20342.8 21133.7 21190.7 22404.4 17642.6 19064.2 20585.0 20668.8 20670.2 4960.5 5815.2 5862.1 6001.4 6053.9 5898.3 5915.3 5992.7 6017.5 6021.4 5294.5 5811.8 5905.3 5969.9 6004.3 5912.9 6004.8 6005.2 6007.3 6022.3 5162.1 5199.7 5253.2 5260.6 5277.1 13013.6 13753.3 13754.7 26462.5 26647.3 2279.0 2375.3 2471.9 2766.4 2843.5 7592.8 9680.3 9952.3 10278.3 10309.7 1820.2 1823.9 1843.0 1883.0 1910.3 106712.5 109027.8 111517.0 113008.4 114270.0 9339.7 11858.6 12068.2 12139.9 12242.1 14364.3 15254.7 15418.8 15460.6 15733.3 8945.3 8965.2 8980.5 9057.8 9268.7 9016.1 9093.0 9132.2 9203.8 9251.0 4803.6 4818.9 4836.1 4924.4 4937.8 2057.6 2125.0 2130.5 2175.0 2184.8 948.6 1012.9 1065.6 1077.4 1095.7 17986.6 18864.9 19916.0 20704.8 20994.4 973.7 985.9 1005.9 1020.8 1042.3 9528.2 10588.6 10945.5 10988.5 11179.3 622208.0 626354.0 635268.0 647322.0 650434.0 105749.9 121788.0 127189.4 130371.3 136267.0 1032.4 1054.0 1069.9 1070.7 1076.3 17902.8 17945.0 18016.0 18278.5 18451.5 41060.0 42114.8 50134.2 50859.7 55502.7 54729.0 66807.7 70521.3 71430.0 73522.6 7946.4 8071.7 8148.7 8171.2 8221.1 12044.2 12098.9 12237.5 12296.0 12475.9 9508.4 10124.6 10150.8 10598.5 10961.6 10494.1 10579.5 10607.4 10741.3 10861.1 10745.3 11184.0 11287.9 11410.2 11553.9 6896.5 8149.1 8263.6 8272.4 8385.1 7885.0 8212.6 10885.6 11004.0 11064.3 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | [#3] mootools.html Cycles:180 Average:5920.70 Median:490.11 stddev:3304.24 (674.2%) stddev-sans-first:3297.63 21:02:24 INFO - PROCESS | 1928 | Values: 1610.4 1628.6 1906.8 1997.5 2058.8 8323.3 8982.3 9161.8 9355.1 9391.7 9080.1 9089.2 9240.2 9243.0 9250.0 2544.2 2556.6 2561.5 2585.0 2587.5 2513.4 2579.3 2581.1 2586.2 2586.8 2538.1 2554.4 2561.4 2582.5 2590.1 2542.6 2550.0 2556.9 2584.0 2584.4 2168.6 2539.5 2565.2 2566.4 2584.4 9157.6 9232.5 9237.0 9280.6 9285.4 5591.9 5663.5 5763.9 5792.5 5801.9 3653.6 3769.3 3809.8 3820.5 3832.7 1060.1 1071.5 1076.1 1097.7 1103.5 12143.6 12235.0 12402.5 12410.6 12419.7 4992.0 5022.3 5089.3 5097.5 5135.0 10250.2 10412.8 10564.5 10596.9 10605.1 5558.2 5569.0 5577.6 5654.6 5792.7 4328.3 4599.2 4623.1 5014.5 5152.2 3621.3 3890.7 4242.0 4249.6 4302.7 1053.6 1128.8 1201.4 1364.3 1421.4 957.9 977.6 978.2 981.8 994.6 6023.9 6027.0 6143.9 6182.9 6267.0 480.1 487.8 488.3 491.9 495.9 3954.5 4013.5 4062.5 4067.3 4138.7 10672.8 11088.9 11092.0 11102.5 11138.3 10541.2 10632.5 10807.5 10845.7 10895.4 8285.5 8353.7 8606.3 8613.3 8658.7 6020.7 6026.6 6107.3 6173.4 6196.8 10026.6 10090.4 10180.9 10249.1 10271.3 10054.9 10334.7 10367.6 10458.0 10661.7 5735.7 7098.1 7550.7 7759.3 7981.7 8496.3 8518.5 8545.6 8566.9 8599.4 7488.0 7605.2 7644.0 7646.9 7754.2 7173.1 7231.2 7235.2 7304.6 7326.3 7231.2 7241.7 7245.6 7258.2 7279.8 4959.3 5088.6 5094.1 5257.1 5274.5 5306.3 5334.4 5364.2 5418.6 5449.7 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | [#4] prototype.html Cycles:180 Average:5982.11 Median:6767.76 stddev:1920.57 (28.4%) stddev-sans-first:1878.43 21:02:24 INFO - PROCESS | 1928 | Values: 324.8 333.7 335.7 341.9 342.0 5647.4 6318.7 6499.9 6857.4 6876.7 6709.6 6773.7 6815.7 6841.8 6845.2 4794.3 4879.6 5013.1 5020.1 5032.7 4935.5 5013.5 5020.5 5029.7 5036.4 4935.7 4936.3 4959.8 4976.3 4993.2 3830.7 4584.7 4957.3 4964.9 5021.5 3527.8 4348.4 4349.7 4361.1 4361.8 6359.7 6548.5 6554.2 6590.5 6672.1 5893.8 5948.4 5953.6 5955.0 5970.9 7338.6 7341.1 7346.0 7346.9 7356.7 4013.6 4893.6 4894.6 4897.6 4909.6 6199.9 7564.1 7794.1 7797.8 7821.9 4898.6 4937.3 5024.3 5026.3 5030.7 4372.9 5085.2 5090.4 5110.8 5111.8 5930.6 5996.6 6009.1 6014.7 6019.8 7286.3 7311.3 7324.7 7359.3 7373.1 1739.3 1773.2 1774.0 1779.8 1780.1 1052.7 1085.1 1088.4 1088.5 1095.0 5625.2 6995.9 7026.0 7048.4 7052.9 7174.9 7336.7 7619.9 7633.1 7703.3 5718.7 6916.7 7075.0 7116.9 7122.3 4046.6 4085.8 4085.8 4103.2 4112.5 7175.7 7887.3 8118.4 8120.0 8157.5 7675.7 7970.9 7973.9 7980.9 7988.8 6507.7 6761.8 7886.1 8096.2 8153.4 6925.3 7060.1 7751.7 7755.1 7767.2 7533.2 7534.9 7550.2 7558.4 7564.4 7760.4 8122.7 8124.8 8130.8 8137.9 4813.9 4855.8 4859.2 4863.7 4870.3 6477.6 7652.0 7653.8 7658.3 7673.0 7334.2 7341.7 7346.4 7364.2 7408.5 7084.3 7309.9 7335.5 7343.9 7358.1 7167.5 7174.1 7186.3 7197.6 7200.9 6634.8 7280.1 7328.5 7345.6 7348.2 6905.2 7186.7 7196.7 7200.4 7209.6 21:02:24 INFO - PROCESS | 1928 | 21:02:24 INFO - PROCESS | 1928 | [#5] yui.html Cycles:180 Average:18302.53 Median:50753.62 stddev:25578.06 (50.4%) stddev-sans-first:25615.32 21:02:24 INFO - PROCESS | 1928 | Values: 610.0 650.3 655.4 666.1 669.2 15385.4 15632.0 15793.2 15802.4 15816.8 14621.7 14817.2 14823.0 14836.0 14837.2 816.1 960.4 972.5 983.4 988.3 947.5 977.1 985.7 988.4 995.7 1035.5 1037.4 1037.9 1038.5 1043.2 1001.7 1030.1 1033.0 1035.6 1041.0 752.0 760.0 764.9 765.9 770.8 15181.7 15222.0 15226.6 15285.2 15384.5 13351.6 13377.3 13450.2 13502.3 13654.0 10336.5 10436.7 10440.9 10506.6 10764.7 3602.8 3605.3 3657.1 3672.8 3879.2 79947.4 81812.0 81922.6 82533.0 82992.0 9701.8 9748.4 9828.8 9923.8 10169.3 22496.4 22524.5 22662.1 23408.3 23502.3 7691.7 7726.3 7799.1 7810.3 7904.6 4137.2 4200.0 4203.4 4208.3 4283.2 3728.9 3776.9 3781.9 3800.1 3802.4 661.8 668.1 672.0 676.6 692.5 522.4 568.6 579.6 585.8 604.9 6584.4 6658.3 7193.9 8102.8 8284.8 506.3 526.4 606.1 610.6 626.4 3786.4 3847.0 3869.0 3882.1 3903.6 81651.2 92722.1 94864.0 96413.0 96934.0 79197.6 79245.6 79417.6 80015.6 80330.6 50892.7 69171.0 69379.0 70684.0 71904.2 8065.5 8353.9 8385.7 8420.9 8481.5 49405.0 50307.0 50670.7 50836.5 51285.2 47599.0 63641.0 68932.0 69014.0 69960.0 10925.3 10977.5 11018.7 11066.8 11098.1 11540.8 11569.8 11737.2 11777.8 11994.5 10977.2 11038.1 11078.8 11485.2 11687.2 11048.6 11055.7 11106.3 11173.1 11261.6 10699.0 11251.8 11260.2 11522.1 11671.9 9442.9 9473.8 9474.0 9478.2 9515.5 9362.2 9552.2 9575.9 9577.5 9635.9 21:02:24 INFO - PROCESS | 1928 | -------- Summary: end -------- 21:02:24 INFO - PROCESS | 1928 | 21:02:25 INFO - TEST-INFO | 1928: exit 0 21:02:25 INFO - TEST-OK | dromaeo_css | took 1110283ms 21:02:25 INFO - TEST-START | kraken 21:02:25 INFO - operating with platform_type : mac_ 21:02:25 INFO - Initialising browser for kraken test... 21:02:25 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpu8WfXq/profile http://localhost:49473/getInfo.html) 21:02:27 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 21:02:27 INFO - PROCESS | 1936 | colorDepth:24 21:02:27 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 21:02:27 INFO - PROCESS | 1936 | __metrics 21:02:27 ERROR - PROCESS | 1936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 21:02:28 INFO - TEST-INFO | 1936: exit 0 21:02:28 INFO - Browser initialized. 21:02:28 INFO - Running cycle 1/1 for kraken test... 21:02:28 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpu8WfXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:02:40 INFO - PROCESS | 1940 | RSS: Main: 171208704 21:02:40 INFO - PROCESS | 1940 | 21:02:42 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-beat-detection) 21:02:43 INFO - PROCESS | 1940 | RSS: Main: 183578624 21:02:43 INFO - PROCESS | 1940 | 21:02:46 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-dft) 21:02:47 INFO - PROCESS | 1940 | RSS: Main: 192225280 21:02:47 INFO - PROCESS | 1940 | 21:02:50 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-fft) 21:02:50 INFO - PROCESS | 1940 | RSS: Main: 195923968 21:02:50 INFO - PROCESS | 1940 | 21:02:52 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-oscillator) 21:02:53 INFO - PROCESS | 1940 | RSS: Main: 196050944 21:02:53 INFO - PROCESS | 1940 | 21:02:55 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:02:56 INFO - PROCESS | 1940 | RSS: Main: 196354048 21:02:56 INFO - PROCESS | 1940 | 21:02:58 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-darkroom) 21:02:59 INFO - PROCESS | 1940 | RSS: Main: 196825088 21:02:59 INFO - PROCESS | 1940 | 21:03:02 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-desaturate) 21:03:02 INFO - PROCESS | 1940 | RSS: Main: 196661248 21:03:02 INFO - PROCESS | 1940 | 21:03:05 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49473/tests/kraken/driver.html?testName=json-parse-financial) 21:03:06 INFO - PROCESS | 1940 | RSS: Main: 196739072 21:03:06 INFO - PROCESS | 1940 | 21:03:08 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49473/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:03:08 INFO - PROCESS | 1940 | RSS: Main: 197619712 21:03:08 INFO - PROCESS | 1940 | 21:03:10 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:03:11 INFO - PROCESS | 1940 | RSS: Main: 197730304 21:03:11 INFO - PROCESS | 1940 | 21:03:13 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:03:14 INFO - PROCESS | 1940 | RSS: Main: 198025216 21:03:14 INFO - PROCESS | 1940 | 21:03:16 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:03:17 INFO - PROCESS | 1940 | RSS: Main: 198160384 21:03:17 INFO - PROCESS | 1940 | 21:03:20 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:03:21 INFO - PROCESS | 1940 | RSS: Main: 198168576 21:03:21 INFO - PROCESS | 1940 | 21:03:22 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49473/tests/kraken/driver.html?testName=ai-astar) 21:03:23 INFO - PROCESS | 1940 | RSS: Main: 200151040 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | __start_tp_report 21:03:23 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 21:03:23 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 21:03:23 INFO - PROCESS | 1940 | |i|pagename|runs| 21:03:23 INFO - PROCESS | 1940 | |0;ai-astar;116;112;116;118;116;134;116;115;119;117 21:03:23 INFO - PROCESS | 1940 | |1;audio-beat-detection;158;122;140;163;122;143;164;150;194;125 21:03:23 INFO - PROCESS | 1940 | |2;audio-dft;203;201;200;208;201;197;200;195;199;196 21:03:23 INFO - PROCESS | 1940 | |3;audio-fft;67;82;76;141;59;56;61;70;127;60 21:03:23 INFO - PROCESS | 1940 | |4;audio-oscillator;79;82;138;77;79;88;121;81;79;121 21:03:23 INFO - PROCESS | 1940 | |5;imaging-gaussian-blur;91;89;91;88;91;87;92;88;91;88 21:03:23 INFO - PROCESS | 1940 | |6;imaging-darkroom;95;96;97;96;95;95;95;118;94;97 21:03:23 INFO - PROCESS | 1940 | |7;imaging-desaturate;147;148;91;90;91;91;89;115;147;89 21:03:23 INFO - PROCESS | 1940 | |8;json-parse-financial;60;64;62;71;83;59;63;106;52;57 21:03:23 INFO - PROCESS | 1940 | |9;json-stringify-tinderbox;66;66;65;71;81;74;73;54;68;98 21:03:23 INFO - PROCESS | 1940 | |10;stanford-crypto-aes;82;83;81;82;80;81;83;78;84;83 21:03:23 INFO - PROCESS | 1940 | |11;stanford-crypto-ccm;126;129;129;136;123;145;117;146;169;166 21:03:23 INFO - PROCESS | 1940 | |12;stanford-crypto-pbkdf2;168;161;180;216;159;225;216;175;171;160 21:03:23 INFO - PROCESS | 1940 | |13;stanford-crypto-sha256-iterative;68;69;66;67;68;69;65;75;91;95 21:03:23 INFO - PROCESS | 1940 | __end_tp_report 21:03:23 INFO - PROCESS | 1940 | __start_cc_report 21:03:23 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1047 21:03:23 INFO - PROCESS | 1940 | __end_cc_report 21:03:23 INFO - PROCESS | 1940 | __startTimestamp1467950603077__endTimestamp 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | ------- Summary: start ------- 21:03:23 INFO - PROCESS | 1940 | Number of tests: 14 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#0] ai-astar Cycles:10 Average:117.90 Median:116.50 stddev:5.95 (5.1%) stddev-sans-first:6.27 21:03:23 INFO - PROCESS | 1940 | Values: 116.0 112.0 116.0 118.0 116.0 134.0 116.0 115.0 119.0 117.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:154.00 stddev:22.78 (14.8%) stddev-sans-first:23.88 21:03:23 INFO - PROCESS | 1940 | Values: 158.0 122.0 140.0 163.0 122.0 143.0 164.0 150.0 194.0 125.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#2] audio-dft Cycles:10 Average:200.00 Median:200.50 stddev:3.74 (1.9%) stddev-sans-first:3.81 21:03:23 INFO - PROCESS | 1940 | Values: 203.0 201.0 200.0 208.0 201.0 197.0 200.0 195.0 199.0 196.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#3] audio-fft Cycles:10 Average:79.90 Median:64.00 stddev:29.81 (46.6%) stddev-sans-first:31.25 21:03:23 INFO - PROCESS | 1940 | Values: 67.0 82.0 76.0 141.0 59.0 56.0 61.0 70.0 127.0 60.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:79.00 stddev:22.86 (28.9%) stddev-sans-first:23.55 21:03:23 INFO - PROCESS | 1940 | Values: 79.0 82.0 138.0 77.0 79.0 88.0 121.0 81.0 79.0 121.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:91.00 stddev:1.78 (2.0%) stddev-sans-first:1.81 21:03:23 INFO - PROCESS | 1940 | Values: 91.0 89.0 91.0 88.0 91.0 87.0 92.0 88.0 91.0 88.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:95.50 stddev:7.16 (7.5%) stddev-sans-first:7.52 21:03:23 INFO - PROCESS | 1940 | Values: 95.0 96.0 97.0 96.0 95.0 95.0 95.0 118.0 94.0 97.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#7] imaging-desaturate Cycles:10 Average:109.80 Median:89.50 stddev:27.02 (30.2%) stddev-sans-first:25.08 21:03:23 INFO - PROCESS | 1940 | Values: 147.0 148.0 91.0 90.0 91.0 91.0 89.0 115.0 147.0 89.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:62.50 stddev:15.90 (25.4%) stddev-sans-first:16.62 21:03:23 INFO - PROCESS | 1940 | Values: 60.0 64.0 62.0 71.0 83.0 59.0 63.0 106.0 52.0 57.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:11.65 (16.2%) stddev-sans-first:12.18 21:03:23 INFO - PROCESS | 1940 | Values: 66.0 66.0 65.0 71.0 81.0 74.0 73.0 54.0 68.0 98.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.50 stddev:1.77 (2.1%) stddev-sans-first:1.87 21:03:23 INFO - PROCESS | 1940 | Values: 82.0 83.0 81.0 82.0 80.0 81.0 83.0 78.0 84.0 83.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:140.50 stddev:17.73 (12.6%) stddev-sans-first:18.21 21:03:23 INFO - PROCESS | 1940 | Values: 126.0 129.0 129.0 136.0 123.0 145.0 117.0 146.0 169.0 166.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:177.50 stddev:25.76 (14.5%) stddev-sans-first:26.74 21:03:23 INFO - PROCESS | 1940 | Values: 168.0 161.0 180.0 216.0 159.0 225.0 216.0 175.0 171.0 160.0 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - PROCESS | 1940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:69.00 stddev:10.76 (15.6%) stddev-sans-first:11.24 21:03:23 INFO - PROCESS | 1940 | Values: 68.0 69.0 66.0 67.0 68.0 69.0 65.0 75.0 91.0 95.0 21:03:23 INFO - PROCESS | 1940 | -------- Summary: end -------- 21:03:23 INFO - PROCESS | 1940 | 21:03:23 INFO - TEST-INFO | 1940: exit 0 21:03:23 INFO - TEST-OK | kraken | took 58750ms 21:03:23 INFO - SUITE-END | took 1169s 21:03:24 INFO - Completed test suite (00:19:29) 21:03:24 INFO - javascript benchmark 21:03:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2884.35102102027, 3658.9817050914726, 3686.981565092174, 3706.2216934443763, 3734.551853777547, 5950.37521060289, 5961.612495187821, 5966.284045914491, 5982.282126144869, 5989.431004054613, 5978.8804223915495, 6001.039833626621, 6023.638581685102, 6053.273607167146, 6062.9090563641585, 4087.366458198969, 5092.567131793793, 5375.6774593524315, 5395.973020134914, 5397.4062853086125, 5329.413764485904, 5393.1101368274185, 5418.972905135469, 5437.0, 5461.563074954014, 5398.6220964532495, 5425.701586412746, 5433.673979561219, 5438.374586922495, 5438.456154384569, 4460.509343972193, 5380.0, 5381.219723140142, 5408.107662235727, 5443.938432005761, 5235.188545775411, 5334.546563542103, 5356.7321633918145, 5407.540359069484, 5426.674399536001, 5548.72256387179, 5555.3611334696625, 5947.702614869239, 5989.131575921467, 5992.101184822268, 6160.5687601867885, 6170.167027451282, 6206.975848984957, 6225.564210505267, 6238.1266622672865, 6348.587341822813, 6360.745570177188, 6379.106925030499, 6401.359864013608, 6416.550841441101, 5968.522518198533, 6107.725152368154, 6120.846978825521, 6121.0, 6126.693665316761, 6376.521760867953, 6422.743090276336, 6493.285738568754, 6502.707378167994, 6611.33886611335, 5194.896102077937, 6202.937970620236, 6220.160278362454, 6227.501799856092, 6240.344763799826, 6281.685915704196, 6301.117843501914, 6322.747090116436, 6328.272248691367, 6337.0, 6170.228721409824, 6221.844453888689, 6235.158253635792, 6264.248290205204, 6331.398517140957, 6231.034189700513, 6252.781152659726, 6255.0, 6258.968705156445, 6285.2457705075685, 5011.373578302712, 5070.61970352225, 5077.593792496666, 5087.23691446286, 5090.745462726849, 4577.359169716243, 4577.931331030038, 4585.518520555361, 4610.10103029906, 4664.0, 6120.821161151463, 6190.628562286277, 6203.193584833943, 6212.968935155386, 6223.813285601439, 6220.066989951453, 6303.527235457267, 6352.174217351715, 6368.331325210786, 6485.0272459130565, 6106.694665266719, 6142.631442113398, 6153.815385538441, 6195.721192546346, 6206.224221972254, 5630.380658127603, 5651.773929042874, 5657.349404818498, 5657.830265092054, 5679.176519404663, 6505.0892874997535, 6571.474282057424, 6660.300668429939, 6689.832754181184, 6698.296678848748, 6345.936540634534, 6355.968220158869, 6377.553571250153, 6379.649119298483, 6389.584676995981, 6662.600243985376, 6666.333366663295, 6696.1629796275465, 6712.093867327848, 6715.395614394728, 6145.9692701536205, 6187.0, 6238.064290356301, 6239.532035097477, 6305.180326557702, 6345.016522438845, 6362.172917520693, 6374.203224596926, 6382.96808515973, 6458.903116453351, 5432.565394768488, 5532.723363831873, 6173.98129308677, 6233.719482623384, 6252.812415627356, 4991.975040124777, 6118.040554665315, 6148.954677704712, 6214.937850621617, 6248.156498872594, 4977.203647416396, 6064.605800622945, 6187.752489900354, 6234.688265586612, 6282.780102696383, 6184.381561843959, 6196.442320191204, 6199.907001394892, 6221.3156552780065, 6266.154069200599, 4526.366308716716, 4969.850904472872, 5143.3570803649545, 6137.009281402588, 6219.720112595034], "value": 5824.0919777745175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.9350081239845, 520.6927912531605, 537.1995726367713, 556.6993823335398, 570.57207094679, 34378.31243375131, 38121.80939095304, 39571.40642890359, 39755.80122099385, 39840.40239396411, 41165.17669646605, 41812.954676133115, 41822.0, 41831.37252941208, 41947.37078943818, 9522.761930951747, 9658.661946831862, 9763.463009534473, 9773.511324433786, 9805.803883922317, 9736.853947190797, 9898.35660682057, 9902.158316543102, 9955.153811925959, 9962.950185249063, 9870.186996705905, 9886.50567471627, 9955.352902061379, 9979.550920208572, 10014.048665376778, 9832.508374581243, 9903.10872021518, 10003.79992400148, 10003.949980250125, 10025.749356266078, 9778.559964801601, 9782.266330025277, 9798.65704700332, 9906.0, 9907.207423406182, 39057.21885562301, 39370.803145984086, 39478.0, 39643.60356396457, 39677.40483892744, 2988.9551656725166, 3396.8301584920655, 3518.36669399508, 3877.670398016172, 3926.0, 23839.523209535884, 28407.147785566467, 28759.56860647092, 29617.851910740523, 30212.0, 2663.853488058156, 2717.790583190481, 2781.8191817531797, 2810.227187523427, 2856.985715071432, 467080.0, 472107.0, 473234.99999999657, 473819.0, 485331.0, 37202.0, 37930.86207413782, 37962.430563541566, 38042.66850660214, 60367.39632603706, 35653.8217308917, 35708.0, 35799.46300805438, 36006.27987440237, 36016.45975310372, 15573.454929077428, 15601.609959751097, 16032.679346413006, 16043.919780401024, 16082.517524474284, 13592.592222233348, 13618.727625447436, 13630.659233519242, 13654.795178072336, 13717.17696938187, 8322.0, 8394.076651568323, 8401.579921003926, 8415.452995555392, 8484.533350665773, 3425.6745609167087, 3494.336076145524, 3497.300539892032, 3519.9472007919903, 3535.4343305071066, 965.6958058211641, 966.7244835222068, 996.14829320931, 1065.174489770434, 1151.83874257604, 30675.84662076675, 30681.0, 30878.304033298, 30916.69083309183, 31151.065468035995, 1092.5575142067476, 1136.5794655977177, 1249.4689756853302, 1277.1672649747643, 1302.8827405533548, 15398.615034624, 15403.0, 15868.60328491797, 15876.0, 16743.827932044638, 621619.0, 631462.0, 633791.0, 639357.0, 640082.0, 62409.0, 63213.0, 63282.36717632857, 63296.36703632997, 63307.6834615824, 1506.6007508010387, 1527.9312430940413, 1531.5175719648498, 1539.3765524962184, 1545.1656105703019, 30316.938907138145, 30702.539461907643, 30768.384632307676, 30788.94873329326, 31117.066488005396, 51810.0, 52352.0, 52357.47642523678, 52435.0, 52519.68700782511, 441595.0, 442078.0, 442710.0, 444636.0, 445956.0, 25682.84427200743, 26612.866935665974, 26727.19818405451, 26849.328766780985, 27056.05303814357, 44165.77917110394, 44623.33065003963, 45405.772971136255, 45412.864678381986, 45532.54467455283, 37160.88517344484, 37313.06717332089, 37461.81269093637, 37569.62430375661, 38122.237555249296, 28779.0, 36057.27885442224, 36302.455463168604, 36728.449073264455, 37067.814660926524, 35889.64110358863, 35915.46126808152, 36041.0, 36118.8194059028, 38080.42879356757, 32386.0, 32645.673543264264, 32664.83667581647, 32855.34289314248, 32939.83530082334, 24912.0, 24923.0, 25055.87472062628, 25542.36144096338, 25813.870930645226], "value": 18603.565004699623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.9385092236164, 414.28122207969176, 415.4993233154046, 418.5605114629639, 419.230711644133, 18282.81717182828, 20342.796572034276, 21133.68299475509, 21190.682139767898, 22404.439889002784, 17642.558936026606, 19064.237430502762, 20585.0, 20668.793312066875, 20670.17319307226, 4960.503949605047, 5815.185873977646, 5862.120681897707, 6001.429864162919, 6053.939460605404, 5898.292204935414, 5915.290165180184, 5992.670403127826, 6017.48851347636, 6021.42796434338, 5294.497022782849, 5811.796587119452, 5905.30359726587, 5969.910451343233, 6004.3395226525045, 5912.852178695524, 6004.819855404301, 6005.2193214882, 6007.309159446632, 6022.2773267207995, 5162.148245539482, 5199.740012999373, 5253.238280449352, 5260.605454590921, 5277.076511610491, 13013.609591712264, 13753.312334383241, 13754.65613359664, 26462.470750585075, 26647.333816654544, 2278.9658155127686, 2375.3467796355967, 2471.851688898672, 2766.432881259337, 2843.516602177635, 7592.785154375273, 9680.322377433513, 9952.253580981456, 10278.280520363578, 10309.742256443575, 1820.1718218210815, 1823.872328936975, 1842.9539261518435, 1883.0396497786091, 1910.3409323783274, 106712.46643766809, 109027.81944361147, 111517.0, 113008.43495782634, 114270.0, 9339.719808405758, 11858.584949526725, 12068.215565988183, 12139.878601214052, 12242.081843861568, 14364.281785910664, 15254.694906101815, 15418.768718469231, 15460.608545230984, 15733.292001859943, 8945.329100317502, 8965.237954773787, 8980.46117232968, 9057.77355566103, 9268.72193834186, 9016.053314402025, 9093.04523025086, 9132.22376098039, 9203.815923681623, 9251.0, 4803.639727020487, 4818.8795280118275, 4836.081144582518, 4924.409070911442, 4937.8271760488215, 2057.6399130152163, 2124.968125478119, 2130.499332656824, 2174.9891250543646, 2184.803367696915, 948.6395169835419, 1012.9414761574026, 1065.5631191211567, 1077.42357838556, 1095.7370231144469, 17986.640267194583, 18864.868107913568, 19916.00419979024, 20704.792952070286, 20994.37016889496, 973.7224890906058, 985.9161971232526, 1005.8943810899897, 1020.7805321855836, 1042.280826229899, 9528.19010384125, 10588.629397971034, 10945.522354482202, 10988.450577471254, 11179.280161474064, 622208.0, 626354.0, 635268.0, 647322.0, 650434.0, 105749.88500229952, 121788.0, 127189.36405317915, 130371.34814326058, 136267.0, 1032.442481060234, 1054.0460882900986, 1069.8662667166604, 1070.6937536205817, 1076.311160857052, 17902.83631563944, 17945.0, 18016.0, 18278.451646450627, 18451.538711531783, 41060.0, 42114.789426052674, 50134.24798627951, 50859.72850678763, 55502.72248638731, 54729.0, 66807.66596167182, 70521.29478705148, 71430.0, 73522.63238683772, 7946.40401969843, 8071.71748988806, 8148.674053037812, 8171.182881711781, 8221.095679475373, 12044.21712588679, 12098.939505302416, 12237.510499579917, 12296.0, 12475.875241247471, 9508.429494230368, 10124.59501619927, 10150.796984060426, 10598.47007649599, 10961.561537538728, 10494.10800081971, 10579.523921423708, 10607.41659208751, 10741.301815381976, 10861.131109511061, 10745.301555399186, 11184.049355804847, 11287.887121129012, 11410.201285910238, 11553.942230288794, 6896.517243793087, 8149.103598604031, 8263.628136733741, 8272.420930534805, 8385.1195624461, 7885.0, 8212.589370531568, 10885.564577416815, 11004.009639132517, 11064.336139831636], "value": 9494.746908443714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1610.3961014619517, 1628.641698826258, 1906.8474522038239, 1997.5305803136268, 2058.7838276980906, 8323.292520135781, 8982.326325525595, 9161.770955726102, 9355.06449355065, 9391.71824845255, 9080.091990800916, 9089.181973622373, 9240.168384845363, 9242.95378523108, 9249.953750231256, 2544.198577448098, 2556.5653838847347, 2561.4748976459828, 2584.9741502585016, 2587.5342438361085, 2513.434477242624, 2579.32937436267, 2581.1224183777513, 2586.159498163095, 2586.822995537026, 2538.073603134861, 2554.3741783263126, 2561.3852675357966, 2582.4705935283314, 2590.093467286444, 2542.567763480222, 2549.987250063747, 2556.8593727344987, 2584.030988379358, 2584.44434446593, 2168.642174041281, 2539.492101579673, 2565.230430870731, 2566.396896729267, 2584.4055867150473, 9157.633694652273, 9232.538373081386, 9237.0, 9280.628774848998, 9285.350025498217, 5591.916121258185, 5663.5186009189265, 5763.942360576382, 5792.536597072224, 5801.854953626151, 3653.5798383186007, 3769.2838360711376, 3809.7523660962224, 3820.541535015788, 3832.6550610445192, 1060.0883240413239, 1071.4535586850684, 1076.1390887290136, 1097.6871591596437, 1103.4813637590319, 12143.574974875924, 12235.0, 12402.503899843996, 12410.627681169579, 12419.689507762288, 4991.975040124777, 5022.347094877642, 5089.287499750038, 5097.464766199496, 5135.024345374367, 10250.231232657581, 10412.843807342895, 10564.524596393181, 10596.894031059745, 10605.09856662177, 5558.166275058693, 5569.0, 5577.637453565505, 5654.575906806924, 5792.7103644818435, 4328.307470804656, 4599.172149013143, 4623.052274283764, 5014.473480284591, 5152.227165925141, 3621.3300539400293, 3890.7471014383973, 4242.045539753531, 4249.553796851348, 4302.741835489881, 1053.6364954090827, 1128.7798879218474, 1201.3512703140207, 1364.3110229334122, 1421.3532842556613, 957.9281553883486, 977.5845265762023, 978.1929907826072, 981.7840075183448, 994.5673631970116, 6023.909641355383, 6027.0, 6143.894099062211, 6182.887080325585, 6266.968665156736, 480.0590841949817, 487.8390131256748, 488.27978731370945, 491.9483454237325, 495.9479254678279, 3954.5056867891512, 4013.518377794683, 4062.532808727034, 4067.3288907330552, 4138.730982486129, 10672.786544269227, 11088.944555277172, 11092.0, 11102.500387482583, 11138.33170009802, 10541.209409294333, 10632.521536530874, 10807.513661885234, 10845.674629761119, 10895.400752958505, 8285.50286982783, 8353.707620233263, 8606.31149508038, 8613.267872230805, 8658.740237792876, 6020.668863212565, 6026.638401695912, 6107.297660769068, 6173.38266173397, 6196.845078873064, 10026.598936042768, 10090.394576325443, 10180.898191017995, 10249.077583017564, 10271.332363396356, 10054.899451005396, 10334.689959301233, 10367.585296588353, 10458.006489383497, 10661.733456663334, 5735.684537350319, 7098.148222213367, 7550.697972081055, 7759.262870027338, 7981.680732770624, 8496.32029437656, 8518.531480768617, 8545.572721364031, 8566.871496927426, 8599.355048371272, 7487.9516867637485, 7605.163432022362, 7644.0, 7646.852972054014, 7754.224577542201, 7173.10336207974, 7231.204567497466, 7235.204127546071, 7304.598247096461, 7326.3040011198855, 7231.240719724564, 7241.674124664298, 7245.601491917995, 7258.237885022208, 7279.8180045497165, 4959.256111583291, 5088.618353623419, 5094.108531007133, 5257.132573125392, 5274.548541135082, 5306.336707911511, 5334.439883812299, 5364.222187782828, 5418.593605479526, 5449.673019618677], "value": 4706.110682473382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.76616835878167, 333.72134267886315, 335.73476953206966, 341.93161367726464, 342.0252280999154, 5647.43525647435, 6318.715657795393, 6499.927511960521, 6857.417119544838, 6876.656167191639, 6709.597424154555, 6773.695183716733, 6815.6592170391405, 6841.7947461576105, 6845.247022827498, 4794.328793968838, 4879.609631229511, 5013.147764879979, 5020.0963826511215, 5032.723200223986, 4935.457099719028, 5013.523715247045, 5020.472850350716, 5029.698218106925, 5036.4208116066575, 4935.728534930578, 4936.284238785374, 4959.752012399365, 4976.253561965698, 4993.226049962262, 3830.693544516432, 4584.739196720911, 4957.330760347343, 4964.87587810304, 5021.472745361721, 3527.805970671612, 4348.434703488558, 4349.739015659071, 4361.105973275471, 4361.8441113105055, 6359.682015899233, 6548.541602087856, 6554.180727409074, 6590.538662293641, 6672.132622759059, 5893.79371721992, 5948.37542058082, 5953.613015154001, 5954.97022514889, 5970.940290597082, 7338.596377199252, 7341.082364704412, 7345.963270183614, 7346.853062938711, 7356.742514012038, 4013.5986401359924, 4893.584045356149, 4894.632902532288, 4897.559219670246, 4909.607231421478, 6199.87600247997, 7564.130125035581, 7794.10367807698, 7797.805054873674, 7821.882671759929, 4898.559129678346, 4937.308776771255, 5024.346834911438, 5026.346574945233, 5030.748462576857, 4372.934405983913, 5085.211792172219, 5090.363704536933, 5110.821121260812, 5111.821086261963, 5930.614510056833, 5996.610220335664, 6009.098635204667, 6014.699265036731, 6019.819405417845, 7286.344229019413, 7311.305425984523, 7324.743633972786, 7359.264073592598, 7373.078365204349, 1739.2955852879604, 1773.157750068707, 1773.973390399145, 1779.7864256289329, 1780.1010489702617, 1052.7420781908481, 1085.0505807418508, 1088.4176965323513, 1088.5101704233127, 1094.9781004379868, 5625.240592520039, 6995.93004069963, 7026.0, 7048.400885924651, 7052.929470705228, 7174.892376614355, 7336.669849856769, 7619.885701714478, 7633.122190948001, 7703.268189521987, 5718.656880587178, 6916.688749006306, 7075.044868942729, 7116.893246601305, 7122.323379278961, 4046.615571520701, 4085.775282359439, 4085.836566537365, 4103.2409004334295, 4112.527059388149, 7175.748848790267, 7887.250711182429, 8118.431709780259, 8120.0, 8157.510549367057, 7675.654595543102, 7970.855155319202, 7973.920260797434, 7980.920190798134, 7988.800279993046, 6507.674616269168, 6761.830954226184, 7886.132525422199, 8096.190380961974, 8153.388495862834, 6925.27284635106, 7060.117485314336, 7751.6511756972195, 7755.06939167281, 7767.184445633127, 7533.209013053551, 7534.924650753423, 7550.244975502405, 7558.395328373607, 7564.394848412004, 7760.417968652261, 8122.675092996214, 8124.83750325002, 8130.796730081795, 8137.877931830909, 4813.879653008703, 4855.781489832895, 4859.173940430064, 4863.708177509361, 4870.318155458168, 6477.643729594917, 7651.961740191264, 7653.808654783675, 7658.349040331412, 7672.961635191788, 7334.193238743841, 7341.70633174667, 7346.449016323904, 7364.153122390993, 7408.518446300973, 7084.2915708428745, 7309.853802923805, 7335.486515943832, 7343.926560734538, 7358.080239970004, 7167.498275120692, 7174.139103307636, 7186.281371862772, 7197.568145911262, 7200.855982880208, 6634.83412914681, 7280.126384833854, 7328.523645962995, 7345.632718364167, 7348.191698913009, 6905.202138823526, 7186.676599553137, 7196.676149573177, 7200.423966082805, 7209.6395180241825], "value": 5340.938308337444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.9695015249238, 650.2976785072119, 655.4265018109154, 666.1340257665034, 669.1869378704872, 15385.384584616615, 15631.983921045125, 15793.210339483037, 15802.367905283803, 15816.841831581694, 14621.707565848677, 14817.18505482198, 14823.0, 14836.0, 14837.183954882477, 816.1145157504116, 960.3901522533207, 972.4602845420789, 983.3853841349156, 988.2588058955783, 947.4504787223394, 977.1108291454777, 985.6796541124128, 988.3822610868208, 995.7012896131132, 1035.5081336365242, 1037.4294138223984, 1037.891021442749, 1038.4703801061476, 1043.2488608202082, 1001.6894762623574, 1030.0780801182975, 1032.9793404131876, 1035.5702383510834, 1040.9739756506071, 751.9661615227328, 759.965801538932, 764.8699721047435, 765.8512231652521, 770.7803276066294, 15181.696366072727, 15222.0, 15226.619334516725, 15285.235738213045, 15384.461543846024, 13351.599452016359, 13377.331133443386, 13450.192988420726, 13502.324883755871, 13654.0, 10336.483175841178, 10436.686899393031, 10440.947795260976, 10506.632267870587, 10764.677059688222, 3602.8018458984743, 3605.3330133925306, 3657.122290650251, 3672.769622176574, 3879.2241551689776, 79947.40105197922, 81812.0, 81922.59038704827, 82533.0, 82992.0, 9701.805963880683, 9748.415095094317, 9828.754281143028, 9923.751906202258, 10169.288149829588, 22496.43758906008, 22524.54950900973, 22662.093516259494, 23408.297751067494, 23502.294931152093, 7691.730789422455, 7726.266004729542, 7799.1031031430975, 7810.336121429742, 7904.589100324456, 4137.213929353413, 4199.979000105041, 4203.369494575777, 4208.305629571087, 4283.186194623012, 3728.850845966131, 3776.905577360533, 3781.8843441184918, 3800.144967382372, 3802.391617341212, 661.765073398946, 668.1147479589563, 671.9731210751613, 676.577139287945, 692.4633409107881, 522.4409881426913, 568.6417556939102, 579.5537436174207, 585.8330375842864, 604.8548348396441, 6584.440322572635, 6658.3341665834, 7193.884947833094, 8102.797430064177, 8284.792880177924, 506.3139446050622, 526.3525863188223, 606.142308633279, 610.5634471353004, 626.3517259636254, 3786.413105968579, 3847.03824043989, 3869.0, 3882.107115363482, 3903.59012303704, 81651.18348816555, 92722.0727792727, 94864.0, 96413.0, 96934.0, 79197.60401197957, 79245.60377198076, 79417.60291198622, 80015.59992200002, 80330.5983470079, 50892.727681808254, 69171.0, 69379.0, 70684.0, 71904.20239494159, 8065.516069035877, 8353.916460835313, 8385.706500272461, 8420.915790842259, 8481.53351565645, 49405.0, 50307.0, 50670.74664626653, 50836.491635084654, 51285.230721539956, 47599.0, 63641.0, 68932.0, 69014.0, 69960.0, 10925.344479331265, 10977.506012229309, 11018.724531886766, 11066.778664426827, 11098.056665183227, 11540.826887596524, 11569.826452603385, 11737.237079589799, 11777.764444711229, 11994.520219191134, 10977.231593788358, 11038.116950643769, 11078.833817492583, 11485.19603627738, 11687.240329378563, 11048.613298534512, 11055.72360690957, 11106.333619982826, 11173.050290725054, 11261.605843795427, 10699.0, 11251.7749645005, 11260.211785175286, 11522.135839812216, 11671.88328116708, 9442.85835712451, 9473.810523789623, 9474.00462073538, 9478.241740660593, 9515.476648784383, 9362.204212642002, 9552.23582113443, 9575.856362154434, 9577.473238971923, 9635.903640963781], "value": 7014.422396338782, "unit": "score"}], "name": "dromaeo_css", "value": 7523.7675801742125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 116.0, 118.0, 116.0, 134.0, 116.0, 115.0, 119.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 140.0, 163.0, 122.0, 143.0, 164.0, 150.0, 194.0, 125.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 201.0, 200.0, 208.0, 201.0, 197.0, 200.0, 195.0, 199.0, 196.0], "value": 200.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 82.0, 76.0, 141.0, 59.0, 56.0, 61.0, 70.0, 127.0, 60.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 138.0, 77.0, 79.0, 88.0, 121.0, 81.0, 79.0, 121.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 88.0, 91.0, 87.0, 92.0, 88.0, 91.0, 88.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 118.0, 94.0, 97.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 91.0, 90.0, 91.0, 91.0, 89.0, 115.0, 147.0, 89.0], "value": 109.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 62.0, 71.0, 83.0, 59.0, 63.0, 106.0, 52.0, 57.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 71.0, 81.0, 74.0, 73.0, 54.0, 68.0, 98.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 82.0, 80.0, 81.0, 83.0, 78.0, 84.0, 83.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 129.0, 136.0, 123.0, 145.0, 117.0, 146.0, 169.0, 166.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 180.0, 216.0, 159.0, 225.0, 216.0, 175.0, 171.0, 160.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 67.0, 68.0, 69.0, 65.0, 75.0, 91.0, 95.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1553.5999999999997, "alertThreshold": 2.0}]} 21:03:24 INFO - Return code: 0 21:03:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:03:24 ERROR - # TBPL SUCCESS # 21:03:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:03:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:03:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:03:24 INFO - 2016-07-07 21:03:24.366 screenresolution[1945:12555] starting screenresolution argv=screenresolution get 21:03:24 INFO - 2016-07-07 21:03:24.368 screenresolution[1945:12555] Display 0: 1600x1200x32@60 21:03:24 INFO - 2016-07-07 21:03:24.374 screenresolution[1946:12558] starting screenresolution argv=screenresolution list 21:03:24 INFO - Available Modes on Display 0 21:03:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:03:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:03:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:03:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:03:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:03:24 INFO - Intel Iris: 21:03:24 INFO - Chipset Model: Intel Iris 21:03:24 INFO - Type: GPU 21:03:24 INFO - Bus: Built-In 21:03:24 INFO - VRAM (Dynamic, Max): 1536 MB 21:03:24 INFO - Vendor: Intel (0x8086) 21:03:24 INFO - Device ID: 0x0a2e 21:03:24 INFO - Revision ID: 0x0009 21:03:24 INFO - Displays: 21:03:24 INFO - Display: 21:03:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:03:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:03:24 INFO - Display Serial Number: 1600x1200 60 21:03:24 INFO - Main Display: Yes 21:03:24 INFO - Mirror: Off 21:03:24 INFO - Online: Yes 21:03:24 INFO - Rotation: Supported 21:03:24 INFO - Return code: 0 21:03:24 INFO - Running post-action listener: _resource_record_post_action 21:03:24 INFO - Running post-run listener: _resource_record_post_run 21:03:25 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 2031616; Write bytes: 495759872; Read time: 23; Write time: 1675 21:03:25 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 189010432; Write bytes: 186058752; Read time: 17362; Write time: 389 21:03:25 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 1196032; Write bytes: 298842624; Read time: 19; Write time: 1225 21:03:25 INFO - Running post-run listener: _upload_blobber_files 21:03:25 INFO - Blob upload gear active. 21:03:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:03:25 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 21:03:25 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'] 21:03:25 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 21:03:26 INFO - (blobuploader) - INFO - Open directory for files ... 21:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:03:26 INFO - (blobuploader) - INFO - Done attempting. 21:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:03:27 INFO - (blobuploader) - INFO - Done attempting. 21:03:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:03:27 INFO - Return code: 0 21:03:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:03:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:03:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b8f037fcbbe54becd74e541be5e807f456d322f467f98e84cce2fbaf7d1444dd362c1f735b09994e398976100fd70a73a82b6b09a0c60cf17dfe725aafb93aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15146243de869e446ff3ff6b0d54237d3a3187fe080b03d2b5cf2308d2d44e8c1d7cadddf8e947e17882127bd4e7336bb5348af3a859ed3c41f4c34c12b81c8a"} 21:03:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:03:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:03:27 INFO - Contents: 21:03:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b8f037fcbbe54becd74e541be5e807f456d322f467f98e84cce2fbaf7d1444dd362c1f735b09994e398976100fd70a73a82b6b09a0c60cf17dfe725aafb93aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15146243de869e446ff3ff6b0d54237d3a3187fe080b03d2b5cf2308d2d44e8c1d7cadddf8e947e17882127bd4e7336bb5348af3a859ed3c41f4c34c12b81c8a"} 21:03:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:03:27 INFO - Copying logs to upload dir... 21:03:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:03:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.827856 ========= master_lag: 3.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-07-07 21:03:31.138201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:31.141889) ========= 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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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/1b8f037fcbbe54becd74e541be5e807f456d322f467f98e84cce2fbaf7d1444dd362c1f735b09994e398976100fd70a73a82b6b09a0c60cf17dfe725aafb93aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15146243de869e446ff3ff6b0d54237d3a3187fe080b03d2b5cf2308d2d44e8c1d7cadddf8e947e17882127bd4e7336bb5348af3a859ed3c41f4c34c12b81c8a"} build_url:https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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/1b8f037fcbbe54becd74e541be5e807f456d322f467f98e84cce2fbaf7d1444dd362c1f735b09994e398976100fd70a73a82b6b09a0c60cf17dfe725aafb93aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15146243de869e446ff3ff6b0d54237d3a3187fe080b03d2b5cf2308d2d44e8c1d7cadddf8e947e17882127bd4e7336bb5348af3a859ed3c41f4c34c12b81c8a"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:31.188505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:31.189162) ========= 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.9tRtVH8RzU/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.iJdHd8Qq39/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005191 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:31.238072) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 21:03:31.238432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 21:03:31.238825) ========= ========= Total master_lag: 3.57 =========