builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0047 starttime: 1469617241.39 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:41.389531) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:41.390065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:41.390408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:41.415727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:41.416480) ========= 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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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-27 04:00:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2016-07-27 04:00:41 (8.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140819 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:41.584805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:41.585612) ========= 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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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-27 04:00:41.639779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:00:41.640680) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --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 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e5RhG5Fn39/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.sJzxKKYY9B/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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-27 04:00:41,721 truncating revision to first 12 chars 2016-07-27 04:00:41,722 Setting DEBUG logging. 2016-07-27 04:00:41,722 attempt 1/10 2016-07-27 04:00:41,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/958cee08361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 04:00:42,681 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.239852 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:00:42.905103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.905480) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.905926) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.906263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.924664) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-27 04:00:42.924986) ========= /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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:00:43 INFO - MultiFileLogger online at 20160727 04:00:43 in /builds/slave/test 04:00:43 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 04:00:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:43 INFO - {'append_to_log': False, 04:00:43 INFO - 'base_work_dir': '/builds/slave/test', 04:00:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:00:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:43 INFO - 'branch': 'Mozilla-Beta', 04:00:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:43 INFO - 'config_files': ('talos/mac_config.py',), 04:00:43 INFO - 'default_actions': ('clobber', 04:00:43 INFO - 'read-buildbot-config', 04:00:43 INFO - 'download-and-extract', 04:00:43 INFO - 'populate-webroot', 04:00:43 INFO - 'create-virtualenv', 04:00:43 INFO - 'install', 04:00:43 INFO - 'run-tests'), 04:00:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:43 INFO - 'download_minidump_stackwalk': True, 04:00:43 INFO - 'download_symbols': 'ondemand', 04:00:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:43 INFO - 'installer_path': 'installer.exe', 04:00:43 INFO - 'log_level': 'info', 04:00:43 INFO - 'log_name': 'talos', 04:00:43 INFO - 'log_to_console': True, 04:00:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:00:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:00:43 INFO - 'opt_config_files': (), 04:00:43 INFO - 'pip_index': False, 04:00:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:00:43 INFO - 'cmd': ('bash', 04:00:43 INFO - '-c', 04:00:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:00:43 INFO - 'enabled': True, 04:00:43 INFO - 'halt_on_failure': False, 04:00:43 INFO - 'name': 'check_screen_resolution'},), 04:00:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:00:43 INFO - 'cmd': ('bash', 04:00:43 INFO - '-c', 04:00:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:00:43 INFO - 'enabled': True, 04:00:43 INFO - 'halt_on_failure': False, 04:00:43 INFO - 'name': 'check_screen_resolution'},), 04:00:43 INFO - 'run_cmd_checks_enabled': True, 04:00:43 INFO - 'sps_profile': False, 04:00:43 INFO - 'sps_profile_interval': 0, 04:00:43 INFO - 'suite': 'dromaeojs-e10s', 04:00:43 INFO - 'system_bits': '32', 04:00:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:43 INFO - 'title': 't-yosemite-r7-0047', 04:00:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:43 INFO - 'use_talos_json': True, 04:00:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:43 INFO - 'work_dir': 'build'} 04:00:43 INFO - ##### 04:00:43 INFO - ##### Running clobber step. 04:00:43 INFO - ##### 04:00:43 INFO - Running pre-action listener: _resource_record_pre_action 04:00:43 INFO - Running main action method: clobber 04:00:43 INFO - rmtree: /builds/slave/test/build 04:00:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:44 INFO - Running post-action listener: _resource_record_post_action 04:00:44 INFO - ##### 04:00:44 INFO - ##### Running read-buildbot-config step. 04:00:44 INFO - ##### 04:00:44 INFO - Running pre-action listener: _resource_record_pre_action 04:00:44 INFO - Running main action method: read_buildbot_config 04:00:44 INFO - Using buildbot properties: 04:00:44 INFO - { 04:00:44 INFO - "project": "", 04:00:44 INFO - "product": "firefox", 04:00:44 INFO - "script_repo_revision": "production", 04:00:44 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:00:44 INFO - "repository": "", 04:00:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:00:44 INFO - "buildid": "20160726073802", 04:00:44 INFO - "pgo_build": "False", 04:00:44 INFO - "basedir": "/builds/slave/test", 04:00:44 INFO - "buildnumber": 42, 04:00:44 INFO - "slavename": "t-yosemite-r7-0047", 04:00:44 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:00:44 INFO - "platform": "yosemite_r7", 04:00:44 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:00:44 INFO - "branch": "mozilla-beta", 04:00:44 INFO - "repo_path": "releases/mozilla-beta", 04:00:44 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:00:44 INFO - "stage_platform": "macosx64", 04:00:44 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:00:44 INFO - "slavebuilddir": "test" 04:00:44 INFO - } 04:00:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:00:44 INFO - Running post-action listener: _resource_record_post_action 04:00:44 INFO - ##### 04:00:44 INFO - ##### Running download-and-extract step. 04:00:44 INFO - ##### 04:00:44 INFO - Running pre-action listener: _resource_record_pre_action 04:00:44 INFO - Running main action method: download_and_extract 04:00:44 INFO - mkdir: /builds/slave/test/build/tests 04:00:44 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')]} 04:00:44 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:45 INFO - Downloaded 1165 bytes. 04:00:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:00:45 INFO - Using the following test package requirements: 04:00:45 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:00:45 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:45 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:00:45 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:45 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:00:45 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:00:45 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:45 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:00:45 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:00:45 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:45 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:00:45 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:45 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:00:45 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:45 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:00:45 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:45 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:00:45 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:00:45 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')]} 04:00:45 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:46 INFO - Downloaded 18314870 bytes. 04:00: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'] 04:00: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 04:00:49 INFO - Return code: 0 04:00:49 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 04:00: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')]} 04:00:49 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:50 INFO - Downloaded 18314870 bytes. 04:00:50 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'] 04:00:50 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 04:00:54 INFO - Return code: 0 04:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:00:54 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:00:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:00:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:00:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:55 INFO - Downloaded 10840145 bytes. 04:00:55 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'] 04:00:55 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 04:00:55 INFO - Return code: 0 04:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:55 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:00:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:00:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:00:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:00:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/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 04:00:58 INFO - Downloaded 86255188 bytes. 04:00:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:00:58 INFO - mkdir: /builds/slave/test/properties 04:00:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:58 INFO - Contents: 04:00:58 INFO - build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:00:58 INFO - Running post-action listener: _resource_record_post_action 04:00:58 INFO - Running post-action listener: set_extra_try_arguments 04:00:58 INFO - ##### 04:00:58 INFO - ##### Running populate-webroot step. 04:00:58 INFO - ##### 04:00:58 INFO - Running pre-action listener: _resource_record_pre_action 04:00:58 INFO - Running main action method: populate_webroot 04:00:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:58 INFO - '--tppagecycles', 04:00:58 INFO - '7'], 04:00:58 INFO - 'tests': ['tsvgm']}}, 04:00:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:00:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['damp', 'tps']}, 04:00:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'tests': ['damp', 'tps']}, 04:00:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['dromaeo_dom']}, 04:00:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['a11yr', 04:00:58 INFO - 'ts_paint', 04:00:58 INFO - 'tpaint', 04:00:58 INFO - 'sessionrestore', 04:00:58 INFO - 'sessionrestore_no_auto_restore', 04:00:58 INFO - 'tabpaint']}, 04:00:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:58 INFO - 'ts_paint', 04:00:58 INFO - 'tpaint', 04:00:58 INFO - 'sessionrestore', 04:00:58 INFO - 'sessionrestore_no_auto_restore', 04:00:58 INFO - 'tabpaint']}, 04:00:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:00:58 INFO - 'ts_paint', 04:00:58 INFO - 'tpaint', 04:00:58 INFO - 'sessionrestore', 04:00:58 INFO - 'sessionrestore_no_auto_restore', 04:00:58 INFO - 'tabpaint']}, 04:00:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:00:58 INFO - 'ts_paint', 04:00:58 INFO - 'tpaint', 04:00:58 INFO - 'sessionrestore', 04:00:58 INFO - 'sessionrestore_no_auto_restore', 04:00:58 INFO - 'tabpaint']}, 04:00:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['a11yr', 04:00:58 INFO - 'ts_paint', 04:00:58 INFO - 'tpaint', 04:00:58 INFO - 'sessionrestore', 04:00:58 INFO - 'sessionrestore_no_auto_restore', 04:00:58 INFO - 'tabpaint']}, 04:00:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['a11yr', 04:00:58 INFO - 'ts_paint', 04:00:58 INFO - 'tpaint', 04:00:58 INFO - 'sessionrestore', 04:00:58 INFO - 'sessionrestore_no_auto_restore', 04:00:58 INFO - 'tabpaint']}, 04:00:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['tsvgx', 04:00:58 INFO - 'tsvgr_opacity', 04:00:58 INFO - 'tart', 04:00:58 INFO - 'tscrollx', 04:00:58 INFO - 'cart']}, 04:00:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:58 INFO - 'tsvgr_opacity', 04:00:58 INFO - 'tart', 04:00:58 INFO - 'tscrollx', 04:00:58 INFO - 'cart']}, 04:00:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'talos_options': ['--disable-e10s'], 04:00:58 INFO - 'tests': ['tp5o']}, 04:00:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'tests': ['tp5o']}, 04:00:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'talos_options': ['--disable-e10s', 04:00:58 INFO - '--xperf_path', 04:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:58 INFO - 'tests': ['tp5n']}, 04:00:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:58 INFO - 'talos_options': ['--xperf_path', 04:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:58 INFO - 'tests': ['tp5n']}}, 04:00:58 INFO - 'talos.zip': {'path': '', 04:00:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:58 INFO - Running post-action listener: _resource_record_post_action 04:00:58 INFO - ##### 04:00:58 INFO - ##### Running create-virtualenv step. 04:00:58 INFO - ##### 04:00:58 INFO - Running pre-action listener: _resource_record_pre_action 04:00:58 INFO - Running main action method: create_virtualenv 04:00:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:58 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 04:00:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:59 INFO - Using real prefix '/tools/python27' 04:00:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:02 INFO - Installing pip.................done. 04:01:02 INFO - Return code: 0 04:01:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:02 INFO - 'HOME': '/Users/cltbld', 04:01:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:02 INFO - 'LOGNAME': 'cltbld', 04:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:02 INFO - 'MOZ_NO_REMOTE': '1', 04:01:02 INFO - 'NO_EM_RESTART': '1', 04:01:02 INFO - 'PAGER': '/bin/cat', 04:01:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:02 INFO - 'PWD': '/builds/slave/test', 04:01:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:02 INFO - 'SHELL': '/bin/bash', 04:01:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:02 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:02 INFO - 'USER': 'cltbld', 04:01:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:02 INFO - 'XPC_FLAGS': '0x0', 04:01:02 INFO - 'XPC_SERVICE_NAME': '0', 04:01:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:02 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 04:01:02 INFO - Cleaning up... 04:01:02 INFO - Return code: 0 04:01:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:01:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:02 INFO - 'HOME': '/Users/cltbld', 04:01:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:02 INFO - 'LOGNAME': 'cltbld', 04:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:02 INFO - 'MOZ_NO_REMOTE': '1', 04:01:02 INFO - 'NO_EM_RESTART': '1', 04:01:02 INFO - 'PAGER': '/bin/cat', 04:01:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:02 INFO - 'PWD': '/builds/slave/test', 04:01:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:02 INFO - 'SHELL': '/bin/bash', 04:01:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:02 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:02 INFO - 'USER': 'cltbld', 04:01:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:02 INFO - 'XPC_FLAGS': '0x0', 04:01:02 INFO - 'XPC_SERVICE_NAME': '0', 04:01:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:03 INFO - Downloading/unpacking psutil>=0.7.1 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:06 INFO - Installing collected packages: psutil 04:01:06 INFO - Running setup.py install for psutil 04:01:06 INFO - building 'psutil._psutil_osx' extension 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 INFO - building 'psutil._psutil_posix' extension 04:01:06 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 04:01:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:01:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:01:06 INFO - ^ 04:01:06 INFO - 1 warning generated. 04:01:06 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 04:01:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:06 INFO - Successfully installed psutil 04:01:06 INFO - Cleaning up... 04:01:07 INFO - Return code: 0 04:01:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 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 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:07 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 04:01:07 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 04:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:07 INFO - 'HOME': '/Users/cltbld', 04:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:07 INFO - 'LOGNAME': 'cltbld', 04:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:07 INFO - 'MOZ_NO_REMOTE': '1', 04:01:07 INFO - 'NO_EM_RESTART': '1', 04:01:07 INFO - 'PAGER': '/bin/cat', 04:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:07 INFO - 'PWD': '/builds/slave/test', 04:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:07 INFO - 'SHELL': '/bin/bash', 04:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:07 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:07 INFO - 'USER': 'cltbld', 04:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:07 INFO - 'XPC_FLAGS': '0x0', 04:01:07 INFO - 'XPC_SERVICE_NAME': '0', 04:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:01:09 INFO - Installing collected packages: mozsystemmonitor 04:01:09 INFO - Running setup.py install for mozsystemmonitor 04:01:09 INFO - Successfully installed mozsystemmonitor 04:01:09 INFO - Cleaning up... 04:01:10 INFO - Return code: 0 04:01:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:10 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 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:10 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 04:01:10 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 04:01:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:10 INFO - 'HOME': '/Users/cltbld', 04:01:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:10 INFO - 'LOGNAME': 'cltbld', 04:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:10 INFO - 'MOZ_NO_REMOTE': '1', 04:01:10 INFO - 'NO_EM_RESTART': '1', 04:01:10 INFO - 'PAGER': '/bin/cat', 04:01:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:10 INFO - 'PWD': '/builds/slave/test', 04:01:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:10 INFO - 'SHELL': '/bin/bash', 04:01:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:10 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:10 INFO - 'USER': 'cltbld', 04:01:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:10 INFO - 'XPC_FLAGS': '0x0', 04:01:10 INFO - 'XPC_SERVICE_NAME': '0', 04:01:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:12 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 04:01:12 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 04:01:12 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 04:01:12 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 04:01:12 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 04:01:12 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 04:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:13 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 04:01:13 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 04:01:13 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 04:01:13 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 04:01:13 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 04:01:13 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 04:01:13 INFO - Downloading docopt-0.6.1.tar.gz 04:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:14 INFO - Running setup.py install for blobuploader 04:01:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:14 INFO - Running setup.py install for requests 04:01:14 INFO - Running setup.py install for docopt 04:01:14 INFO - Successfully installed blobuploader requests docopt 04:01:14 INFO - Cleaning up... 04:01:14 INFO - Return code: 0 04:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:14 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')]} 04:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:14 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')]} 04:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:14 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 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:14 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 04:01:14 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 04:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:14 INFO - 'HOME': '/Users/cltbld', 04:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:14 INFO - 'LOGNAME': 'cltbld', 04:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:14 INFO - 'MOZ_NO_REMOTE': '1', 04:01:14 INFO - 'NO_EM_RESTART': '1', 04:01:14 INFO - 'PAGER': '/bin/cat', 04:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:14 INFO - 'PWD': '/builds/slave/test', 04:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:14 INFO - 'SHELL': '/bin/bash', 04:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:14 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:14 INFO - 'USER': 'cltbld', 04:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:14 INFO - 'XPC_FLAGS': '0x0', 04:01:14 INFO - 'XPC_SERVICE_NAME': '0', 04:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-y6YbWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-wk3O6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-INKu3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-QZFcdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_ag6MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ntKBcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-BC2g0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-KSsa60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:15 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-7wNa7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-iSXttj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-BsXCq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-Auk4EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-i6Ymgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ANQaeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_C26O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ePphM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-jnwc33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:16 INFO - Running setup.py install for manifestparser 04:01:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:17 INFO - Running setup.py install for mozcrash 04:01:17 INFO - Running setup.py install for mozdebug 04:01:17 INFO - Running setup.py install for mozdevice 04:01:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:17 INFO - Running setup.py install for mozfile 04:01:17 INFO - Running setup.py install for mozhttpd 04:01:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:17 INFO - Running setup.py install for mozinfo 04:01:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:17 INFO - Running setup.py install for mozInstall 04:01:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Running setup.py install for mozleak 04:01:18 INFO - Running setup.py install for mozlog 04:01:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Running setup.py install for moznetwork 04:01:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Running setup.py install for mozprocess 04:01:18 INFO - Running setup.py install for mozprofile 04:01:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:18 INFO - Running setup.py install for mozrunner 04:01:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:19 INFO - Running setup.py install for mozscreenshot 04:01:19 INFO - Running setup.py install for moztest 04:01:19 INFO - Running setup.py install for mozversion 04:01:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:19 INFO - Cleaning up... 04:01:19 INFO - Return code: 0 04:01:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:19 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 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:19 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 04:01:19 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 04:01:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:19 INFO - 'HOME': '/Users/cltbld', 04:01:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:19 INFO - 'LOGNAME': 'cltbld', 04:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:19 INFO - 'MOZ_NO_REMOTE': '1', 04:01:19 INFO - 'NO_EM_RESTART': '1', 04:01:19 INFO - 'PAGER': '/bin/cat', 04:01:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:19 INFO - 'PWD': '/builds/slave/test', 04:01:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:19 INFO - 'SHELL': '/bin/bash', 04:01:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:19 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:19 INFO - 'USER': 'cltbld', 04:01:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:19 INFO - 'XPC_FLAGS': '0x0', 04:01:19 INFO - 'XPC_SERVICE_NAME': '0', 04:01:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:19 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-GvqrQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:19 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)) 04:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:19 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-27uMjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-XVKAa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-r8rY3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-dfAmnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-5sdTBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-lngCYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-0At9rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-xwfFFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_W9jak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ybQHJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:20 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)) 04:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:20 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-wbUNON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:21 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)) 04:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-bgsW3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:21 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)) 04:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-tqzD3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:21 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)) 04:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-XZhMDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:21 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)) 04:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-YrByuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:21 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)) 04:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-qz9fw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:21 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)) 04:01:21 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)) 04:01:21 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)) 04:01:21 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)) 04:01:21 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)) 04:01:21 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)) 04:01:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:24 INFO - Downloading blessings-1.6.tar.gz 04:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:24 INFO - Installing collected packages: blessings 04:01:24 INFO - Running setup.py install for blessings 04:01:24 INFO - Successfully installed blessings 04:01:24 INFO - Cleaning up... 04:01:24 INFO - Return code: 0 04:01:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:24 INFO - Reading from file tmpfile_stdout 04:01:24 INFO - Current package versions: 04:01:24 INFO - blessings == 1.6 04:01:24 INFO - blobuploader == 1.2.4 04:01:24 INFO - docopt == 0.6.1 04:01:24 INFO - manifestparser == 1.1 04:01:24 INFO - mozInstall == 1.12 04:01:24 INFO - mozcrash == 0.17 04:01:24 INFO - mozdebug == 0.1 04:01:24 INFO - mozdevice == 0.48 04:01:24 INFO - mozfile == 1.2 04:01:24 INFO - mozhttpd == 0.7 04:01:24 INFO - mozinfo == 0.9 04:01:24 INFO - mozleak == 0.1 04:01:24 INFO - mozlog == 3.1 04:01:24 INFO - moznetwork == 0.27 04:01:24 INFO - mozprocess == 0.22 04:01:24 INFO - mozprofile == 0.28 04:01:24 INFO - mozrunner == 6.11 04:01:24 INFO - mozscreenshot == 0.1 04:01:24 INFO - mozsystemmonitor == 0.0 04:01:24 INFO - moztest == 0.7 04:01:24 INFO - mozversion == 1.4 04:01:24 INFO - psutil == 3.1.1 04:01:24 INFO - requests == 1.2.3 04:01:24 INFO - wsgiref == 0.1.2 04:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:24 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')]} 04:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:24 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')]} 04:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:24 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 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:24 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 04:01:24 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 04:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:24 INFO - 'HOME': '/Users/cltbld', 04:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:24 INFO - 'LOGNAME': 'cltbld', 04:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:24 INFO - 'MOZ_NO_REMOTE': '1', 04:01:24 INFO - 'NO_EM_RESTART': '1', 04:01:24 INFO - 'PAGER': '/bin/cat', 04:01:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:24 INFO - 'PWD': '/builds/slave/test', 04:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:24 INFO - 'SHELL': '/bin/bash', 04:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:24 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:24 INFO - 'USER': 'cltbld', 04:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:24 INFO - 'XPC_FLAGS': '0x0', 04:01:24 INFO - 'XPC_SERVICE_NAME': '0', 04:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 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)) 04:01:25 INFO - Cleaning up... 04:01:25 INFO - Return code: 0 04:01:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:01:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:01:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:25 INFO - 'HOME': '/Users/cltbld', 04:01:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:25 INFO - 'LOGNAME': 'cltbld', 04:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:25 INFO - 'MOZ_NO_REMOTE': '1', 04:01:25 INFO - 'NO_EM_RESTART': '1', 04:01:25 INFO - 'PAGER': '/bin/cat', 04:01:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:25 INFO - 'PWD': '/builds/slave/test', 04:01:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:25 INFO - 'SHELL': '/bin/bash', 04:01:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:25 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:25 INFO - 'USER': 'cltbld', 04:01:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:25 INFO - 'XPC_FLAGS': '0x0', 04:01:25 INFO - 'XPC_SERVICE_NAME': '0', 04:01:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:25 INFO - Downloading/unpacking jsonschema 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:27 INFO - Downloading/unpacking functools32 (from jsonschema) 04:01:27 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 04:01:27 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 04:01:27 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 04:01:27 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 04:01:27 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 04:01:27 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 04:01:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:28 INFO - warning: no files found matching '*.txt' 04:01:28 INFO - no previously-included directories found matching 'build' 04:01:28 INFO - no previously-included directories found matching 'dist' 04:01:28 INFO - no previously-included directories found matching '.git*' 04:01:28 INFO - Installing collected packages: jsonschema, functools32 04:01:28 INFO - Running setup.py install for functools32 04:01:28 INFO - warning: no files found matching '*.txt' 04:01:28 INFO - no previously-included directories found matching 'build' 04:01:28 INFO - no previously-included directories found matching 'dist' 04:01:28 INFO - no previously-included directories found matching '.git*' 04:01:28 INFO - Successfully installed jsonschema functools32 04:01:28 INFO - Cleaning up... 04:01:28 INFO - Return code: 0 04:01:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:01:28 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')]} 04:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:28 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')]} 04:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:28 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 0x10b624a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b634420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caa597fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, '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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 04:01:28 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 04:01:28 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 04:01:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:28 INFO - 'HOME': '/Users/cltbld', 04:01:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:28 INFO - 'LOGNAME': 'cltbld', 04:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:28 INFO - 'MOZ_NO_REMOTE': '1', 04:01:28 INFO - 'NO_EM_RESTART': '1', 04:01:28 INFO - 'PAGER': '/bin/cat', 04:01:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:28 INFO - 'PWD': '/builds/slave/test', 04:01:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:28 INFO - 'SHELL': '/bin/bash', 04:01:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:28 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:28 INFO - 'USER': 'cltbld', 04:01:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:28 INFO - 'XPC_FLAGS': '0x0', 04:01:28 INFO - 'XPC_SERVICE_NAME': '0', 04:01:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:28 INFO - Downloading/unpacking flake8 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:01:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:01:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:32 INFO - no previously-included directories found matching 'docs/_build' 04:01:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:01:32 INFO - Running setup.py install for pep8 04:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:32 INFO - no previously-included directories found matching 'docs/_build' 04:01:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:01:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:01:32 INFO - Cleaning up... 04:01:32 INFO - Return code: 0 04:01:32 INFO - Running post-action listener: _resource_record_post_action 04:01:32 INFO - Running post-action listener: _start_resource_monitoring 04:01:32 INFO - Starting resource monitoring. 04:01:32 INFO - ##### 04:01:32 INFO - ##### Running install step. 04:01:32 INFO - ##### 04:01:32 INFO - Running pre-action listener: _resource_record_pre_action 04:01:32 INFO - Running main action method: install 04:01:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:33 INFO - Reading from file tmpfile_stdout 04:01:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:33 INFO - Reading from file tmpfile_stdout 04:01:33 INFO - Output received: 04:01:33 INFO - Usage: mozinstall [options] installer 04:01:33 INFO - Options: 04:01:33 INFO - -h, --help show this help message and exit 04:01:33 INFO - -d DEST, --destination=DEST 04:01:33 INFO - Directory to install application into. [default: 04:01:33 INFO - "/builds/slave/test"] 04:01:33 INFO - --app=APP Application being installed. [default: firefox] 04:01:33 INFO - mkdir: /builds/slave/test/build/application 04:01:33 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'] 04:01:33 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 04:01:54 INFO - Reading from file tmpfile_stdout 04:01:54 INFO - Output received: 04:01:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:01:54 INFO - Running post-action listener: _resource_record_post_action 04:01:54 INFO - ##### 04:01:54 INFO - ##### Running run-tests step. 04:01:54 INFO - ##### 04:01:54 INFO - Running pre-action listener: _resource_record_pre_action 04:01:54 INFO - Running main action method: run_tests 04:01:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:01:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:01:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:01:54 INFO - 2016-07-27 04:01:54.888 screenresolution[2230:16785] starting screenresolution argv=screenresolution get 04:01:54 INFO - 2016-07-27 04:01:54.890 screenresolution[2230:16785] Display 0: 1600x1200x32@60 04:01:54 INFO - 2016-07-27 04:01:54.896 screenresolution[2231:16788] starting screenresolution argv=screenresolution list 04:01:54 INFO - Available Modes on Display 0 04:01:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:01:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:01:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:01:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:01:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:01:55 INFO - Intel Iris: 04:01:55 INFO - Chipset Model: Intel Iris 04:01:55 INFO - Type: GPU 04:01:55 INFO - Bus: Built-In 04:01:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:01:55 INFO - Vendor: Intel (0x8086) 04:01:55 INFO - Device ID: 0x0a2e 04:01:55 INFO - Revision ID: 0x0009 04:01:55 INFO - Displays: 04:01:55 INFO - Display: 04:01:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:01:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:01:55 INFO - Display Serial Number: 1600x1200 60 04:01:55 INFO - Main Display: Yes 04:01:55 INFO - Mirror: Off 04:01:55 INFO - Online: Yes 04:01:55 INFO - Rotation: Supported 04:01:55 INFO - Return code: 0 04:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:55 INFO - Python 2.7.3 04:01:55 INFO - Return code: 0 04:01:55 INFO - grabbing minidump binary from tooltool 04:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:55 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 0x10b4c3e00>, '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 0x10b32cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4beb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:55 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 04:01:55 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 04:01:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:55 INFO - Return code: 0 04:01:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:01:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:01:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:01:56 INFO - Return code: 0 04:01:56 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/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 04:01:56 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/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0047 --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 04:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5RhG5Fn39/Render', 04:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:56 INFO - 'HOME': '/Users/cltbld', 04:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:56 INFO - 'LOGNAME': 'cltbld', 04:01:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:56 INFO - 'MOZ_NO_REMOTE': '1', 04:01:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:56 INFO - 'NO_EM_RESTART': '1', 04:01:56 INFO - 'PAGER': '/bin/cat', 04:01:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:56 INFO - 'PWD': '/builds/slave/test', 04:01:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:56 INFO - 'SHELL': '/bin/bash', 04:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJzxKKYY9B/Listeners', 04:01:56 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 04:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:56 INFO - 'USER': 'cltbld', 04:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:56 INFO - 'XPC_FLAGS': '0x0', 04:01:56 INFO - 'XPC_SERVICE_NAME': '0', 04:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:56 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/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 04:01:56 INFO - mozversion application_buildid: 20160726073802 04:01:56 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:01:56 INFO - mozversion application_display_name: Firefox 04:01:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:56 INFO - mozversion application_name: Firefox 04:01:56 INFO - mozversion application_remotingname: firefox 04:01:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:01:56 INFO - mozversion application_vendor: Mozilla 04:01:56 INFO - mozversion application_version: 48.0 04:01:56 INFO - mozversion platform_buildid: 20160726073802 04:01:56 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:01:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:01:56 INFO - mozversion platform_version: 48.0 04:01:56 INFO - using testdate: 1469617316 04:01:56 INFO - actual date: 1469617316 04:01:56 INFO - starting webserver on 'localhost:50455' 04:01:56 INFO - SUITE-START | Running 2 tests 04:01:56 INFO - TEST-START | dromaeo_css 04:01:56 INFO - operating with platform_type : mac_ 04:01:56 INFO - Initialising browser for dromaeo_css test... 04:01:56 INFO - TEST-INFO | started process 2249 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpLArQNT/profile http://localhost:50455/getInfo.html) 04:01:59 INFO - PROCESS | 2249 | __metrics Screen width/height:1600/1200 04:01:59 INFO - PROCESS | 2249 | colorDepth:24 04:01:59 INFO - PROCESS | 2249 | Browser inner width/height: 1024/689 04:01:59 INFO - PROCESS | 2249 | __metrics 04:01:59 ERROR - PROCESS | 2249 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:01:59 INFO - TEST-INFO | 2249: exit 0 04:01:59 INFO - Browser initialized. 04:01:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:59 INFO - TEST-INFO | started process 2253 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpLArQNT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:11 INFO - PROCESS | 2253 | RSS: Main: 170942464 04:02:11 INFO - PROCESS | 2253 | 04:03:01 INFO - PROCESS | 2253 | 1469617381342 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] 04:05:12 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:50455/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50455/tests/dromaeo/cssquery-ext.html) 04:05:13 INFO - PROCESS | 2253 | RSS: Main: 181870592 04:05:13 INFO - PROCESS | 2253 | 04:08:15 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:50455/tests/dromaeo/cssquery-ext.html (next: http://localhost:50455/tests/dromaeo/cssquery-jquery.html) 04:08:16 INFO - PROCESS | 2253 | RSS: Main: 192630784 04:08:16 INFO - PROCESS | 2253 | 04:11:18 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:50455/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50455/tests/dromaeo/cssquery-mootools.html) 04:11:18 INFO - PROCESS | 2253 | RSS: Main: 194568192 04:11:18 INFO - PROCESS | 2253 | 04:14:20 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:50455/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50455/tests/dromaeo/cssquery-prototype.html) 04:14:20 INFO - PROCESS | 2253 | RSS: Main: 198262784 04:14:20 INFO - PROCESS | 2253 | 04:17:23 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:50455/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50455/tests/dromaeo/cssquery-yui.html) 04:17:24 INFO - PROCESS | 2253 | RSS: Main: 197595136 04:17:24 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:50455/tests/dromaeo/cssquery-yui.html (next: http://localhost:50455/tests/dromaeo/cssquery-dojo.html) 04:20:26 INFO - PROCESS | 2253 | RSS: Main: 202399744 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | __start_tp_report 04:20:26 INFO - PROCESS | 2253 | _x_x_mozilla_page_load 04:20:26 INFO - PROCESS | 2253 | _x_x_mozilla_page_load_details 04:20:26 INFO - PROCESS | 2253 | |i|pagename|runs| 04:20:26 INFO - PROCESS | 2253 | |0;dojo.html;3208.598925134358;3609.8917032489026;3660.1215708230015;3675.3568125578017;3718.4608231806387;5977.043673012319;5997.910031349527;6024.668643224626;6036.4868986136125;6085.2393450818645;5943.732532036058;5998.730057147428;6043.214382130328;6046.8488287792825;6056.878862422749;5370.087085195507;5428.267183930178;5532.7786888524615;5578.191162281467;5604.355499117612;5392.245085688007;5397.217403476494;5452.672839629615;5493.450654934514;5519.917201241965;5462.071447853875;5468.453154684539;5480.479354461319;5486.231927530149;5488.368837583669;4908.779104940286;5451.48210919962;5466.289382380265;5522;5559.082751346023;4397.428334316551;5269.104252277122;5388.380336261302;5394.217838413408;5427.4301198374;5232.502912223333;5700.543956483471;5700.971495142539;5931.377205393414;5937.465628093449;6252.06219067139;6320.051992201161;6332.33510481402;6349.238091429012;6357.682115894233;6387.616742995388;6402.647854368008;6430.61416315018;6453.257875344301;6464.515161362917;6027.427394397525;6048.395160483917;6133.815985520441;6140.416660417298;6146.354632763585;6522.119513865568;6567.934320656828;6610.239822420387;6613.933860661332;6618.437432818168;6251.374862513803;6293.811185664345;6295.779647712308;6298.71655775482;6300.086487459384;6228.688565571703;6276.340984196594;6327.810165695037;6362.268339141058;6396.392342727433;6265.0602409638;6268.780592679234;6313.2424109107205;6317.557770956081;6328.746850125944;5455.099908515051;6293.496520278458;6294.685265736694;6298.779542715983;6336.6831658416895;4301.333293339538;5034.521720436553;5069.417017043013;5118.74406279692;5179.22311653255;4513.909721805546;4538.500764915857;4555.316702494652;4557.134144512598;4566.995261042565;5341.305630268118;6041.848953776191;6170.10533472644;6171;6191.102290167991;6235.189425374672;6283.37166283368;6318.462930650854;6386.265579458422;6408.423241908251;6069.605475644157;6095.939040609537;6102.908456373158;6103.23709536308;6105.664188469588;4763.642726795504;4836.854894353175;5480.671159730429;5621.269234999424;5639.520640745501;6495.610263384212;6564.737410503717;6607.4383677386995;6658.6337751424135;6723.722492726366;6361.491080713625;6397.488200944006;6401.455876250571;6402.071699603438;6468.288488266193;6656.966715166393;6726.293739157513;6730.8653826924165;6743.494237932076;6748.73005079811;6196.969015154896;6278.497720182283;6317.431431171217;6357.96821015892;6366.236051673829;6404.551681382445;6411.326810684811;6417.326180751141;6429.32492088324;6451.225852897683;5694.800681976111;6265.404786545271;6277.403646653561;6277.497800176066;6291.465225455888;5495.972520137374;6172.722227499863;6192.721327540181;6249.906251406142;6256.092866534418;6150.384961503813;6196;6208.255009398901;6244.750209991549;6270.717817698123;6153.769246150878;6254.061890716429;6265.185525881606;6269.49844012487;6279.780207692892;6122.062734707273;6135.04893764628;6198.721057552511;6231.719572619152;6249.1563638908165 04:20:26 INFO - PROCESS | 2253 | |1;ext.html;518.7561845932411;542.4548328929427;557.4648337595913;559.4377650461286;561.9297587801524;30768.692313076863;39255.80372098139;39283.803580982094;39308.60691393085;39333.21333573327;40618.59381406185;41397;41432.378514322234;41468.58531414685;41477.79261103698;9547.23622110233;9710.36882602632;9766.658166964158;9771.804563908718;9792.265580081486;9655.08276713711;9848.113669769718;9922.603095876193;9922.702318930444;9940.850887236697;8707.782305442382;9735.318527703064;9829.262805289596;9899.257555683316;9912.504374781269;9818.067283608047;9843.557039933148;9893.30746847721;9916.157126644244;9933.205343572497;9240.168384845396;9386.389884657476;9794.706158815246;9827.950860245724;9907.306488545804;39118.217635647416;39225.60774392277;39250.80374598109;39660;39829.80085099556;3226.677332266778;3308.8345582720767;3374.240795820945;3416.4021296273054;3418.29924865402;27839.86080069607;28376.574351384745;29456.55815162774;29823;30052.54921176184;2791.3440341519727;2794.357297821492;2814.212020634205;2835.9291017724518;2854.471922694308;447861;455499;458700;459003;459094;53028.46971530312;60290.69854650786;60788.39211607916;60844.087338689955;61007.38992610017;69046;70754;70808.64595676989;70825;70931.64534177296;13615.795763063563;17784.822151778575;17819.46541603754;17833.643327133384;17958.371456998942;11534.711632209262;13538.390772415265;13555.322233888266;13585.116967397087;13651.658708532168;19941.700874486894;20203.898980505004;20259.493512662302;20288.188472461232;20619.175232990812;7382.630868456556;7997.360211183091;8332.833343333099;8396.328293736486;8410;859.2524503681836;1034.4000479721744;1058.51837413978;1072.790805792863;1085.2511766880828;26648.733512665014;30713;30744.69255307463;31037.534436983013;31294.904678336603;1039.4231201683137;1112.3492756737237;1243.5461056714234;1272.497363541396;1318.8021796730568;14208.502702405367;14958.099930541528;14979.664260935391;15069.698606027818;15134.243287835565;591237;599486;601091;606046;606848;59537.106943395884;60393.69803151044;61631.07553386703;61720.38279617146;61743.691281544205;1301.2517802263735;1512.0625212368402;1515.6438237014293;1518.3622878391102;1525.2068924159375;25172.622410664222;29247.85376073106;29608.555871661512;29975.400491990473;30121.548176777804;51458.48541514537;51587.48412515977;52059;52203.95592088213;52296;558812;561073;562548;566566;570871;23202.1879234226;26667.333316666463;27511.724882751718;28129.015484457945;28300.15099547017;37859;39172.80413597914;39214.80392598133;39477.802610987914;39531.40702889516;35447.64552354444;35550.28899421945;36302.273954520235;36501.63498365089;36997.26005479929;37801.62198378091;37927.43108853314;37939.292731827685;38219;38546.421803672405;33033.50449743304;37986.43020354752;38210.426843597925;38243.42634860424;38934.415983759696;30736.846315768278;31538;31589.36821263608;31689.20776980594;31771;24699.50600988006;25047.622380768502;25421.61867571951;25555.105571304914;25722.842472088425 04:20:26 INFO - PROCESS | 2253 | |2;jquery.html;333.71133969116704;421.66266986410875;424.74939785526533;427.23098422838893;434.2552522424044;20561.280355187573;21287.574248515022;21313.786862131376;21500;22953.77046229537;17864.732029019575;21278.936053197318;21578.460538486546;21704.782952170473;21731.565368692616;5852.239208902858;5876.853078673035;6136;6160.2915664698685;6163;6032.66820324882;6124.356942521038;6139.662318572477;6141.263048434194;6159.014557670774;5764.51001664859;6002.8499287517725;6100.755969761204;6121.387861213865;6121.540884433685;5817.941820581782;6009.369016253296;6042.123892035652;6208.00671892495;6214.689265536705;6029.758809647609;6045.879082418327;6049.274087109531;6089.147519347295;6116.785912493041;13682.863171368259;17269.913650431794;25799.065070119817;26436.810343534587;26904.59643105355;2034.8982550872545;2273.090763694519;2288.39357570244;2328.2782337475437;2343.3438637181616;9895.65365212214;10188.083072523508;10374.221933354953;13422.93288533561;14626.341814618369;1740.5909611241348;1755.4821327708357;1807.9548011299692;1841.9539511512185;1883.896385698786;108841;110235;110793;111374.44312778384;111989;12119.818202726967;12197.414336136246;12257.203281786655;12269.57056503018;12284.201526900722;15450.304736286895;15674.216289185495;15804.36782528709;15872.047677139408;15879.682406351809;7591.8861217081785;8766.123387661182;9173.724788256362;9222;9261.49061801594;9128;9139;9175.08249175077;9237.307201959746;9245.537723113817;4069.4709687740406;4258.318669012943;4796.832110876103;4875.853724388274;4900.166971614834;1566.772817941392;1748.7114626086807;1882.792892781793;2012.3560460652743;2141.603803296395;909.4270609515962;991.7966816802539;1005.3666190300211;1038.4132964874973;1137.5279259107378;19705.01474926248;19968.70046949297;20936.37190884276;20959.580808383747;21570.460738481663;906.7234493479552;999.7752752877811;1006.3810756384917;1046.398320965448;1095.315427857589;8909.242714369351;11683.415829208505;11722.120840936965;11744.29534227949;11768.058555315554;565592;568349;572108;690088;702737;129011;133636;135518.6448135506;137229.94155087683;140432;987.9456629885282;1023.559869256227;1027.6762819711766;1032.9535170917327;1047.1204188481863;19196.808031919503;19279.325223617107;19599.31402400966;19792.289003066897;19796.81219126857;55486;57998;58028.70985645045;58243.4175658238;59200.407995919486;68384;81876;85947;86228.56885715532;86470.56764716136;8181.590920454072;8399.874001890099;8414.537200454033;8544.316454683734;8770.122987701434;9400.34197606161;10683.89316106829;11570.247933884608;13323.467061317438;13622.795658064939;10999.065079468335;11178.049865761175;11604;11637.069034477052;11833.053355731348;11301.71745706364;11404.600838970597;11454.083673306282;11599.536018559163;11801.763964720829;11705.824412633987;11751.412429378326;11804.527818887493;11852.288862668267;12106.576269830513;8648.264897483532;8797.120287971407;8841.248493878093;8852.468851868909;8914.643414263617;7751.728689495841;10932.836007460053;11503.884961150281;11722.472488737856;11884.524619015143 04:20:26 INFO - PROCESS | 2253 | |3;mootools.html;1646.0699704666865;1668.82347944699;1964.931227407041;2013.8288245499132;2116.4285642876434;8268.669253229878;8976.506292153928;9042.095790420963;9275.953620231889;9294.442333459998;8958.820823583525;9021.864672029924;9093.454392736441;9104.544772761368;9125.771855703611;2529.3550144713117;2532.202356257782;2539.657146285246;2549.9490010199784;2551.7703406693395;2489.0666000249907;2555.3739333863227;2556.782673472757;2559.424129570841;2563.269468201563;2521.798256139514;2547.5414425403515;2557.360659835041;2572.794176465878;2585.418280886804;2548.388386787167;2554;2561.6541766861424;2593.1831473085917;2593.7795287400404;2444.2545023767743;2445.7187423446353;2464.7412021737637;2543.2370288913253;2597.545429549821;9136.771580710469;9221.861672074925;9252.583633736498;9276.953615231881;9282.071792820663;5629.57778166635;5760.6255593386295;5805.970970145122;5826.184334193216;5828.271466066742;3523.119220194951;3559.555055618048;3594.802285874276;3750.043738846604;3796.1268908151005;1065.8880817514205;1085.426132108446;1097.1661537231762;1098.4068602954394;1100.3287994323457;12619.810702839464;12641.367931603383;12659.303738294482;12668.303243321614;12689.175203611829;5010.69935803853;5016.247562865527;5089.694618322913;5108.872278193075;5168.7415629218385;9082.954585227164;9298.628054877865;10337.328073675337;10395.58417663285;10587.523561439753;5495.340559132929;5555.055640541118;5668.546516278688;5668.943310566924;5748.367679555246;4506.954930450719;4593.104344652761;4837.37114175155;5149;5150.562202212854;4206.8737937861915;4222.218889505451;4248.87253382399;4313;4321;1401.4884567133126;1426.0588011912089;1427.8072460217945;1432.8495507971513;1432.9140251584938;907.8275127725843;950.5817440326234;951.219999600335;978.4031740638205;984.0848011349514;5890.175375447355;5933;6098.573099882966;6098.939010609926;6114.755409783648;996.4320337407609;1011.9241056920761;1017.1405162637559;1052.8631277933973;1058.222206678091;4008.2183974124764;4018.7387819792207;4048.0487085534874;4081;4091.8977025574004;10909.072728818139;11220.102391808636;11340.659780206606;11359.261647992855;11510.136739744552;11085.057770089472;11105.500252488657;11230.438478076063;11304.26522276066;11317.207795454238;8404.36967227448;8616.913830861737;8720.651173953098;8761.080086590944;8768.386212965032;6036.366181550874;6097.390260973867;6274.027525733519;6275.435210831047;6276.497880169667;9966.950165249418;10055.748606284902;10075.395476271447;10236.078752912274;10287.588496460057;9743.75640608962;10269.897301027193;10424.791504169722;10440.37357758537;10516.947415262875;7017.403520700594;7611.162772094955;7678.5392876427595;7808;7915.168907264654;8468.44955077918;8597.226249637562;8612.440191387539;8645.308375330083;8668.91331086681;7505.061867266591;7653.846923061619;7718.112417072109;7721.5753133575945;7743.032120984877;7472.476926615085;7519.924800751923;7554.848903022019;7635.923640763522;7661.310482056641;7237.203907570269;7323.523970941872;7377.926220737939;7403.370713489414;7403.5928023959195;4970.155073637418;4980.800767969241;5093.159628661229;5151.5106064923775;5176.767045482887;5005.524475174852;5116.616253780907;5142.76857541419;5169.4830516948;5310.468953104659 04:20:26 INFO - PROCESS | 2253 | |4;prototype.html;287.86470358931297;316.42094966211835;319.8704524667509;340.69507790527473;344.30278685661534;6824.283450237728;6857.708300015989;6861.108055952725;6881.931180688185;6886.586804791704;6630.535862489615;6805.965970170155;6830.282820303871;6836.794896153111;6870.965645171779;4848.951510484894;4908.141075311824;5055.266986286986;5056.064628043805;5083.212102124176;4355.520892701816;5077.923831142536;5098.796048158069;5107.106256405133;5136.409312929024;5047.47001564836;5066.088104141271;5074.594032477393;5084.288199652033;5086;5077.3907131144315;5082.974585127087;5101.872453188663;5109;5114.616403769695;3571.3750093733493;4357.193919124972;4363.454568178978;4371.759553224571;4401.207782599131;5112.565431938289;6353;6557.836054098638;6596.076549283104;6658.201015878077;5926.199963004982;5957.1362152487645;5983.910241346383;5996.970015149896;5997.610155339889;7335.119785625706;7337.926620733778;7344.779656610311;7348.448866335047;7361.668724907392;4873.34209881665;4880.2435622478215;4881.609471242292;4885.218365061573;4886.53577910098;6310.368963103699;7203.38771204443;7792.493487923267;7822.843543129163;7852.450328477009;4934.901301974012;4938.209886418156;4939.407271127416;4950.480199579064;4973.925391119136;4952.455229924705;5027.597792176617;5032.974835125801;5044.974775126101;5061.392632884077;5891;5943.940560594425;5979.671118088547;5983.790567330123;5988.820335389945;7348.448866335047;7365.852682946311;7373.188949215582;7373.262673732584;7401.259874012556;1558.6517662222095;1641.588234118657;1722.6726921885052;1744.5813004878737;1749.3439960014994;1023.6468418395641;1061.601899287767;1076.9946150269197;1077.2620754782843;1077.9730506737237;6919.37725604688;6921.723131074801;6989.126359205099;7036.155661320572;7048.365647091787;7353.867378460187;7579.2420757924865;7595.202503737028;7606.771796846104;7637.625227459111;6094.39056094387;6968.616726080013;7048.330408611174;7071.186813516511;7163.928360716431;4017.055991841915;4054.878353649395;4059.6346328830546;4076;4082.3672330788777;6487.610743355413;8056.677732890619;8105.594720263964;8117.391195660349;8139.308158806568;6391.808245752635;7606.885896711554;7904.1700621435075;7956.681732730626;7963.721269755647;6588.110605068446;8047.51714897108;8082.313003394777;8091.109977902426;8199.549024803573;6248.312685604489;7692.461527693008;7713.2286771322415;7744.49660772048;7748.92251077482;6389.233292004989;6826.897596535957;7512.361449276654;7562.962185189039;7564.50830696003;7702.575023620648;7907.169747176464;8044;8054.637541310538;8179.100298967228;3752.4371344297483;4728.432588089451;4769.284607308931;4805.591524720298;4807.038592281628;6040.09398590215;7568.508046977149;7714.884276735741;7749;7755.457118001911;5993.70031498432;6493.448056915215;7148.499605027599;7454.291842274975;7528.247175282428;7232.168300645493;7274.16347120088;7465.328120469184;7473.327400533978;7474.215207403145;7180.533265337736;7196.676149573177;7225.963870180615;7238.819029524304;7277.38142257914;7391.0761154855645;7418.109826820816;7434.219406962191;7449.366803821736;7464.290892365217;5911.615744976562;7250.891236631349;7276.490645654753;7283.854322913406;7294.452916031425 04:20:26 INFO - PROCESS | 2253 | |5;yui.html;751.413897160215;777.4557809533325;779.1273773373819;793.6864938349356;808.0626473290981;15216.771748423782;15544.222788860554;15555;15571.610709732235;15618.999999999985;14363.856361436408;14428.422863085463;14449.494267700633;14537.982341236091;14550.563483095497;778.2101167315179;953.4422362917684;961.5672947173765;982.8476586129161;987.7481242283208;935.957881895313;962.9277804164681;964.8070385922808;971.8056388722284;973.6446197138065;1009.1271050541302;1019.1999280564759;1026.845973104033;1026.9589216431334;1028.254515476281;972.2513664478312;998.5805961496189;1013.6350913671035;1013.7516308504427;1013.8276492996208;758.9354904833095;762.2872614105773;770.537677393565;771.7221800151941;772.7758949904521;15063.322150503254;15066.849331506653;15079.623009424742;15335.693286134216;15417.691646167126;13034.478620855154;13088.934555327258;13117.60647180586;13170.670733231746;13280.269585172811;10146.796023714334;10339.844902326471;10456;10674.839877401846;10830.566777328897;3572.089117275078;3594.5398642392865;3618.2944325856206;3691.077230692327;3853.0560012796764;57809;75737.62131189309;75787.86318205232;75819.24180758232;79924.80112798371;9709.223262139012;9822.214222862154;9845.55694993727;10024.79950400988;10427.68716938493;22790;22878.31365059051;22917.885410573173;22955.96698148587;23446.413839653804;7672.73145439907;7684.692612295557;7696.037995250594;7709.4603377763015;7883.408744344197;4216.072464057902;4222.852200172979;4241.1941731071;4264.701470897069;4355.08543205924;3761.605031471711;3774.1885494618787;3820.1977584706965;3844.2695887781233;3847.5575308839843;705.7071315404153;732.6117157906318;735.6468894930464;737.8598066367373;743.3755645258009;558.8463172627479;563.1355868741463;564.350996354196;591.6006695480534;597.9880402391927;8006.428300493163;8065.879011814827;8081.555514446644;8142.796430089295;8438.662453501915;498.8303976647957;506.4530307268142;515.2811827500616;576.6540075954478;584.8537865533617;3544.2379888324135;3551.0057183988524;3847.153626202231;3871.9806400967814;4012.398140278923;82982.3403531926;85191.72212416818;91262;91356.17287654342;92752.07247927434;64009.71980560363;65795;72831.90752138723;75899.86150207752;77218.22781772223;65780;66573.667131665;68755.31244687589;69746.65126674334;69759;7572.734954276574;7636.08366995964;7754.224577542201;7887.487313324845;8001.399895008014;39447;49856;50855.74572127264;51172.74413627908;51305.23042154445;67358;71491.92762108677;72108.63945680238;73166;73973;11128.1653875958;11152.776944461228;11227.943860280646;11358.26171298863;11559.595414160463;10362;11783.234089784137;11824.40877956116;12156.878431215575;12479.438425271066;11126.388048657402;11162.386068766296;11355.261907975955;11546.48040838181;11587.942060289644;11006.779864402828;11119.555217791521;11203.831942520706;11360.715982100513;11614;10721.088707459641;10867.29362591429;11004.669859904216;11121.555137794398;11171.72070698239;9597.520123993912;9610.231181505324;9660.95169524148;9695.1146798108;9996.550155242887;9538.427694338361;9757.56090975922;9765.85351219718;9789.510524473606;9826.361286516354 04:20:26 INFO - PROCESS | 2253 | __end_tp_report 04:20:26 INFO - PROCESS | 2253 | __start_cc_report 04:20:26 INFO - PROCESS | 2253 | _x_x_mozilla_cycle_collect,396 04:20:26 INFO - PROCESS | 2253 | __end_cc_report 04:20:26 INFO - PROCESS | 2253 | __startTimestamp1469618426459__endTimestamp 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | ------- Summary: start ------- 04:20:26 INFO - PROCESS | 2253 | Number of tests: 6 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | [#0] dojo.html Cycles:165 Average:5917.76 Median:6191.10 stddev:674.66 (10.9%) stddev-sans-first:642.38 04:20:26 INFO - PROCESS | 2253 | Values: 3208.6 3609.9 3660.1 3675.4 3718.5 5977.0 5997.9 6024.7 6036.5 6085.2 5943.7 5998.7 6043.2 6046.8 6056.9 5370.1 5428.3 5532.8 5578.2 5604.4 5392.2 5397.2 5452.7 5493.5 5519.9 5462.1 5468.5 5480.5 5486.2 5488.4 4908.8 5451.5 5466.3 5522.0 5559.1 4397.4 5269.1 5388.4 5394.2 5427.4 5232.5 5700.5 5701.0 5931.4 5937.5 6252.1 6320.1 6332.3 6349.2 6357.7 6387.6 6402.6 6430.6 6453.3 6464.5 6027.4 6048.4 6133.8 6140.4 6146.4 6522.1 6567.9 6610.2 6613.9 6618.4 6251.4 6293.8 6295.8 6298.7 6300.1 6228.7 6276.3 6327.8 6362.3 6396.4 6265.1 6268.8 6313.2 6317.6 6328.7 5455.1 6293.5 6294.7 6298.8 6336.7 4301.3 5034.5 5069.4 5118.7 5179.2 4513.9 4538.5 4555.3 4557.1 4567.0 5341.3 6041.8 6170.1 6171.0 6191.1 6235.2 6283.4 6318.5 6386.3 6408.4 6069.6 6095.9 6102.9 6103.2 6105.7 4763.6 4836.9 5480.7 5621.3 5639.5 6495.6 6564.7 6607.4 6658.6 6723.7 6361.5 6397.5 6401.5 6402.1 6468.3 6657.0 6726.3 6730.9 6743.5 6748.7 6197.0 6278.5 6317.4 6358.0 6366.2 6404.6 6411.3 6417.3 6429.3 6451.2 5694.8 6265.4 6277.4 6277.5 6291.5 5496.0 6172.7 6192.7 6249.9 6256.1 6150.4 6196.0 6208.3 6244.8 6270.7 6153.8 6254.1 6265.2 6269.5 6279.8 6122.1 6135.0 6198.7 6231.7 6249.2 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | [#1] ext.html Cycles:180 Average:67679.65 Median:39026.32 stddev:145144.27 (371.9%) stddev-sans-first:145463.84 04:20:26 INFO - PROCESS | 2253 | Values: 518.8 542.5 557.5 559.4 561.9 30768.7 39255.8 39283.8 39308.6 39333.2 40618.6 41397.0 41432.4 41468.6 41477.8 9547.2 9710.4 9766.7 9771.8 9792.3 9655.1 9848.1 9922.6 9922.7 9940.9 8707.8 9735.3 9829.3 9899.3 9912.5 9818.1 9843.6 9893.3 9916.2 9933.2 9240.2 9386.4 9794.7 9828.0 9907.3 39118.2 39225.6 39250.8 39660.0 39829.8 3226.7 3308.8 3374.2 3416.4 3418.3 27839.9 28376.6 29456.6 29823.0 30052.5 2791.3 2794.4 2814.2 2835.9 2854.5 447861.0 455499.0 458700.0 459003.0 459094.0 53028.5 60290.7 60788.4 60844.1 61007.4 69046.0 70754.0 70808.6 70825.0 70931.6 13615.8 17784.8 17819.5 17833.6 17958.4 11534.7 13538.4 13555.3 13585.1 13651.7 19941.7 20203.9 20259.5 20288.2 20619.2 7382.6 7997.4 8332.8 8396.3 8410.0 859.3 1034.4 1058.5 1072.8 1085.3 26648.7 30713.0 30744.7 31037.5 31294.9 1039.4 1112.3 1243.5 1272.5 1318.8 14208.5 14958.1 14979.7 15069.7 15134.2 591237.0 599486.0 601091.0 606046.0 606848.0 59537.1 60393.7 61631.1 61720.4 61743.7 1301.3 1512.1 1515.6 1518.4 1525.2 25172.6 29247.9 29608.6 29975.4 30121.5 51458.5 51587.5 52059.0 52204.0 52296.0 558812.0 561073.0 562548.0 566566.0 570871.0 23202.2 26667.3 27511.7 28129.0 28300.2 37859.0 39172.8 39214.8 39477.8 39531.4 35447.6 35550.3 36302.3 36501.6 36997.3 37801.6 37927.4 37939.3 38219.0 38546.4 33033.5 37986.4 38210.4 38243.4 38934.4 30736.8 31538.0 31589.4 31689.2 31771.0 24699.5 25047.6 25421.6 25555.1 25722.8 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | [#2] jquery.html Cycles:180 Average:36037.31 Median:21641.62 stddev:103835.51 (479.8%) stddev-sans-first:104092.19 04:20:26 INFO - PROCESS | 2253 | Values: 333.7 421.7 424.7 427.2 434.3 20561.3 21287.6 21313.8 21500.0 22953.8 17864.7 21278.9 21578.5 21704.8 21731.6 5852.2 5876.9 6136.0 6160.3 6163.0 6032.7 6124.4 6139.7 6141.3 6159.0 5764.5 6002.8 6100.8 6121.4 6121.5 5817.9 6009.4 6042.1 6208.0 6214.7 6029.8 6045.9 6049.3 6089.1 6116.8 13682.9 17269.9 25799.1 26436.8 26904.6 2034.9 2273.1 2288.4 2328.3 2343.3 9895.7 10188.1 10374.2 13422.9 14626.3 1740.6 1755.5 1808.0 1842.0 1883.9 108841.0 110235.0 110793.0 111374.4 111989.0 12119.8 12197.4 12257.2 12269.6 12284.2 15450.3 15674.2 15804.4 15872.0 15879.7 7591.9 8766.1 9173.7 9222.0 9261.5 9128.0 9139.0 9175.1 9237.3 9245.5 4069.5 4258.3 4796.8 4875.9 4900.2 1566.8 1748.7 1882.8 2012.4 2141.6 909.4 991.8 1005.4 1038.4 1137.5 19705.0 19968.7 20936.4 20959.6 21570.5 906.7 999.8 1006.4 1046.4 1095.3 8909.2 11683.4 11722.1 11744.3 11768.1 565592.0 568349.0 572108.0 690088.0 702737.0 129011.0 133636.0 135518.6 137229.9 140432.0 987.9 1023.6 1027.7 1033.0 1047.1 19196.8 19279.3 19599.3 19792.3 19796.8 55486.0 57998.0 58028.7 58243.4 59200.4 68384.0 81876.0 85947.0 86228.6 86470.6 8181.6 8399.9 8414.5 8544.3 8770.1 9400.3 10683.9 11570.2 13323.5 13622.8 10999.1 11178.0 11604.0 11637.1 11833.1 11301.7 11404.6 11454.1 11599.5 11801.8 11705.8 11751.4 11804.5 11852.3 12106.6 8648.3 8797.1 8841.2 8852.5 8914.6 7751.7 10932.8 11503.9 11722.5 11884.5 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | [#3] mootools.html Cycles:180 Average:5972.20 Median:5008.11 stddev:3306.61 (66.0%) stddev-sans-first:3299.90 04:20:26 INFO - PROCESS | 2253 | Values: 1646.1 1668.8 1964.9 2013.8 2116.4 8268.7 8976.5 9042.1 9276.0 9294.4 8958.8 9021.9 9093.5 9104.5 9125.8 2529.4 2532.2 2539.7 2549.9 2551.8 2489.1 2555.4 2556.8 2559.4 2563.3 2521.8 2547.5 2557.4 2572.8 2585.4 2548.4 2554.0 2561.7 2593.2 2593.8 2444.3 2445.7 2464.7 2543.2 2597.5 9136.8 9221.9 9252.6 9277.0 9282.1 5629.6 5760.6 5806.0 5826.2 5828.3 3523.1 3559.6 3594.8 3750.0 3796.1 1065.9 1085.4 1097.2 1098.4 1100.3 12619.8 12641.4 12659.3 12668.3 12689.2 5010.7 5016.2 5089.7 5108.9 5168.7 9083.0 9298.6 10337.3 10395.6 10587.5 5495.3 5555.1 5668.5 5668.9 5748.4 4507.0 4593.1 4837.4 5149.0 5150.6 4206.9 4222.2 4248.9 4313.0 4321.0 1401.5 1426.1 1427.8 1432.8 1432.9 907.8 950.6 951.2 978.4 984.1 5890.2 5933.0 6098.6 6098.9 6114.8 996.4 1011.9 1017.1 1052.9 1058.2 4008.2 4018.7 4048.0 4081.0 4091.9 10909.1 11220.1 11340.7 11359.3 11510.1 11085.1 11105.5 11230.4 11304.3 11317.2 8404.4 8616.9 8720.7 8761.1 8768.4 6036.4 6097.4 6274.0 6275.4 6276.5 9967.0 10055.7 10075.4 10236.1 10287.6 9743.8 10269.9 10424.8 10440.4 10516.9 7017.4 7611.2 7678.5 7808.0 7915.2 8468.4 8597.2 8612.4 8645.3 8668.9 7505.1 7653.8 7718.1 7721.6 7743.0 7472.5 7519.9 7554.8 7635.9 7661.3 7237.2 7323.5 7377.9 7403.4 7403.6 4970.2 4980.8 5093.2 5151.5 5176.8 5005.5 5116.6 5142.8 5169.5 5310.5 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | [#4] prototype.html Cycles:180 Average:5980.57 Median:6644.37 stddev:1920.54 (28.9%) stddev-sans-first:1877.80 04:20:26 INFO - PROCESS | 2253 | Values: 287.9 316.4 319.9 340.7 344.3 6824.3 6857.7 6861.1 6881.9 6886.6 6630.5 6806.0 6830.3 6836.8 6871.0 4849.0 4908.1 5055.3 5056.1 5083.2 4355.5 5077.9 5098.8 5107.1 5136.4 5047.5 5066.1 5074.6 5084.3 5086.0 5077.4 5083.0 5101.9 5109.0 5114.6 3571.4 4357.2 4363.5 4371.8 4401.2 5112.6 6353.0 6557.8 6596.1 6658.2 5926.2 5957.1 5983.9 5997.0 5997.6 7335.1 7337.9 7344.8 7348.4 7361.7 4873.3 4880.2 4881.6 4885.2 4886.5 6310.4 7203.4 7792.5 7822.8 7852.5 4934.9 4938.2 4939.4 4950.5 4973.9 4952.5 5027.6 5033.0 5045.0 5061.4 5891.0 5943.9 5979.7 5983.8 5988.8 7348.4 7365.9 7373.2 7373.3 7401.3 1558.7 1641.6 1722.7 1744.6 1749.3 1023.6 1061.6 1077.0 1077.3 1078.0 6919.4 6921.7 6989.1 7036.2 7048.4 7353.9 7579.2 7595.2 7606.8 7637.6 6094.4 6968.6 7048.3 7071.2 7163.9 4017.1 4054.9 4059.6 4076.0 4082.4 6487.6 8056.7 8105.6 8117.4 8139.3 6391.8 7606.9 7904.2 7956.7 7963.7 6588.1 8047.5 8082.3 8091.1 8199.5 6248.3 7692.5 7713.2 7744.5 7748.9 6389.2 6826.9 7512.4 7563.0 7564.5 7702.6 7907.2 8044.0 8054.6 8179.1 3752.4 4728.4 4769.3 4805.6 4807.0 6040.1 7568.5 7714.9 7749.0 7755.5 5993.7 6493.4 7148.5 7454.3 7528.2 7232.2 7274.2 7465.3 7473.3 7474.2 7180.5 7196.7 7226.0 7238.8 7277.4 7391.1 7418.1 7434.2 7449.4 7464.3 5911.6 7250.9 7276.5 7283.9 7294.5 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - PROCESS | 2253 | [#5] yui.html Cycles:180 Average:17927.87 Median:51238.99 stddev:24577.59 (48.0%) stddev-sans-first:24612.70 04:20:26 INFO - PROCESS | 2253 | Values: 751.4 777.5 779.1 793.7 808.1 15216.8 15544.2 15555.0 15571.6 15619.0 14363.9 14428.4 14449.5 14538.0 14550.6 778.2 953.4 961.6 982.8 987.7 936.0 962.9 964.8 971.8 973.6 1009.1 1019.2 1026.8 1027.0 1028.3 972.3 998.6 1013.6 1013.8 1013.8 758.9 762.3 770.5 771.7 772.8 15063.3 15066.8 15079.6 15335.7 15417.7 13034.5 13088.9 13117.6 13170.7 13280.3 10146.8 10339.8 10456.0 10674.8 10830.6 3572.1 3594.5 3618.3 3691.1 3853.1 57809.0 75737.6 75787.9 75819.2 79924.8 9709.2 9822.2 9845.6 10024.8 10427.7 22790.0 22878.3 22917.9 22956.0 23446.4 7672.7 7684.7 7696.0 7709.5 7883.4 4216.1 4222.9 4241.2 4264.7 4355.1 3761.6 3774.2 3820.2 3844.3 3847.6 705.7 732.6 735.6 737.9 743.4 558.8 563.1 564.4 591.6 598.0 8006.4 8065.9 8081.6 8142.8 8438.7 498.8 506.5 515.3 576.7 584.9 3544.2 3551.0 3847.2 3872.0 4012.4 82982.3 85191.7 91262.0 91356.2 92752.1 64009.7 65795.0 72831.9 75899.9 77218.2 65780.0 66573.7 68755.3 69746.7 69759.0 7572.7 7636.1 7754.2 7887.5 8001.4 39447.0 49856.0 50855.7 51172.7 51305.2 67358.0 71491.9 72108.6 73166.0 73973.0 11128.2 11152.8 11227.9 11358.3 11559.6 10362.0 11783.2 11824.4 12156.9 12479.4 11126.4 11162.4 11355.3 11546.5 11587.9 11006.8 11119.6 11203.8 11360.7 11614.0 10721.1 10867.3 11004.7 11121.6 11171.7 9597.5 9610.2 9661.0 9695.1 9996.6 9538.4 9757.6 9765.9 9789.5 9826.4 04:20:26 INFO - PROCESS | 2253 | -------- Summary: end -------- 04:20:26 INFO - PROCESS | 2253 | 04:20:26 INFO - TEST-INFO | 2253: exit 0 04:20:26 INFO - TEST-OK | dromaeo_css | took 1110454ms 04:20:26 INFO - TEST-START | kraken 04:20:26 INFO - operating with platform_type : mac_ 04:20:26 INFO - Initialising browser for kraken test... 04:20:26 INFO - TEST-INFO | started process 2258 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpQfHBUT/profile http://localhost:50455/getInfo.html) 04:20:29 INFO - PROCESS | 2258 | __metrics Screen width/height:1600/1200 04:20:29 INFO - PROCESS | 2258 | colorDepth:24 04:20:29 INFO - PROCESS | 2258 | Browser inner width/height: 1024/689 04:20:29 INFO - PROCESS | 2258 | __metrics 04:20:29 ERROR - PROCESS | 2258 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:20:30 INFO - TEST-INFO | 2258: exit 0 04:20:30 INFO - Browser initialized. 04:20:30 INFO - Running cycle 1/1 for kraken test... 04:20:30 INFO - TEST-INFO | started process 2262 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpQfHBUT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:42 INFO - PROCESS | 2262 | RSS: Main: 171012096 04:20:42 INFO - PROCESS | 2262 | 04:20:44 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50455/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:45 INFO - PROCESS | 2262 | RSS: Main: 183595008 04:20:45 INFO - PROCESS | 2262 | 04:20:48 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50455/tests/kraken/driver.html?testName=audio-dft) 04:20:49 INFO - PROCESS | 2262 | RSS: Main: 192188416 04:20:49 INFO - PROCESS | 2262 | 04:20:52 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50455/tests/kraken/driver.html?testName=audio-fft) 04:20:53 INFO - PROCESS | 2262 | RSS: Main: 195870720 04:20:53 INFO - PROCESS | 2262 | 04:20:55 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50455/tests/kraken/driver.html?testName=audio-oscillator) 04:20:55 INFO - PROCESS | 2262 | RSS: Main: 196190208 04:20:55 INFO - PROCESS | 2262 | 04:20:57 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50455/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:58 INFO - PROCESS | 2262 | RSS: Main: 196411392 04:20:58 INFO - PROCESS | 2262 | 04:21:01 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50455/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:01 INFO - PROCESS | 2262 | RSS: Main: 198447104 04:21:01 INFO - PROCESS | 2262 | 04:21:04 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50455/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:05 INFO - PROCESS | 2262 | RSS: Main: 198500352 04:21:05 INFO - PROCESS | 2262 | 04:21:07 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50455/tests/kraken/driver.html?testName=json-parse-financial) 04:21:08 INFO - PROCESS | 2262 | RSS: Main: 198500352 04:21:08 INFO - PROCESS | 2262 | 04:21:10 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50455/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:10 INFO - PROCESS | 2262 | RSS: Main: 198389760 04:21:10 INFO - PROCESS | 2262 | 04:21:12 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:13 INFO - PROCESS | 2262 | RSS: Main: 197718016 04:21:13 INFO - PROCESS | 2262 | 04:21:15 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:16 INFO - PROCESS | 2262 | RSS: Main: 198008832 04:21:16 INFO - PROCESS | 2262 | 04:21:18 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:19 INFO - PROCESS | 2262 | RSS: Main: 198086656 04:21:19 INFO - PROCESS | 2262 | 04:21:22 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:22 INFO - PROCESS | 2262 | RSS: Main: 198008832 04:21:22 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:50455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50455/tests/kraken/driver.html?testName=ai-astar) 04:21:24 INFO - PROCESS | 2262 | RSS: Main: 200142848 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | __start_tp_report 04:21:24 INFO - PROCESS | 2262 | _x_x_mozilla_page_load 04:21:24 INFO - PROCESS | 2262 | _x_x_mozilla_page_load_details 04:21:24 INFO - PROCESS | 2262 | |i|pagename|runs| 04:21:24 INFO - PROCESS | 2262 | |0;ai-astar;118;121;167;125;118;132;116;113;131;168 04:21:24 INFO - PROCESS | 2262 | |1;audio-beat-detection;158;124;143;176;177;134;124;172;197;124 04:21:24 INFO - PROCESS | 2262 | |2;audio-dft;201;190;195;201;196;198;203;200;200;198 04:21:24 INFO - PROCESS | 2262 | |3;audio-fft;60;70;80;145;76;55;52;79;158;83 04:21:24 INFO - PROCESS | 2262 | |4;audio-oscillator;75;109;168;112;80;80;122;77;77;118 04:21:24 INFO - PROCESS | 2262 | |5;imaging-gaussian-blur;88;86;88;86;89;85;88;85;88;99 04:21:24 INFO - PROCESS | 2262 | |6;imaging-darkroom;94;95;94;94;94;93;93;94;94;93 04:21:24 INFO - PROCESS | 2262 | |7;imaging-desaturate;93;93;89;94;101;90;89;91;90;91 04:21:24 INFO - PROCESS | 2262 | |8;json-parse-financial;58;60;75;67;57;62;64;78;62;58 04:21:24 INFO - PROCESS | 2262 | |9;json-stringify-tinderbox;60;68;84;91;103;79;71;65;65;66 04:21:24 INFO - PROCESS | 2262 | |10;stanford-crypto-aes;82;79;80;81;82;80;106;72;88;97 04:21:24 INFO - PROCESS | 2262 | |11;stanford-crypto-ccm;131;130;154;145;124;126;126;128;142;143 04:21:24 INFO - PROCESS | 2262 | |12;stanford-crypto-pbkdf2;163;176;166;167;167;161;166;167;165;165 04:21:24 INFO - PROCESS | 2262 | |13;stanford-crypto-sha256-iterative;65;68;69;69;67;86;88;95;79;65 04:21:24 INFO - PROCESS | 2262 | __end_tp_report 04:21:24 INFO - PROCESS | 2262 | __start_cc_report 04:21:24 INFO - PROCESS | 2262 | _x_x_mozilla_cycle_collect,1040 04:21:24 INFO - PROCESS | 2262 | __end_cc_report 04:21:24 INFO - PROCESS | 2262 | __startTimestamp1469618484857__endTimestamp 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | ------- Summary: start ------- 04:21:24 INFO - PROCESS | 2262 | Number of tests: 14 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#0] ai-astar Cycles:10 Average:130.90 Median:128.00 stddev:20.25 (15.8%) stddev-sans-first:20.93 04:21:24 INFO - PROCESS | 2262 | Values: 118.0 121.0 167.0 125.0 118.0 132.0 116.0 113.0 131.0 168.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:165.00 stddev:26.69 (16.2%) stddev-sans-first:28.24 04:21:24 INFO - PROCESS | 2262 | Values: 158.0 124.0 143.0 176.0 177.0 134.0 124.0 172.0 197.0 124.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#2] audio-dft Cycles:10 Average:198.20 Median:200.00 stddev:3.77 (1.9%) stddev-sans-first:3.86 04:21:24 INFO - PROCESS | 2262 | Values: 201.0 190.0 195.0 201.0 196.0 198.0 203.0 200.0 200.0 198.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#3] audio-fft Cycles:10 Average:85.80 Median:73.00 stddev:36.37 (49.8%) stddev-sans-first:37.36 04:21:24 INFO - PROCESS | 2262 | Values: 60.0 70.0 80.0 145.0 76.0 55.0 52.0 79.0 158.0 83.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:76.00 stddev:30.01 (39.5%) stddev-sans-first:30.23 04:21:24 INFO - PROCESS | 2262 | Values: 75.0 109.0 168.0 112.0 80.0 80.0 122.0 77.0 77.0 118.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:4.05 (4.6%) stddev-sans-first:4.29 04:21:24 INFO - PROCESS | 2262 | Values: 88.0 86.0 88.0 86.0 89.0 85.0 88.0 85.0 88.0 99.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:21:24 INFO - PROCESS | 2262 | Values: 94.0 95.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 93.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:91.00 stddev:3.57 (3.9%) stddev-sans-first:3.77 04:21:24 INFO - PROCESS | 2262 | Values: 93.0 93.0 89.0 94.0 101.0 90.0 89.0 91.0 90.0 91.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:63.00 stddev:7.23 (11.5%) stddev-sans-first:7.33 04:21:24 INFO - PROCESS | 2262 | Values: 58.0 60.0 75.0 67.0 57.0 62.0 64.0 78.0 62.0 58.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:69.50 stddev:13.77 (19.8%) stddev-sans-first:13.47 04:21:24 INFO - PROCESS | 2262 | Values: 60.0 68.0 84.0 91.0 103.0 79.0 71.0 65.0 65.0 66.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.50 stddev:9.90 (12.1%) stddev-sans-first:10.45 04:21:24 INFO - PROCESS | 2262 | Values: 82.0 79.0 80.0 81.0 82.0 80.0 106.0 72.0 88.0 97.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:136.50 stddev:10.26 (7.5%) stddev-sans-first:10.78 04:21:24 INFO - PROCESS | 2262 | Values: 131.0 130.0 154.0 145.0 124.0 126.0 126.0 128.0 142.0 143.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:3.92 (2.4%) stddev-sans-first:3.97 04:21:24 INFO - PROCESS | 2262 | Values: 163.0 176.0 166.0 167.0 167.0 161.0 166.0 167.0 165.0 165.0 04:21:24 INFO - PROCESS | 2262 | 04:21:24 INFO - PROCESS | 2262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:74.00 stddev:11.01 (14.9%) stddev-sans-first:11.05 04:21:24 INFO - PROCESS | 2262 | Values: 65.0 68.0 69.0 69.0 67.0 86.0 88.0 95.0 79.0 65.0 04:21:24 INFO - PROCESS | 2262 | -------- Summary: end -------- 04:21:24 INFO - PROCESS | 2262 | 04:21:25 INFO - TEST-INFO | 2262: exit 0 04:21:25 INFO - TEST-OK | kraken | took 58623ms 04:21:25 INFO - SUITE-END | took 1169s 04:21:26 INFO - Completed test suite (00:19:29) 04:21:26 INFO - javascript benchmark 04:21:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.598925134358, 3609.8917032489026, 3660.1215708230015, 3675.3568125578017, 3718.4608231806387, 5977.043673012319, 5997.910031349527, 6024.668643224626, 6036.4868986136125, 6085.2393450818645, 5943.732532036058, 5998.730057147428, 6043.214382130328, 6046.8488287792825, 6056.878862422749, 5370.087085195507, 5428.267183930178, 5532.7786888524615, 5578.191162281467, 5604.355499117612, 5392.245085688007, 5397.217403476494, 5452.672839629615, 5493.450654934514, 5519.917201241965, 5462.071447853875, 5468.453154684539, 5480.479354461319, 5486.231927530149, 5488.368837583669, 4908.779104940286, 5451.48210919962, 5466.289382380265, 5522.0, 5559.082751346023, 4397.428334316551, 5269.104252277122, 5388.380336261302, 5394.217838413408, 5427.4301198374, 5232.502912223333, 5700.543956483471, 5700.971495142539, 5931.377205393414, 5937.465628093449, 6252.06219067139, 6320.051992201161, 6332.33510481402, 6349.238091429012, 6357.682115894233, 6387.616742995388, 6402.647854368008, 6430.61416315018, 6453.257875344301, 6464.515161362917, 6027.427394397525, 6048.395160483917, 6133.815985520441, 6140.416660417298, 6146.354632763585, 6522.119513865568, 6567.934320656828, 6610.239822420387, 6613.933860661332, 6618.437432818168, 6251.374862513803, 6293.811185664345, 6295.779647712308, 6298.71655775482, 6300.086487459384, 6228.688565571703, 6276.340984196594, 6327.810165695037, 6362.268339141058, 6396.392342727433, 6265.0602409638, 6268.780592679234, 6313.2424109107205, 6317.557770956081, 6328.746850125944, 5455.099908515051, 6293.496520278458, 6294.685265736694, 6298.779542715983, 6336.6831658416895, 4301.333293339538, 5034.521720436553, 5069.417017043013, 5118.74406279692, 5179.22311653255, 4513.909721805546, 4538.500764915857, 4555.316702494652, 4557.134144512598, 4566.995261042565, 5341.305630268118, 6041.848953776191, 6170.10533472644, 6171.0, 6191.102290167991, 6235.189425374672, 6283.37166283368, 6318.462930650854, 6386.265579458422, 6408.423241908251, 6069.605475644157, 6095.939040609537, 6102.908456373158, 6103.23709536308, 6105.664188469588, 4763.642726795504, 4836.854894353175, 5480.671159730429, 5621.269234999424, 5639.520640745501, 6495.610263384212, 6564.737410503717, 6607.4383677386995, 6658.6337751424135, 6723.722492726366, 6361.491080713625, 6397.488200944006, 6401.455876250571, 6402.071699603438, 6468.288488266193, 6656.966715166393, 6726.293739157513, 6730.8653826924165, 6743.494237932076, 6748.73005079811, 6196.969015154896, 6278.497720182283, 6317.431431171217, 6357.96821015892, 6366.236051673829, 6404.551681382445, 6411.326810684811, 6417.326180751141, 6429.32492088324, 6451.225852897683, 5694.800681976111, 6265.404786545271, 6277.403646653561, 6277.497800176066, 6291.465225455888, 5495.972520137374, 6172.722227499863, 6192.721327540181, 6249.906251406142, 6256.092866534418, 6150.384961503813, 6196.0, 6208.255009398901, 6244.750209991549, 6270.717817698123, 6153.769246150878, 6254.061890716429, 6265.185525881606, 6269.49844012487, 6279.780207692892, 6122.062734707273, 6135.04893764628, 6198.721057552511, 6231.719572619152, 6249.1563638908165], "value": 5875.834365269284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.7561845932411, 542.4548328929427, 557.4648337595913, 559.4377650461286, 561.9297587801524, 30768.692313076863, 39255.80372098139, 39283.803580982094, 39308.60691393085, 39333.21333573327, 40618.59381406185, 41397.0, 41432.378514322234, 41468.58531414685, 41477.79261103698, 9547.23622110233, 9710.36882602632, 9766.658166964158, 9771.804563908718, 9792.265580081486, 9655.08276713711, 9848.113669769718, 9922.603095876193, 9922.702318930444, 9940.850887236697, 8707.782305442382, 9735.318527703064, 9829.262805289596, 9899.257555683316, 9912.504374781269, 9818.067283608047, 9843.557039933148, 9893.30746847721, 9916.157126644244, 9933.205343572497, 9240.168384845396, 9386.389884657476, 9794.706158815246, 9827.950860245724, 9907.306488545804, 39118.217635647416, 39225.60774392277, 39250.80374598109, 39660.0, 39829.80085099556, 3226.677332266778, 3308.8345582720767, 3374.240795820945, 3416.4021296273054, 3418.29924865402, 27839.86080069607, 28376.574351384745, 29456.55815162774, 29823.0, 30052.54921176184, 2791.3440341519727, 2794.357297821492, 2814.212020634205, 2835.9291017724518, 2854.471922694308, 447861.0, 455499.0, 458700.0, 459003.0, 459094.0, 53028.46971530312, 60290.69854650786, 60788.39211607916, 60844.087338689955, 61007.38992610017, 69046.0, 70754.0, 70808.64595676989, 70825.0, 70931.64534177296, 13615.795763063563, 17784.822151778575, 17819.46541603754, 17833.643327133384, 17958.371456998942, 11534.711632209262, 13538.390772415265, 13555.322233888266, 13585.116967397087, 13651.658708532168, 19941.700874486894, 20203.898980505004, 20259.493512662302, 20288.188472461232, 20619.175232990812, 7382.630868456556, 7997.360211183091, 8332.833343333099, 8396.328293736486, 8410.0, 859.2524503681836, 1034.4000479721744, 1058.51837413978, 1072.790805792863, 1085.2511766880828, 26648.733512665014, 30713.0, 30744.69255307463, 31037.534436983013, 31294.904678336603, 1039.4231201683137, 1112.3492756737237, 1243.5461056714234, 1272.497363541396, 1318.8021796730568, 14208.502702405367, 14958.099930541528, 14979.664260935391, 15069.698606027818, 15134.243287835565, 591237.0, 599486.0, 601091.0, 606046.0, 606848.0, 59537.106943395884, 60393.69803151044, 61631.07553386703, 61720.38279617146, 61743.691281544205, 1301.2517802263735, 1512.0625212368402, 1515.6438237014293, 1518.3622878391102, 1525.2068924159375, 25172.622410664222, 29247.85376073106, 29608.555871661512, 29975.400491990473, 30121.548176777804, 51458.48541514537, 51587.48412515977, 52059.0, 52203.95592088213, 52296.0, 558812.0, 561073.0, 562548.0, 566566.0, 570871.0, 23202.1879234226, 26667.333316666463, 27511.724882751718, 28129.015484457945, 28300.15099547017, 37859.0, 39172.80413597914, 39214.80392598133, 39477.802610987914, 39531.40702889516, 35447.64552354444, 35550.28899421945, 36302.273954520235, 36501.63498365089, 36997.26005479929, 37801.62198378091, 37927.43108853314, 37939.292731827685, 38219.0, 38546.421803672405, 33033.50449743304, 37986.43020354752, 38210.426843597925, 38243.42634860424, 38934.415983759696, 30736.846315768278, 31538.0, 31589.36821263608, 31689.20776980594, 31771.0, 24699.50600988006, 25047.622380768502, 25421.61867571951, 25555.105571304914, 25722.842472088425], "value": 19929.476033519266, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.71133969116704, 421.66266986410875, 424.74939785526533, 427.23098422838893, 434.2552522424044, 20561.280355187573, 21287.574248515022, 21313.786862131376, 21500.0, 22953.77046229537, 17864.732029019575, 21278.936053197318, 21578.460538486546, 21704.782952170473, 21731.565368692616, 5852.239208902858, 5876.853078673035, 6136.0, 6160.2915664698685, 6163.0, 6032.66820324882, 6124.356942521038, 6139.662318572477, 6141.263048434194, 6159.014557670774, 5764.51001664859, 6002.8499287517725, 6100.755969761204, 6121.387861213865, 6121.540884433685, 5817.941820581782, 6009.369016253296, 6042.123892035652, 6208.00671892495, 6214.689265536705, 6029.758809647609, 6045.879082418327, 6049.274087109531, 6089.147519347295, 6116.785912493041, 13682.863171368259, 17269.913650431794, 25799.065070119817, 26436.810343534587, 26904.59643105355, 2034.8982550872545, 2273.090763694519, 2288.39357570244, 2328.2782337475437, 2343.3438637181616, 9895.65365212214, 10188.083072523508, 10374.221933354953, 13422.93288533561, 14626.341814618369, 1740.5909611241348, 1755.4821327708357, 1807.9548011299692, 1841.9539511512185, 1883.896385698786, 108841.0, 110235.0, 110793.0, 111374.44312778384, 111989.0, 12119.818202726967, 12197.414336136246, 12257.203281786655, 12269.57056503018, 12284.201526900722, 15450.304736286895, 15674.216289185495, 15804.36782528709, 15872.047677139408, 15879.682406351809, 7591.8861217081785, 8766.123387661182, 9173.724788256362, 9222.0, 9261.49061801594, 9128.0, 9139.0, 9175.08249175077, 9237.307201959746, 9245.537723113817, 4069.4709687740406, 4258.318669012943, 4796.832110876103, 4875.853724388274, 4900.166971614834, 1566.772817941392, 1748.7114626086807, 1882.792892781793, 2012.3560460652743, 2141.603803296395, 909.4270609515962, 991.7966816802539, 1005.3666190300211, 1038.4132964874973, 1137.5279259107378, 19705.01474926248, 19968.70046949297, 20936.37190884276, 20959.580808383747, 21570.460738481663, 906.7234493479552, 999.7752752877811, 1006.3810756384917, 1046.398320965448, 1095.315427857589, 8909.242714369351, 11683.415829208505, 11722.120840936965, 11744.29534227949, 11768.058555315554, 565592.0, 568349.0, 572108.0, 690088.0, 702737.0, 129011.0, 133636.0, 135518.6448135506, 137229.94155087683, 140432.0, 987.9456629885282, 1023.559869256227, 1027.6762819711766, 1032.9535170917327, 1047.1204188481863, 19196.808031919503, 19279.325223617107, 19599.31402400966, 19792.289003066897, 19796.81219126857, 55486.0, 57998.0, 58028.70985645045, 58243.4175658238, 59200.407995919486, 68384.0, 81876.0, 85947.0, 86228.56885715532, 86470.56764716136, 8181.590920454072, 8399.874001890099, 8414.537200454033, 8544.316454683734, 8770.122987701434, 9400.34197606161, 10683.89316106829, 11570.247933884608, 13323.467061317438, 13622.795658064939, 10999.065079468335, 11178.049865761175, 11604.0, 11637.069034477052, 11833.053355731348, 11301.71745706364, 11404.600838970597, 11454.083673306282, 11599.536018559163, 11801.763964720829, 11705.824412633987, 11751.412429378326, 11804.527818887493, 11852.288862668267, 12106.576269830513, 8648.264897483532, 8797.120287971407, 8841.248493878093, 8852.468851868909, 8914.643414263617, 7751.728689495841, 10932.836007460053, 11503.884961150281, 11722.472488737856, 11884.524619015143], "value": 9876.99463287103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1646.0699704666865, 1668.82347944699, 1964.931227407041, 2013.8288245499132, 2116.4285642876434, 8268.669253229878, 8976.506292153928, 9042.095790420963, 9275.953620231889, 9294.442333459998, 8958.820823583525, 9021.864672029924, 9093.454392736441, 9104.544772761368, 9125.771855703611, 2529.3550144713117, 2532.202356257782, 2539.657146285246, 2549.9490010199784, 2551.7703406693395, 2489.0666000249907, 2555.3739333863227, 2556.782673472757, 2559.424129570841, 2563.269468201563, 2521.798256139514, 2547.5414425403515, 2557.360659835041, 2572.794176465878, 2585.418280886804, 2548.388386787167, 2554.0, 2561.6541766861424, 2593.1831473085917, 2593.7795287400404, 2444.2545023767743, 2445.7187423446353, 2464.7412021737637, 2543.2370288913253, 2597.545429549821, 9136.771580710469, 9221.861672074925, 9252.583633736498, 9276.953615231881, 9282.071792820663, 5629.57778166635, 5760.6255593386295, 5805.970970145122, 5826.184334193216, 5828.271466066742, 3523.119220194951, 3559.555055618048, 3594.802285874276, 3750.043738846604, 3796.1268908151005, 1065.8880817514205, 1085.426132108446, 1097.1661537231762, 1098.4068602954394, 1100.3287994323457, 12619.810702839464, 12641.367931603383, 12659.303738294482, 12668.303243321614, 12689.175203611829, 5010.69935803853, 5016.247562865527, 5089.694618322913, 5108.872278193075, 5168.7415629218385, 9082.954585227164, 9298.628054877865, 10337.328073675337, 10395.58417663285, 10587.523561439753, 5495.340559132929, 5555.055640541118, 5668.546516278688, 5668.943310566924, 5748.367679555246, 4506.954930450719, 4593.104344652761, 4837.37114175155, 5149.0, 5150.562202212854, 4206.8737937861915, 4222.218889505451, 4248.87253382399, 4313.0, 4321.0, 1401.4884567133126, 1426.0588011912089, 1427.8072460217945, 1432.8495507971513, 1432.9140251584938, 907.8275127725843, 950.5817440326234, 951.219999600335, 978.4031740638205, 984.0848011349514, 5890.175375447355, 5933.0, 6098.573099882966, 6098.939010609926, 6114.755409783648, 996.4320337407609, 1011.9241056920761, 1017.1405162637559, 1052.8631277933973, 1058.222206678091, 4008.2183974124764, 4018.7387819792207, 4048.0487085534874, 4081.0, 4091.8977025574004, 10909.072728818139, 11220.102391808636, 11340.659780206606, 11359.261647992855, 11510.136739744552, 11085.057770089472, 11105.500252488657, 11230.438478076063, 11304.26522276066, 11317.207795454238, 8404.36967227448, 8616.913830861737, 8720.651173953098, 8761.080086590944, 8768.386212965032, 6036.366181550874, 6097.390260973867, 6274.027525733519, 6275.435210831047, 6276.497880169667, 9966.950165249418, 10055.748606284902, 10075.395476271447, 10236.078752912274, 10287.588496460057, 9743.75640608962, 10269.897301027193, 10424.791504169722, 10440.37357758537, 10516.947415262875, 7017.403520700594, 7611.162772094955, 7678.5392876427595, 7808.0, 7915.168907264654, 8468.44955077918, 8597.226249637562, 8612.440191387539, 8645.308375330083, 8668.91331086681, 7505.061867266591, 7653.846923061619, 7718.112417072109, 7721.5753133575945, 7743.032120984877, 7472.476926615085, 7519.924800751923, 7554.848903022019, 7635.923640763522, 7661.310482056641, 7237.203907570269, 7323.523970941872, 7377.926220737939, 7403.370713489414, 7403.5928023959195, 4970.155073637418, 4980.800767969241, 5093.159628661229, 5151.5106064923775, 5176.767045482887, 5005.524475174852, 5116.616253780907, 5142.76857541419, 5169.4830516948, 5310.468953104659], "value": 4838.990693778476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.86470358931297, 316.42094966211835, 319.8704524667509, 340.69507790527473, 344.30278685661534, 6824.283450237728, 6857.708300015989, 6861.108055952725, 6881.931180688185, 6886.586804791704, 6630.535862489615, 6805.965970170155, 6830.282820303871, 6836.794896153111, 6870.965645171779, 4848.951510484894, 4908.141075311824, 5055.266986286986, 5056.064628043805, 5083.212102124176, 4355.520892701816, 5077.923831142536, 5098.796048158069, 5107.106256405133, 5136.409312929024, 5047.47001564836, 5066.088104141271, 5074.594032477393, 5084.288199652033, 5086.0, 5077.3907131144315, 5082.974585127087, 5101.872453188663, 5109.0, 5114.616403769695, 3571.3750093733493, 4357.193919124972, 4363.454568178978, 4371.759553224571, 4401.207782599131, 5112.565431938289, 6353.0, 6557.836054098638, 6596.076549283104, 6658.201015878077, 5926.199963004982, 5957.1362152487645, 5983.910241346383, 5996.970015149896, 5997.610155339889, 7335.119785625706, 7337.926620733778, 7344.779656610311, 7348.448866335047, 7361.668724907392, 4873.34209881665, 4880.2435622478215, 4881.609471242292, 4885.218365061573, 4886.53577910098, 6310.368963103699, 7203.38771204443, 7792.493487923267, 7822.843543129163, 7852.450328477009, 4934.901301974012, 4938.209886418156, 4939.407271127416, 4950.480199579064, 4973.925391119136, 4952.455229924705, 5027.597792176617, 5032.974835125801, 5044.974775126101, 5061.392632884077, 5891.0, 5943.940560594425, 5979.671118088547, 5983.790567330123, 5988.820335389945, 7348.448866335047, 7365.852682946311, 7373.188949215582, 7373.262673732584, 7401.259874012556, 1558.6517662222095, 1641.588234118657, 1722.6726921885052, 1744.5813004878737, 1749.3439960014994, 1023.6468418395641, 1061.601899287767, 1076.9946150269197, 1077.2620754782843, 1077.9730506737237, 6919.37725604688, 6921.723131074801, 6989.126359205099, 7036.155661320572, 7048.365647091787, 7353.867378460187, 7579.2420757924865, 7595.202503737028, 7606.771796846104, 7637.625227459111, 6094.39056094387, 6968.616726080013, 7048.330408611174, 7071.186813516511, 7163.928360716431, 4017.055991841915, 4054.878353649395, 4059.6346328830546, 4076.0, 4082.3672330788777, 6487.610743355413, 8056.677732890619, 8105.594720263964, 8117.391195660349, 8139.308158806568, 6391.808245752635, 7606.885896711554, 7904.1700621435075, 7956.681732730626, 7963.721269755647, 6588.110605068446, 8047.51714897108, 8082.313003394777, 8091.109977902426, 8199.549024803573, 6248.312685604489, 7692.461527693008, 7713.2286771322415, 7744.49660772048, 7748.92251077482, 6389.233292004989, 6826.897596535957, 7512.361449276654, 7562.962185189039, 7564.50830696003, 7702.575023620648, 7907.169747176464, 8044.0, 8054.637541310538, 8179.100298967228, 3752.4371344297483, 4728.432588089451, 4769.284607308931, 4805.591524720298, 4807.038592281628, 6040.09398590215, 7568.508046977149, 7714.884276735741, 7749.0, 7755.457118001911, 5993.70031498432, 6493.448056915215, 7148.499605027599, 7454.291842274975, 7528.247175282428, 7232.168300645493, 7274.16347120088, 7465.328120469184, 7473.327400533978, 7474.215207403145, 7180.533265337736, 7196.676149573177, 7225.963870180615, 7238.819029524304, 7277.38142257914, 7391.0761154855645, 7418.109826820816, 7434.219406962191, 7449.366803821736, 7464.290892365217, 5911.615744976562, 7250.891236631349, 7276.490645654753, 7283.854322913406, 7294.452916031425], "value": 5330.617900160357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.413897160215, 777.4557809533325, 779.1273773373819, 793.6864938349356, 808.0626473290981, 15216.771748423782, 15544.222788860554, 15555.0, 15571.610709732235, 15618.999999999985, 14363.856361436408, 14428.422863085463, 14449.494267700633, 14537.982341236091, 14550.563483095497, 778.2101167315179, 953.4422362917684, 961.5672947173765, 982.8476586129161, 987.7481242283208, 935.957881895313, 962.9277804164681, 964.8070385922808, 971.8056388722284, 973.6446197138065, 1009.1271050541302, 1019.1999280564759, 1026.845973104033, 1026.9589216431334, 1028.254515476281, 972.2513664478312, 998.5805961496189, 1013.6350913671035, 1013.7516308504427, 1013.8276492996208, 758.9354904833095, 762.2872614105773, 770.537677393565, 771.7221800151941, 772.7758949904521, 15063.322150503254, 15066.849331506653, 15079.623009424742, 15335.693286134216, 15417.691646167126, 13034.478620855154, 13088.934555327258, 13117.60647180586, 13170.670733231746, 13280.269585172811, 10146.796023714334, 10339.844902326471, 10456.0, 10674.839877401846, 10830.566777328897, 3572.089117275078, 3594.5398642392865, 3618.2944325856206, 3691.077230692327, 3853.0560012796764, 57809.0, 75737.62131189309, 75787.86318205232, 75819.24180758232, 79924.80112798371, 9709.223262139012, 9822.214222862154, 9845.55694993727, 10024.79950400988, 10427.68716938493, 22790.0, 22878.31365059051, 22917.885410573173, 22955.96698148587, 23446.413839653804, 7672.73145439907, 7684.692612295557, 7696.037995250594, 7709.4603377763015, 7883.408744344197, 4216.072464057902, 4222.852200172979, 4241.1941731071, 4264.701470897069, 4355.08543205924, 3761.605031471711, 3774.1885494618787, 3820.1977584706965, 3844.2695887781233, 3847.5575308839843, 705.7071315404153, 732.6117157906318, 735.6468894930464, 737.8598066367373, 743.3755645258009, 558.8463172627479, 563.1355868741463, 564.350996354196, 591.6006695480534, 597.9880402391927, 8006.428300493163, 8065.879011814827, 8081.555514446644, 8142.796430089295, 8438.662453501915, 498.8303976647957, 506.4530307268142, 515.2811827500616, 576.6540075954478, 584.8537865533617, 3544.2379888324135, 3551.0057183988524, 3847.153626202231, 3871.9806400967814, 4012.398140278923, 82982.3403531926, 85191.72212416818, 91262.0, 91356.17287654342, 92752.07247927434, 64009.71980560363, 65795.0, 72831.90752138723, 75899.86150207752, 77218.22781772223, 65780.0, 66573.667131665, 68755.31244687589, 69746.65126674334, 69759.0, 7572.734954276574, 7636.08366995964, 7754.224577542201, 7887.487313324845, 8001.399895008014, 39447.0, 49856.0, 50855.74572127264, 51172.74413627908, 51305.23042154445, 67358.0, 71491.92762108677, 72108.63945680238, 73166.0, 73973.0, 11128.1653875958, 11152.776944461228, 11227.943860280646, 11358.26171298863, 11559.595414160463, 10362.0, 11783.234089784137, 11824.40877956116, 12156.878431215575, 12479.438425271066, 11126.388048657402, 11162.386068766296, 11355.261907975955, 11546.48040838181, 11587.942060289644, 11006.779864402828, 11119.555217791521, 11203.831942520706, 11360.715982100513, 11614.0, 10721.088707459641, 10867.29362591429, 11004.669859904216, 11121.555137794398, 11171.72070698239, 9597.520123993912, 9610.231181505324, 9660.95169524148, 9695.1146798108, 9996.550155242887, 9538.427694338361, 9757.56090975922, 9765.85351219718, 9789.510524473606, 9826.361286516354], "value": 7013.098486772946, "unit": "score"}], "name": "dromaeo_css", "value": 7705.092515697704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 167.0, 125.0, 118.0, 132.0, 116.0, 113.0, 131.0, 168.0], "value": 130.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 143.0, 176.0, 177.0, 134.0, 124.0, 172.0, 197.0, 124.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 190.0, 195.0, 201.0, 196.0, 198.0, 203.0, 200.0, 200.0, 198.0], "value": 198.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 70.0, 80.0, 145.0, 76.0, 55.0, 52.0, 79.0, 158.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 109.0, 168.0, 112.0, 80.0, 80.0, 122.0, 77.0, 77.0, 118.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 89.0, 85.0, 88.0, 85.0, 88.0, 99.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 89.0, 94.0, 101.0, 90.0, 89.0, 91.0, 90.0, 91.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 75.0, 67.0, 57.0, 62.0, 64.0, 78.0, 62.0, 58.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 68.0, 84.0, 91.0, 103.0, 79.0, 71.0, 65.0, 65.0, 66.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 81.0, 82.0, 80.0, 106.0, 72.0, 88.0, 97.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 154.0, 145.0, 124.0, 126.0, 126.0, 128.0, 142.0, 143.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 176.0, 166.0, 167.0, 167.0, 161.0, 166.0, 167.0, 165.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 69.0, 69.0, 67.0, 86.0, 88.0, 95.0, 79.0, 65.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1544.0, "alertThreshold": 2.0}]} 04:21:26 INFO - Return code: 0 04:21:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:26 ERROR - # TBPL SUCCESS # 04:21:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:21:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:21:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:21:26 INFO - 2016-07-27 04:21:26.157 screenresolution[2267:19392] starting screenresolution argv=screenresolution get 04:21:26 INFO - 2016-07-27 04:21:26.159 screenresolution[2267:19392] Display 0: 1600x1200x32@60 04:21:26 INFO - 2016-07-27 04:21:26.165 screenresolution[2268:19395] starting screenresolution argv=screenresolution list 04:21:26 INFO - Available Modes on Display 0 04:21:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:21:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:21:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:21:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:21:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:21:26 INFO - Intel Iris: 04:21:26 INFO - Chipset Model: Intel Iris 04:21:26 INFO - Type: GPU 04:21:26 INFO - Bus: Built-In 04:21:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:21:26 INFO - Vendor: Intel (0x8086) 04:21:26 INFO - Device ID: 0x0a2e 04:21:26 INFO - Revision ID: 0x0009 04:21:26 INFO - Displays: 04:21:26 INFO - Display: 04:21:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:21:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:21:26 INFO - Display Serial Number: 1600x1200 60 04:21:26 INFO - Main Display: Yes 04:21:26 INFO - Mirror: Off 04:21:26 INFO - Online: Yes 04:21:26 INFO - Rotation: Supported 04:21:26 INFO - Return code: 0 04:21:26 INFO - Running post-action listener: _resource_record_post_action 04:21:26 INFO - Running post-run listener: _resource_record_post_run 04:21:27 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 1094144; Write bytes: 491609088; Read time: 14; Write time: 1776 04:21:27 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 184791552; Write bytes: 184619008; Read time: 16579; Write time: 472 04:21:27 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 1094144; Write bytes: 297036800; Read time: 14; Write time: 1271 04:21:27 INFO - Running post-run listener: _upload_blobber_files 04:21:27 INFO - Blob upload gear active. 04:21:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:21:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:21:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:28 INFO - (blobuploader) - INFO - Done attempting. 04:21:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:21:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:21:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:29 INFO - (blobuploader) - INFO - Done attempting. 04:21:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:29 INFO - Return code: 0 04:21:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75609a1af595ae267de966bd7fb81964f2063418e15482d984c6726191e2d46e0ab1ae2e0c9de5b5c32b846f9d9b889e72cbc1e43b6a712900cb037c1dba375f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d588af41a1b305c1be5070a72feb9bdc7a447abe0f401c32706f3454294de2ed7c202b0d13160f1723f011624271f07674fdd2734103d73ee9d4a5ef1602a90c"} 04:21:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:29 INFO - Contents: 04:21:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75609a1af595ae267de966bd7fb81964f2063418e15482d984c6726191e2d46e0ab1ae2e0c9de5b5c32b846f9d9b889e72cbc1e43b6a712900cb037c1dba375f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d588af41a1b305c1be5070a72feb9bdc7a447abe0f401c32706f3454294de2ed7c202b0d13160f1723f011624271f07674fdd2734103d73ee9d4a5ef1602a90c"} 04:21:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:29 INFO - Copying logs to upload dir... 04:21:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.953407 ========= master_lag: 2.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-27 04:21:31.890203) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:31.893487) ========= 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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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/75609a1af595ae267de966bd7fb81964f2063418e15482d984c6726191e2d46e0ab1ae2e0c9de5b5c32b846f9d9b889e72cbc1e43b6a712900cb037c1dba375f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d588af41a1b305c1be5070a72feb9bdc7a447abe0f401c32706f3454294de2ed7c202b0d13160f1723f011624271f07674fdd2734103d73ee9d4a5ef1602a90c"} build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011740 build_url: 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/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/75609a1af595ae267de966bd7fb81964f2063418e15482d984c6726191e2d46e0ab1ae2e0c9de5b5c32b846f9d9b889e72cbc1e43b6a712900cb037c1dba375f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d588af41a1b305c1be5070a72feb9bdc7a447abe0f401c32706f3454294de2ed7c202b0d13160f1723f011624271f07674fdd2734103d73ee9d4a5ef1602a90c"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:32.101602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-07-27 04:21:32.101920) ========= 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.e5RhG5Fn39/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.sJzxKKYY9B/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.005247 ========= master_lag: 3.81 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-07-27 04:21:35.913686) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-07-27 04:21:35.914012) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-07-27 04:21:39.812325) ========= ========= Total master_lag: 6.10 =========