builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0306 starttime: 1465288638.5 results: success (0) buildid: 20160606120332 builduid: 394ff36afaaf47b0a5ccdc9e3ac607e3 revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.503272) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.503682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.503953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.527609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.527994) ========= 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.3D9n5sgAwE/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.pnA3onCLrR/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-07 01:37:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 57.3M=0s 2016-06-07 01:37:18 (57.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096559 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.646006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.646316) ========= 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.3D9n5sgAwE/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.pnA3onCLrR/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.025881 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:18.694723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:18.695069) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --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 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3D9n5sgAwE/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.pnA3onCLrR/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-07 01:37:18,779 truncating revision to first 12 chars 2016-06-07 01:37:18,779 Setting DEBUG logging. 2016-06-07 01:37:18,779 attempt 1/10 2016-06-07 01:37:18,779 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d72a56c57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:37:19,844 unpacking tar archive at: mozilla-beta-46d72a56c57d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.324936 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:20.170116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:20.170478) ========= script_repo_revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:20.170921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:20.171205) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:21.084368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-07 01:37:21.084753) ========= /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.3D9n5sgAwE/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.pnA3onCLrR/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:37:21 INFO - MultiFileLogger online at 20160607 01:37:21 in /builds/slave/test 01:37:21 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 01:37:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:21 INFO - {'append_to_log': False, 01:37:21 INFO - 'base_work_dir': '/builds/slave/test', 01:37:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:37:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:21 INFO - 'branch': 'Mozilla-Beta', 01:37:21 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:21 INFO - 'config_files': ('talos/mac_config.py',), 01:37:21 INFO - 'default_actions': ('clobber', 01:37:21 INFO - 'read-buildbot-config', 01:37:21 INFO - 'download-and-extract', 01:37:21 INFO - 'populate-webroot', 01:37:21 INFO - 'create-virtualenv', 01:37:21 INFO - 'install', 01:37:21 INFO - 'run-tests'), 01:37:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:21 INFO - 'download_minidump_stackwalk': True, 01:37:21 INFO - 'download_symbols': 'ondemand', 01:37:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:21 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:21 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:21 INFO - 'installer_path': 'installer.exe', 01:37:21 INFO - 'log_level': 'info', 01:37:21 INFO - 'log_name': 'talos', 01:37:21 INFO - 'log_to_console': True, 01:37:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:37:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:37:21 INFO - 'opt_config_files': (), 01:37:21 INFO - 'pip_index': False, 01:37:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:21 INFO - 'cmd': ('bash', 01:37:21 INFO - '-c', 01:37:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:21 INFO - 'enabled': True, 01:37:21 INFO - 'halt_on_failure': False, 01:37:21 INFO - 'name': 'check_screen_resolution'},), 01:37:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:21 INFO - 'cmd': ('bash', 01:37:21 INFO - '-c', 01:37:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:21 INFO - 'enabled': True, 01:37:21 INFO - 'halt_on_failure': False, 01:37:21 INFO - 'name': 'check_screen_resolution'},), 01:37:21 INFO - 'run_cmd_checks_enabled': True, 01:37:21 INFO - 'sps_profile': False, 01:37:21 INFO - 'sps_profile_interval': 0, 01:37:21 INFO - 'suite': 'dromaeojs-e10s', 01:37:21 INFO - 'system_bits': '32', 01:37:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:21 INFO - 'title': 't-yosemite-r7-0306', 01:37:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:21 INFO - 'use_talos_json': True, 01:37:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:21 INFO - 'work_dir': 'build'} 01:37:21 INFO - ##### 01:37:21 INFO - ##### Running clobber step. 01:37:21 INFO - ##### 01:37:21 INFO - Running pre-action listener: _resource_record_pre_action 01:37:21 INFO - Running main action method: clobber 01:37:21 INFO - rmtree: /builds/slave/test/build 01:37:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:23 INFO - Running post-action listener: _resource_record_post_action 01:37:23 INFO - ##### 01:37:23 INFO - ##### Running read-buildbot-config step. 01:37:23 INFO - ##### 01:37:23 INFO - Running pre-action listener: _resource_record_pre_action 01:37:23 INFO - Running main action method: read_buildbot_config 01:37:23 INFO - Using buildbot properties: 01:37:23 INFO - { 01:37:23 INFO - "project": "", 01:37:23 INFO - "product": "firefox", 01:37:23 INFO - "script_repo_revision": "production", 01:37:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 01:37:23 INFO - "repository": "", 01:37:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 01:37:23 INFO - "buildid": "20160606120332", 01:37:23 INFO - "pgo_build": "False", 01:37:23 INFO - "basedir": "/builds/slave/test", 01:37:23 INFO - "buildnumber": 1, 01:37:23 INFO - "slavename": "t-yosemite-r7-0306", 01:37:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:37:23 INFO - "platform": "yosemite_r7", 01:37:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:37:23 INFO - "branch": "mozilla-beta", 01:37:23 INFO - "repo_path": "releases/mozilla-beta", 01:37:23 INFO - "revision": "46d72a56c57dafb4dc1061d4741a3e1181ac3d68", 01:37:23 INFO - "stage_platform": "macosx64", 01:37:23 INFO - "builduid": "394ff36afaaf47b0a5ccdc9e3ac607e3", 01:37:23 INFO - "slavebuilddir": "test" 01:37:23 INFO - } 01:37:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:37:23 INFO - Running post-action listener: _resource_record_post_action 01:37:23 INFO - ##### 01:37:23 INFO - ##### Running download-and-extract step. 01:37:23 INFO - ##### 01:37:23 INFO - Running pre-action listener: _resource_record_pre_action 01:37:23 INFO - Running main action method: download_and_extract 01:37:23 INFO - mkdir: /builds/slave/test/build/tests 01:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:37:23 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:25 INFO - Downloaded 1165 bytes. 01:37:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:25 INFO - Using the following test package requirements: 01:37:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:37:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:37:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:37:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:37:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:37:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:37:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:37:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:37:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:37: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')]} 01:37:25 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:27 INFO - Downloaded 18292404 bytes. 01:37:27 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'] 01:37:27 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 01:37:30 INFO - Return code: 0 01:37:30 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 01:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:30 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:32 INFO - Downloaded 18292404 bytes. 01:37:32 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'] 01:37:32 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 01:37:35 INFO - Return code: 0 01:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:35 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:36 INFO - Downloaded 10840145 bytes. 01:37:36 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'] 01:37:36 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 01:37:36 INFO - Return code: 0 01:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:36 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/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 01:37:39 INFO - Downloaded 86246253 bytes. 01:37:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:39 INFO - mkdir: /builds/slave/test/properties 01:37:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:39 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:39 INFO - Contents: 01:37:39 INFO - build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:40 INFO - Running post-action listener: _resource_record_post_action 01:37:40 INFO - Running post-action listener: set_extra_try_arguments 01:37:40 INFO - ##### 01:37:40 INFO - ##### Running populate-webroot step. 01:37:40 INFO - ##### 01:37:40 INFO - Running pre-action listener: _resource_record_pre_action 01:37:40 INFO - Running main action method: populate_webroot 01:37:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:40 INFO - '--tppagecycles', 01:37:40 INFO - '7'], 01:37:40 INFO - 'tests': ['tsvgm']}}, 01:37:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['damp', 'tps']}, 01:37:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'tests': ['damp', 'tps']}, 01:37:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['dromaeo_dom']}, 01:37:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['a11yr', 01:37:40 INFO - 'ts_paint', 01:37:40 INFO - 'tpaint', 01:37:40 INFO - 'sessionrestore', 01:37:40 INFO - 'sessionrestore_no_auto_restore', 01:37:40 INFO - 'tabpaint']}, 01:37:40 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:40 INFO - 'ts_paint', 01:37:40 INFO - 'tpaint', 01:37:40 INFO - 'sessionrestore', 01:37:40 INFO - 'sessionrestore_no_auto_restore', 01:37:40 INFO - 'tabpaint']}, 01:37:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:40 INFO - 'ts_paint', 01:37:40 INFO - 'tpaint', 01:37:40 INFO - 'sessionrestore', 01:37:40 INFO - 'sessionrestore_no_auto_restore', 01:37:40 INFO - 'tabpaint']}, 01:37:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:40 INFO - 'ts_paint', 01:37:40 INFO - 'tpaint', 01:37:40 INFO - 'sessionrestore', 01:37:40 INFO - 'sessionrestore_no_auto_restore', 01:37:40 INFO - 'tabpaint']}, 01:37:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['a11yr', 01:37:40 INFO - 'ts_paint', 01:37:40 INFO - 'tpaint', 01:37:40 INFO - 'sessionrestore', 01:37:40 INFO - 'sessionrestore_no_auto_restore', 01:37:40 INFO - 'tabpaint']}, 01:37:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['a11yr', 01:37:40 INFO - 'ts_paint', 01:37:40 INFO - 'tpaint', 01:37:40 INFO - 'sessionrestore', 01:37:40 INFO - 'sessionrestore_no_auto_restore', 01:37:40 INFO - 'tabpaint']}, 01:37:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['tsvgx', 01:37:40 INFO - 'tsvgr_opacity', 01:37:40 INFO - 'tart', 01:37:40 INFO - 'tscrollx', 01:37:40 INFO - 'cart']}, 01:37:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:40 INFO - 'tsvgr_opacity', 01:37:40 INFO - 'tart', 01:37:40 INFO - 'tscrollx', 01:37:40 INFO - 'cart']}, 01:37:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'talos_options': ['--disable-e10s'], 01:37:40 INFO - 'tests': ['tp5o']}, 01:37:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'tests': ['tp5o']}, 01:37:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'talos_options': ['--disable-e10s', 01:37:40 INFO - '--xperf_path', 01:37:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:40 INFO - 'tests': ['tp5n']}, 01:37:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:40 INFO - 'talos_options': ['--xperf_path', 01:37:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:40 INFO - 'tests': ['tp5n']}}, 01:37:40 INFO - 'talos.zip': {'path': '', 01:37:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:40 INFO - Running post-action listener: _resource_record_post_action 01:37:40 INFO - ##### 01:37:40 INFO - ##### Running create-virtualenv step. 01:37:40 INFO - ##### 01:37:40 INFO - Running pre-action listener: _resource_record_pre_action 01:37:40 INFO - Running main action method: create_virtualenv 01:37:40 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37:40 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 01:37:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:40 INFO - Using real prefix '/tools/python27' 01:37:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:41 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:44 INFO - Installing pip.................done. 01:37:44 INFO - Return code: 0 01:37:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:44 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 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:37:44 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 01:37:44 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 01:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:44 INFO - 'HOME': '/Users/cltbld', 01:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:44 INFO - 'LOGNAME': 'cltbld', 01:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:44 INFO - 'MOZ_NO_REMOTE': '1', 01:37:44 INFO - 'NO_EM_RESTART': '1', 01:37:44 INFO - 'PAGER': '/bin/cat', 01:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:44 INFO - 'PWD': '/builds/slave/test', 01:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:44 INFO - 'SHELL': '/bin/bash', 01:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:37:44 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:44 INFO - 'USER': 'cltbld', 01:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:44 INFO - 'XPC_FLAGS': '0x0', 01:37:44 INFO - 'XPC_SERVICE_NAME': '0', 01:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:44 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 01:37:44 INFO - Cleaning up... 01:37:44 INFO - Return code: 0 01:37:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:44 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 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:37:44 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 01:37:44 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 01:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:44 INFO - 'HOME': '/Users/cltbld', 01:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:44 INFO - 'LOGNAME': 'cltbld', 01:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:44 INFO - 'MOZ_NO_REMOTE': '1', 01:37:44 INFO - 'NO_EM_RESTART': '1', 01:37:44 INFO - 'PAGER': '/bin/cat', 01:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:44 INFO - 'PWD': '/builds/slave/test', 01:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:44 INFO - 'SHELL': '/bin/bash', 01:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:37:44 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:44 INFO - 'USER': 'cltbld', 01:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:44 INFO - 'XPC_FLAGS': '0x0', 01:37:44 INFO - 'XPC_SERVICE_NAME': '0', 01:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:45 INFO - Downloading/unpacking psutil>=0.7.1 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:47 INFO - Installing collected packages: psutil 01:37:47 INFO - Running setup.py install for psutil 01:37:48 INFO - building 'psutil._psutil_osx' extension 01:37:48 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 01:37:48 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 01:37:48 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 01:37:48 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 01:37:48 INFO - building 'psutil._psutil_posix' extension 01:37:48 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 01:37:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:37:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:37:48 INFO - ^ 01:37:48 INFO - 1 warning generated. 01:37:48 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 01:37:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:49 INFO - Successfully installed psutil 01:37:49 INFO - Cleaning up... 01:37:49 INFO - Return code: 0 01:37:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:49 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 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:37:49 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 01:37:49 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 01:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:49 INFO - 'HOME': '/Users/cltbld', 01:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:49 INFO - 'LOGNAME': 'cltbld', 01:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:49 INFO - 'MOZ_NO_REMOTE': '1', 01:37:49 INFO - 'NO_EM_RESTART': '1', 01:37:49 INFO - 'PAGER': '/bin/cat', 01:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:49 INFO - 'PWD': '/builds/slave/test', 01:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:49 INFO - 'SHELL': '/bin/bash', 01:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:37:49 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:49 INFO - 'USER': 'cltbld', 01:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:49 INFO - 'XPC_FLAGS': '0x0', 01:37:49 INFO - 'XPC_SERVICE_NAME': '0', 01:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:37:49 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 01:37:49 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 01:37:49 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 01:37:49 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 01:37:49 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 01:37:49 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 01:37:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:37:51 INFO - Installing collected packages: mozsystemmonitor 01:37:51 INFO - Running setup.py install for mozsystemmonitor 01:37:52 INFO - Successfully installed mozsystemmonitor 01:37:52 INFO - Cleaning up... 01:37:52 INFO - Return code: 0 01:37:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:37:52 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')]} 01:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:52 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')]} 01:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:52 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 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:37:52 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 01:37:52 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 01:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:52 INFO - 'HOME': '/Users/cltbld', 01:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:52 INFO - 'LOGNAME': 'cltbld', 01:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:52 INFO - 'MOZ_NO_REMOTE': '1', 01:37:52 INFO - 'NO_EM_RESTART': '1', 01:37:52 INFO - 'PAGER': '/bin/cat', 01:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:52 INFO - 'PWD': '/builds/slave/test', 01:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:52 INFO - 'SHELL': '/bin/bash', 01:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:37:52 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:52 INFO - 'USER': 'cltbld', 01:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:52 INFO - 'XPC_FLAGS': '0x0', 01:37:52 INFO - 'XPC_SERVICE_NAME': '0', 01:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:52 INFO - Downloading/unpacking blobuploader==1.2.4 01:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:54 INFO - Downloading blobuploader-1.2.4.tar.gz 01:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:37:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:37:54 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 01:37:54 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 01:37:54 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 01:37:54 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 01:37:54 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 01:37:54 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 01:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:37:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:56 INFO - Downloading docopt-0.6.1.tar.gz 01:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:37:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:37:56 INFO - Running setup.py install for blobuploader 01:37:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:37:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:37:56 INFO - Running setup.py install for requests 01:37:56 INFO - Running setup.py install for docopt 01:37:56 INFO - Successfully installed blobuploader requests docopt 01:37:56 INFO - Cleaning up... 01:37:57 INFO - Return code: 0 01:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:57 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')]} 01:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:57 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')]} 01:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:57 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 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:37:57 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 01:37:57 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 01:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:57 INFO - 'HOME': '/Users/cltbld', 01:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:57 INFO - 'LOGNAME': 'cltbld', 01:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:57 INFO - 'MOZ_NO_REMOTE': '1', 01:37:57 INFO - 'NO_EM_RESTART': '1', 01:37:57 INFO - 'PAGER': '/bin/cat', 01:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:57 INFO - 'PWD': '/builds/slave/test', 01:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:57 INFO - 'SHELL': '/bin/bash', 01:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:37:57 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:57 INFO - 'USER': 'cltbld', 01:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:57 INFO - 'XPC_FLAGS': '0x0', 01:37:57 INFO - 'XPC_SERVICE_NAME': '0', 01:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-feD8KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Tq3jWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-QMMMy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-KgoATr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-2IsFXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-mTpgaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-rPzl1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6gnt8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-APjBun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-rPS2RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-MT0YFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6kaLAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-jEdyMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-zY2Sjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-vCXkcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-o7PTzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-OphTZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:37:59 INFO - Running setup.py install for manifestparser 01:37:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:37:59 INFO - Running setup.py install for mozcrash 01:37:59 INFO - Running setup.py install for mozdebug 01:37:59 INFO - Running setup.py install for mozdevice 01:37:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:37:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:37:59 INFO - Running setup.py install for mozfile 01:37:59 INFO - Running setup.py install for mozhttpd 01:37:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:37:59 INFO - Running setup.py install for mozinfo 01:38:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for mozInstall 01:38:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for mozleak 01:38:00 INFO - Running setup.py install for mozlog 01:38:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for moznetwork 01:38:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for mozprocess 01:38:00 INFO - Running setup.py install for mozprofile 01:38:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for mozrunner 01:38:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Running setup.py install for mozscreenshot 01:38:01 INFO - Running setup.py install for moztest 01:38:01 INFO - Running setup.py install for mozversion 01:38:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:38:01 INFO - Cleaning up... 01:38:01 INFO - Return code: 0 01:38:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:01 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')]} 01:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:01 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')]} 01:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:01 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 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:38:01 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 01:38:01 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 01:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:01 INFO - 'HOME': '/Users/cltbld', 01:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:01 INFO - 'LOGNAME': 'cltbld', 01:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:01 INFO - 'MOZ_NO_REMOTE': '1', 01:38:01 INFO - 'NO_EM_RESTART': '1', 01:38:01 INFO - 'PAGER': '/bin/cat', 01:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:01 INFO - 'PWD': '/builds/slave/test', 01:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:01 INFO - 'SHELL': '/bin/bash', 01:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:38:01 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:01 INFO - 'USER': 'cltbld', 01:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:01 INFO - 'XPC_FLAGS': '0x0', 01:38:01 INFO - 'XPC_SERVICE_NAME': '0', 01:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:01 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-hfb_Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:01 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)) 01:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:01 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-laPhNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-EZEXTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-ia2FZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-neU4Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-z3RmpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-igiux0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-2ZwGO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Hoc0QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-rHa3Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:02 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)) 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:02 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-0BILD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:03 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)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:03 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-BdDf4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:03 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)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:03 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6lfzmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:03 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)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:03 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-fVRCco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:03 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)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:03 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-fesu9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:03 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)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:03 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Y8Bb8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:03 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)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:03 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-UW2C7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:03 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)) 01:38:03 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)) 01:38:03 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)) 01:38:03 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)) 01:38:03 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)) 01:38:03 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)) 01:38:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:06 INFO - Downloading blessings-1.6.tar.gz 01:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:38:06 INFO - Installing collected packages: blessings 01:38:06 INFO - Running setup.py install for blessings 01:38:06 INFO - Successfully installed blessings 01:38:06 INFO - Cleaning up... 01:38:06 INFO - Return code: 0 01:38:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:38:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:06 INFO - Reading from file tmpfile_stdout 01:38:06 INFO - Current package versions: 01:38:06 INFO - blessings == 1.6 01:38:06 INFO - blobuploader == 1.2.4 01:38:06 INFO - docopt == 0.6.1 01:38:06 INFO - manifestparser == 1.1 01:38:06 INFO - mozInstall == 1.12 01:38:06 INFO - mozcrash == 0.17 01:38:06 INFO - mozdebug == 0.1 01:38:06 INFO - mozdevice == 0.48 01:38:06 INFO - mozfile == 1.2 01:38:06 INFO - mozhttpd == 0.7 01:38:06 INFO - mozinfo == 0.9 01:38:06 INFO - mozleak == 0.1 01:38:06 INFO - mozlog == 3.1 01:38:06 INFO - moznetwork == 0.27 01:38:06 INFO - mozprocess == 0.22 01:38:06 INFO - mozprofile == 0.28 01:38:06 INFO - mozrunner == 6.11 01:38:06 INFO - mozscreenshot == 0.1 01:38:06 INFO - mozsystemmonitor == 0.0 01:38:06 INFO - moztest == 0.7 01:38:06 INFO - mozversion == 1.4 01:38:06 INFO - psutil == 3.1.1 01:38:06 INFO - requests == 1.2.3 01:38:06 INFO - wsgiref == 0.1.2 01:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:06 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 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:38:06 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 01:38:06 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 01:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:06 INFO - 'HOME': '/Users/cltbld', 01:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:06 INFO - 'LOGNAME': 'cltbld', 01:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:06 INFO - 'MOZ_NO_REMOTE': '1', 01:38:06 INFO - 'NO_EM_RESTART': '1', 01:38:06 INFO - 'PAGER': '/bin/cat', 01:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:06 INFO - 'PWD': '/builds/slave/test', 01:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:06 INFO - 'SHELL': '/bin/bash', 01:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:38:06 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:06 INFO - 'USER': 'cltbld', 01:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:06 INFO - 'XPC_FLAGS': '0x0', 01:38:06 INFO - 'XPC_SERVICE_NAME': '0', 01:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 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)) 01:38:06 INFO - Cleaning up... 01:38:06 INFO - Return code: 0 01:38:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:38: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', 'jsonschema'] in /builds/slave/test/build 01:38: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 jsonschema 01:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:07 INFO - 'HOME': '/Users/cltbld', 01:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:07 INFO - 'LOGNAME': 'cltbld', 01:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:07 INFO - 'MOZ_NO_REMOTE': '1', 01:38:07 INFO - 'NO_EM_RESTART': '1', 01:38:07 INFO - 'PAGER': '/bin/cat', 01:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:07 INFO - 'PWD': '/builds/slave/test', 01:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:07 INFO - 'SHELL': '/bin/bash', 01:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:38:07 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:07 INFO - 'USER': 'cltbld', 01:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:07 INFO - 'XPC_FLAGS': '0x0', 01:38:07 INFO - 'XPC_SERVICE_NAME': '0', 01:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:07 INFO - Downloading/unpacking jsonschema 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:38:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:10 INFO - Downloading functools32-3.2.3-2.tar.gz 01:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:38:10 INFO - warning: no files found matching '*.txt' 01:38:10 INFO - no previously-included directories found matching 'build' 01:38:10 INFO - no previously-included directories found matching 'dist' 01:38:10 INFO - no previously-included directories found matching '.git*' 01:38:10 INFO - Installing collected packages: jsonschema, functools32 01:38:10 INFO - Running setup.py install for functools32 01:38:10 INFO - warning: no files found matching '*.txt' 01:38:10 INFO - no previously-included directories found matching 'build' 01:38:10 INFO - no previously-included directories found matching 'dist' 01:38:10 INFO - no previously-included directories found matching '.git*' 01:38:10 INFO - Successfully installed jsonschema functools32 01:38:10 INFO - Cleaning up... 01:38:10 INFO - Return code: 0 01:38:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103749a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103759420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035da980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, '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.3D9n5sgAwE/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.pnA3onCLrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 01:38: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', 'flake8'] in /builds/slave/test/build 01:38: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 flake8 01:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:10 INFO - 'HOME': '/Users/cltbld', 01:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:10 INFO - 'LOGNAME': 'cltbld', 01:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:10 INFO - 'MOZ_NO_REMOTE': '1', 01:38:10 INFO - 'NO_EM_RESTART': '1', 01:38:10 INFO - 'PAGER': '/bin/cat', 01:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:10 INFO - 'PWD': '/builds/slave/test', 01:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:10 INFO - 'SHELL': '/bin/bash', 01:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:38:10 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:10 INFO - 'USER': 'cltbld', 01:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:10 INFO - 'XPC_FLAGS': '0x0', 01:38:10 INFO - 'XPC_SERVICE_NAME': '0', 01:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:10 INFO - Downloading/unpacking flake8 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:38:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:38:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:14 INFO - no previously-included directories found matching 'docs/_build' 01:38:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:38:14 INFO - Running setup.py install for pep8 01:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:14 INFO - no previously-included directories found matching 'docs/_build' 01:38:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:38:14 INFO - Cleaning up... 01:38:14 INFO - Return code: 0 01:38:14 INFO - Running post-action listener: _resource_record_post_action 01:38:14 INFO - Running post-action listener: _start_resource_monitoring 01:38:14 INFO - Starting resource monitoring. 01:38:14 INFO - ##### 01:38:14 INFO - ##### Running install step. 01:38:14 INFO - ##### 01:38:14 INFO - Running pre-action listener: _resource_record_pre_action 01:38:14 INFO - Running main action method: install 01:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:14 INFO - Reading from file tmpfile_stdout 01:38:14 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:15 INFO - Reading from file tmpfile_stdout 01:38:15 INFO - Output received: 01:38:15 INFO - Usage: mozinstall [options] installer 01:38:15 INFO - Options: 01:38:15 INFO - -h, --help show this help message and exit 01:38:15 INFO - -d DEST, --destination=DEST 01:38:15 INFO - Directory to install application into. [default: 01:38:15 INFO - "/builds/slave/test"] 01:38:15 INFO - --app=APP Application being installed. [default: firefox] 01:38:15 INFO - mkdir: /builds/slave/test/build/application 01:38:15 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'] 01:38:15 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 01:38:36 INFO - Reading from file tmpfile_stdout 01:38:36 INFO - Output received: 01:38:36 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:38:36 INFO - Running post-action listener: _resource_record_post_action 01:38:36 INFO - ##### 01:38:36 INFO - ##### Running run-tests step. 01:38:36 INFO - ##### 01:38:36 INFO - Running pre-action listener: _resource_record_pre_action 01:38:36 INFO - Running main action method: run_tests 01:38:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:36 INFO - 2016-06-07 01:38:36.792 screenresolution[1645:7543] starting screenresolution argv=screenresolution get 01:38:36 INFO - 2016-06-07 01:38:36.794 screenresolution[1645:7543] Display 0: 1600x1200x32@60 01:38:36 INFO - 2016-06-07 01:38:36.800 screenresolution[1646:7545] starting screenresolution argv=screenresolution list 01:38:36 INFO - Available Modes on Display 0 01:38:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:37 INFO - Intel Iris: 01:38:37 INFO - Chipset Model: Intel Iris 01:38:37 INFO - Type: GPU 01:38:37 INFO - Bus: Built-In 01:38:37 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:37 INFO - Vendor: Intel (0x8086) 01:38:37 INFO - Device ID: 0x0a2e 01:38:37 INFO - Revision ID: 0x0009 01:38:37 INFO - Displays: 01:38:37 INFO - Display: 01:38:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:37 INFO - Display Serial Number: 1600x1200 60 01:38:37 INFO - Main Display: Yes 01:38:37 INFO - Mirror: Off 01:38:37 INFO - Online: Yes 01:38:37 INFO - Rotation: Supported 01:38:37 INFO - Return code: 0 01:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:37 INFO - Python 2.7.3 01:38:37 INFO - Return code: 0 01:38:37 INFO - grabbing minidump binary from tooltool 01:38:37 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')]} 01:38:37 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 0x1035e8e00>, '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 0x103451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:37 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 01:38:37 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 01:38:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:37 INFO - Return code: 0 01:38:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:38:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:38:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:38:38 INFO - Return code: 0 01:38:38 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/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 01:38:38 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/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0306 --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 01:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3D9n5sgAwE/Render', 01:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:38 INFO - 'HOME': '/Users/cltbld', 01:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:38 INFO - 'LOGNAME': 'cltbld', 01:38:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:38 INFO - 'MOZ_NO_REMOTE': '1', 01:38:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:38 INFO - 'NO_EM_RESTART': '1', 01:38:38 INFO - 'PAGER': '/bin/cat', 01:38:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:38 INFO - 'PWD': '/builds/slave/test', 01:38:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:38 INFO - 'SHELL': '/bin/bash', 01:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pnA3onCLrR/Listeners', 01:38:38 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 01:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:38 INFO - 'USER': 'cltbld', 01:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:38 INFO - 'XPC_FLAGS': '0x0', 01:38:38 INFO - 'XPC_SERVICE_NAME': '0', 01:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:38 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/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 01:38:38 INFO - mozversion application_buildid: 20160606120332 01:38:38 INFO - mozversion application_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:38 INFO - mozversion application_display_name: Firefox 01:38:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:38 INFO - mozversion application_name: Firefox 01:38:38 INFO - mozversion application_remotingname: firefox 01:38:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:38 INFO - mozversion application_vendor: Mozilla 01:38:38 INFO - mozversion application_version: 48.0 01:38:38 INFO - mozversion platform_buildid: 20160606120332 01:38:38 INFO - mozversion platform_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:38 INFO - mozversion platform_version: 48.0 01:38:38 INFO - using testdate: 1465288718 01:38:38 INFO - actual date: 1465288718 01:38:38 INFO - starting webserver on 'localhost:49274' 01:38:38 INFO - SUITE-START | Running 2 tests 01:38:38 INFO - TEST-START | dromaeo_css 01:38:38 INFO - operating with platform_type : mac_ 01:38:38 INFO - Initialising browser for dromaeo_css test... 01:38:38 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpXAwofy/profile http://localhost:49274/getInfo.html) 01:38:41 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 01:38:41 INFO - PROCESS | 1664 | colorDepth:24 01:38:41 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 01:38:41 INFO - PROCESS | 1664 | __metrics 01:38:41 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:38:42 INFO - TEST-INFO | 1664: exit 0 01:38:42 INFO - Browser initialized. 01:38:42 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:42 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpXAwofy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:54 INFO - PROCESS | 1668 | RSS: Main: 170536960 01:38:54 INFO - PROCESS | 1668 | 01:39:43 INFO - PROCESS | 1668 | 1465288783684 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] 01:41:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 01:41:55 INFO - PROCESS | 1668 | RSS: Main: 181805056 01:41:55 INFO - PROCESS | 1668 | 01:44:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 01:44:58 INFO - PROCESS | 1668 | RSS: Main: 192217088 01:44:58 INFO - PROCESS | 1668 | 01:48:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 01:48:00 INFO - PROCESS | 1668 | RSS: Main: 194232320 01:48:00 INFO - PROCESS | 1668 | 01:51:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 01:51:02 INFO - PROCESS | 1668 | RSS: Main: 198094848 01:51:02 INFO - PROCESS | 1668 | 01:54:05 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 01:54:06 INFO - PROCESS | 1668 | RSS: Main: 197451776 01:54:06 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 01:57:08 INFO - PROCESS | 1668 | RSS: Main: 202633216 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | __start_tp_report 01:57:08 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 01:57:08 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 01:57:08 INFO - PROCESS | 1668 | |i|pagename|runs| 01:57:08 INFO - PROCESS | 1668 | |0;dojo.html;3494.388482015647;3641.198936234028;3655.6709896109346;3684.2631473705264;3704.2591481703666;6044.425779550947;6072.483838873695;6072.969635151829;6077.665728384937;6081.969590152049;5909.2022576952095;6026.75892964282;6030;6058.394160583939;6067.211262535864;5378.946210537883;5417.187421886709;5446.2647542581835;5458.918116228259;5541.33503979523;5299.5760339172775;5412.621116521845;5490.396056433789;5499.835004949858;5583.190437386576;5468.945310546903;5499.917501237464;5502.2296878437055;5506.201600767887;5524.06090964535;5121.308623335858;5155.556444195631;5438.293021907166;5449.754761035763;5578;4688.7186768793645;5021.39743230811;5245.160774276097;5289.153735402318;5415.918761218585;5265.236540701615;5800.390958949291;5828.921649494815;5843.590948633598;6006.039033754579;6127.739336776387;6302.960011598081;6309;6309.968450157766;6317.93682063178;6342.841428964267;6374.171357723512;6433.195850518685;6438.935610643881;6449.709763060627;6021.458068773788;6074.817755467343;6095.969520152371;6110.725017374229;6115;6337.366263373626;6446.258680251831;6492.577982431127;6495.967520162463;6532.444742196966;6225.968870155621;6275.96862015687;6300.243970723543;6318.147050148263;6342.112104305401;6317;6317.6209427434505;6340.175777148941;6341.23905131378;6355.745770169141;6215.751369945242;6236.220472440945;6275.6862156891975;6285.402886725754;6314.873702525923;6296.150019747367;6313.589616674902;6324.6521441321165;6336.524760642878;6337.397947195009;5078.771455284447;5108.412532558729;5111.923321150186;5134.2812006319145;5135.845924622267;3847.249786291646;4480.260756975128;4548.88627784308;4646.09401166776;4647.419072615923;6026.035834266497;6045.535474501953;6079.118527813443;6146.985747351637;6207.81376558704;6432.485401167895;6436.098946147543;6444.097826304321;6446.387593178641;6460.127882735865;5973.342932277446;6114.755409783559;6190.628562286277;6205.627662340274;6206.317305096436;5590.301212348457;5609.354924183689;5637.210790489335;5656.85857853557;5676.659400435987;5521.503064724194;6610.140681711443;6614.239362473281;6650.667466626649;6657.101291325609;6221.688915554295;6365.7135428904885;6409.262934762562;6421.967890160519;6451.741930322734;6658.800235992928;6668.06647069401;6678.933210668026;6690.531662783558;6700.162479690039;6323.051542268697;6341.175647165839;6357.427831495188;6373.458256048288;6374.266959299554;5554.305711786027;6117.908231376444;6220.129181914445;6300.936990630035;6343.397377249154;6146.938530614815;6245.18812554365;6273.3099359071375;6285.088662143872;6298.71655775482;6173.197484327009;6210.658413787104;6243.750249990131;6289.685515724287;6297.874042519033;4572.79422425985;6127.494965204967;6140.385961403824;6217.813465596039;6432.388923052303;6271.874562508816;6274.372562743689;6274.466670333073;6290.748370065146;6315.2948703850625;5181.870453238699;6098.0852872069545;6212.161358216764;6251.187345645037;6280.403361680633 01:57:08 INFO - PROCESS | 1668 | |1;ext.html;560.5403569073359;563.6956043736383;577.0909682797264;608.0301918440086;611.1413464082965;38449;39181.60818391815;39695;39695.60304396955;39843.40234896475;40255.39616905749;40739;41111.58888411115;41692.166156676845;41733.37399939003;9703.514824258777;9895.960924102974;9923.156531694814;9931.453770042644;9941.204703623693;8555.786105347353;9737.07497787709;9906.801863962752;9912.306138570302;10003.74990625233;9872.308938374317;9886.406815591052;9972.252081093911;10068.69793906184;10073.44596047217;9906.702798915972;9932.404055756642;9997.15024222942;10005.399676019462;10035.147012503947;9818.45998470084;9821.459819709913;9874.456904870229;9921.65274215399;9966.80066398668;33172.50241246359;33518.83240583781;39615.405768913486;39699.20601587952;40333.79833100845;3172.888948886778;3329.500574913758;3360.5127256547908;3364.444866597033;3553.626869178725;26328.86835565829;26387.34031649205;26989.785459654362;27207.911683532635;27512.862435687894;1957.3442896629647;2460.692413448319;2558.334832943448;2560.9871950640313;2606.1139212667595;314001;314817.99999999773;315032;316854;317238.4138079295;34759.30481390358;34995.475067874;34995.65004349975;37097;37898.62101379006;35739.4639080414;36332.63667363292;36591.63408365935;36626.81686591604;36774.44838327427;16373.263203155886;16488.752668709978;16569.751453728204;16724.581885452717;16733.665326693397;13879.097858639156;14081.929590352187;14202.715945681028;14292.642683932776;14402.279886005657;8348.290395316344;8387.245147936594;8471.576421178916;8526.957365213135;8539.231469167804;3092.412441636127;3547.802175905627;3576.1059735066233;3629.9818500907327;3649.0694872807794;852.2627926843236;1033.5968972100886;1095.895889890459;1117.279354816139;1228.8402507674125;30834.69165308318;30878.845605772276;30986.380272394876;31228.687713123032;31282.687173128434;1191.845060142176;1231.396615658321;1235.5984305100878;1246.8628450870397;1255.2280347586168;15712.29294681742;15785.68428631421;15929.283182256826;16006.359745610278;16151.11168885699;618754;619427;622594;624475;625132;61691;61865.38134618596;62147;62257.68871155706;62552;1531.3109100904637;1544.559800456842;1559.5555266748922;1564.0850102689826;1570.8350623184401;29686.703132968392;29694.257643559085;30089.097327080224;30737.38525229438;30956.69043309538;52227;52567.211491826885;52572.73713631407;52982.94034119219;53129.46870531245;547142;547786;548185;548365;550718;26113.73886261113;26598.734012659625;27183.184504464898;27399;27477.72522274752;39897;45432.09135817331;48221.03557928892;48384;48486.75756621194;38236.808815955745;38768;39023.609763902;39027.41458878062;39037.804810975766;37283.44074838934;38312.616873830906;38473.038174045876;38877;39334.80332598433;32159.839200803846;33391.66608333983;38335.80832095822;38418.80790596141;38615.2276954465;29550;31063;31321.06036818899;31641.8417907909;31769.682303177597;20009.6998545019;24311.392215194763;24341;24526.509469810146;24550.263492095266 01:57:08 INFO - PROCESS | 1668 | |2;jquery.html;369.8982779735571;422.5626476596721;426.3604593110334;431.9956800431996;433.7462584388133;18351.724724129148;20472;20541.07565159568;21267.893660531696;21433.464163395885;21438.464038399008;21793.67309490359;21980.450488737788;22099.558008839813;22544.985475653593;5859.501942334896;6307;6376.202974628171;6383.106365108865;6392.232932048138;6131.662758548278;6214.502839772807;6256.874862502747;6316.74733010679;6355.618662880219;6285.308616052231;6335.334789847069;6346.682665866711;6365.2998170201245;6398.328175541571;6102.202907238142;6303.653299068549;6342.0803983422375;6357.809265722012;6363.331850155736;5440.292761940922;5535.6955367454775;5561.694106824123;5566.526845218162;5567.109262518018;22379.888100559394;26894;27134.86432567844;27286.45427091467;27782.722172778416;2067.927622533219;2193.9451513712283;2332.3586013846157;2349.424391024193;2883.700650071363;10163.542640581192;10183.28716989811;10449.68650940473;10459.477026148663;10493.9475302623;1782.7949785774672;1786.6605344984541;1818.9181486833124;1835.3392778599693;1865.8693891427606;117131;118753;125193.37403313017;125265;126006.3699681505;12038.39808009596;12119.939400303118;12248.203866748632;12250.44872980718;12330.568430105082;13888.236147011808;14907.478238261609;15413.537593871977;15723.842761572467;15752.921235393978;9223.769405764775;9428.198603118812;9480.431174129575;9523.476208808443;9616.990216027216;9537.570809313598;9627.133557979816;9632.518374081268;9706.805863882682;9707.66023189199;4781.808727650925;4797.544233297831;4839.879003024953;4868.659193856467;4905.386826646669;1769;1837.3844762004878;2014.113789932425;2082.3961051294955;2123.193186589117;901.5086777706166;995.8605795188535;1006.4263369879098;1019.2966852871494;1039.030635029327;17186.226619801888;20263;20685.58628827445;21687.132514699235;21702.674459883114;1041.630221271453;1044.7492601775518;1077.0360527327998;1093.278436232083;1101.493313075994;9316;10907.454627268606;11391.373474458984;11423.942880285545;11434.885651143382;603110;613044;619701;624164;626641;119339;123281;129404.3529782345;129531;131556;1042.3641578637025;1057.5558265528496;1059.2955684469896;1060.3372891942536;1085.4247248957906;18439.53901152482;18826.905865470584;19038.524036898634;19058.237670493025;19259.711104333164;42717.78641106775;51576.74211628918;54563.727181363836;54769;55210.723946380014;68960.3103968954;71259;72737;75326;77524.44951100834;7909.090454597795;7927.762167134995;8111.797205069921;8148.429609927485;8355.916440835514;7541.585212813348;12410.255384676948;12631.557895473614;12960.222386656831;12979.091463597457;5300.867478313073;6009;7117.110361204849;7383.187849336676;11290.887091129312;11062.889371106186;11069.446527673745;11136.721581960192;11140.387278699425;11293.71765705831;11277.154213434189;11519.481623326803;11682.70793230176;11799.35103569312;11878.346690931736;8227.465214761021;8244.258016778518;8297.751067467985;8331.16688331162;8594.011688655635;11239.213255072067;11431.714207144887;11469.254498457574;11505;11554.942225289156 01:57:08 INFO - PROCESS | 1668 | |3;mootools.html;1631.9437508738988;1642.359479802877;1930.0928563575123;2017.848661350398;2070.254708305009;8356.83286334273;8828.249598784096;9098.909010909889;9281.721548353551;9286.117818807219;7433.5911524866115;8950.14973577509;9053.45679259245;9072.72781816545;9081.18269355758;2446.657467954488;2527.1155095716535;2554.9361265968405;2559.5392829290813;2578.9097381591646;2156.9352919412445;2451.019592163131;2514.2959971208;2557.5268575313626;2563.3976015636313;2102.7897210279;2520.974790252092;2522.8738563071865;2534.974650253492;2536.251805717318;2082.6980087887246;2490.2155820916355;2505.473850491399;2546.2743118211406;2550.081970490622;2205.6986378036877;2472.344828620417;2499.487605040962;2513.434477242624;2533.442642618621;9045.819083618357;9204.953975230148;9234.261259099256;9274.582643781046;9290.210332121778;5583.162525621149;5626.12795016769;5687.260656114679;5757.769689212427;5778.017736984681;3621.746477746559;3667.2298817248143;3699.667029967316;3706.129059670975;3749.531308586427;1049.2445439283704;1059.4596755654595;1065.9733506662317;1074.4466599701161;1074.5272080284728;12022.63932082039;12028.45871935765;12111.939440302831;12482.126251162423;12486.813752693388;4932.654714170046;4969.18008528596;5043.52086551777;5076.340075790124;5087.516685914832;10496.370217786956;10558.788824223473;10566.418846963337;10587.364758114383;10618.415987120783;5597;5689.146628005749;5693.914591281134;5719.7140142992685;5750.913736293959;4638.165130276515;5034.572061374751;5094.77073531692;5148.304978827885;5183.740812959412;3615.638436156416;4207.600277973587;4250.936235956463;4325.76208308546;4341.08837144197;1391.7216556688702;1417.8015077889104;1420.0627585793534;1420.1479112532397;1428.3358238419185;871.3421366868101;885.3846576629181;903.1510380242551;928.4800511713462;929.6792606550729;6123.6221850083375;6164.3835616438;6164.599301045418;6278.968605156945;6316.463100636405;959.5010594490826;1021.4739409204266;1031.6750223679517;1044.0916402729674;1058.7406085509099;4082.4896887889013;4115.8765237042935;4128.38074288853;4141.91716165675;4147.668186545069;11084.667459976052;11158.944205279084;11230.3261804292;11399.886001140048;11426.771464570662;10846.566137354575;10885.292455990335;10895.237333386745;10900.182486313399;11177.385243811668;8357;8640.956795215983;8643.308535317285;8729.345299102593;8767.868481972775;4962.255661650637;5331.733413329395;5746.798862039808;5982.312034116132;6146.231721034871;9446.055394460498;9489.857652135086;9518.286128540525;9563;9582.281328900499;9179.449233046038;9803.460809655253;9823.901760982299;9854.802903942025;10173.745656358651;6982.231954485104;7074.186468556182;7551.169371369255;7557.962210188914;7659.846803063796;8319.625616847377;8330.333573314;8338.04112527067;8341.499510029418;8382.790430239293;7274.454415918933;7436.814079647836;7497.9250207497225;7522.059742532184;7587.62061896914;7426.108866936002;7458.627068646438;7548;7570.280823321776;7597.354224890946;7228.277172282729;7237.3486386225495;7290;7292.015577896916;7300.342969132804;4990.725510096834;5115.590752739847;5177.8187763428095;5211.791528338824;5250.894982100413;5051.2423136529815;5099.36257967754;5100.974495127501;5116.513931176532;5139.203423469368 01:57:08 INFO - PROCESS | 1668 | |4;prototype.html;331.65176564607157;336.14271322210493;336.8349508740717;342.65734265734267;345.3179969560118;5992.861356342292;6704.128463299777;6790.864182716343;6847.657617119143;6864.244933057366;5927.288725352963;6850.246472887979;6894.1037665103595;6902.689378977945;6910.686969475796;5028.7988480460735;5052.242163675451;5057.974710126444;5059.595232381401;5075.796968121271;5061.038402703493;5071.087204303224;5073.467285934979;5091.694498330094;5101.15830887903;4977.875553111183;4985.102681517325;4986.227134794112;5035.874103147414;5043.067032598981;4268;4696.201645720202;4705.623550116;4897.069556784199;4990.1516742153735;3564.928701425983;4135.60711732385;4150.439690641755;4185.518665353462;4188.246115699173;5423.647462914937;5602.187682786014;6331.715072821734;6416.45460135889;6427.646479443629;5844.707764611752;5853.5902486825935;5862.794802181946;5898.7640494380175;5953.255843019622;7306.4154867611;7318.15841178266;7331.78004659861;7335.559866408033;7367.410607151415;4493.123840851035;4648.1865673507;4675.906481870377;4680.812767489297;4702.976485117552;6320.399562041599;7664.271894170045;7711.344535714471;7712.383009359181;7727.961360193163;4712.340272361872;4716.198246298138;4726.314684370747;4729.337892695025;4729.95270047302;4803.951960480351;4811.975940120277;4820.39745031871;4821.083244636944;4830.396200474941;5802.158686990363;5826.300843898759;5841.182234487175;5842.298924129132;5861.824145275563;7073.469489788184;7145.570885822856;7344.559326440324;7386.852262954818;7394.334509894135;1446.7323545144181;1660.2528862012143;1671.6489537197324;1673.397576872325;1680.2690829488968;996.7009897030862;1035.99482002591;1037.7509397744486;1058.1059902773948;1058.5501162006117;5732.283464566929;6839.829004274933;6999.930000700029;7079.504434689626;7083.6458177090935;6179.660118693425;6566.343365663395;7730.1110372306775;7738.380929525624;7763.883541746878;6279.7488100476385;7022.08712867324;7032.05067315916;7036.683349249296;7087.369904921897;3059.0211132437407;3466.3933811582874;3631.9818400907825;3932.5953550780337;4067.3695577185586;7938;8050.919490805017;8052.194780522018;8052.59737013147;8058.516489010678;7925.167857374892;7984.520928744294;7991.520508769492;7992.720254791055;8022.839543209103;8051.154628764012;8077.676892924217;8088.636011379502;8093.231143041402;8100.918990810016;7471.813204669927;7709.306162445407;7735.6905723770415;7735.922640773745;7765.961170194339;6448.193975753031;7218;7566.924330756622;7600.42996775233;7619.809504762426;6470.741170353133;8027.799305017421;8040.5979701015885;8043.758687239392;8076.596170191585;3929.80350982444;4318.805653745651;4448.665400379938;4805.303231031551;4815.012922350979;7442.702291908263;7561.168271490242;7596.430267729832;7695.2304769524835;7738.032745906762;5503.504684578407;7363.668634911549;7385.667644956097;7394.630268486661;7425.071866016748;7368.852622947618;7395.741149059757;7396.519226250277;7420.443466740124;7471.476996610402;7160.212376638669;7224.8916266255;7230.023946767119;7269.854602908018;7315.926840731738;7256.7460138894885;7429.702811887464;7470.663820127998;7491.513051651626;7515.323620873929;7028.578285302899;7137.750178743719;7260.056192695127;7302.306280903305;7336.266373362621 01:57:08 INFO - PROCESS | 1668 | |5;yui.html;715.5635062611806;717.8205448637841;719.9352058314751;727.894455303981;765.1659690936877;15205.4678086267;15246.313915873785;15573.22133893305;15837.604059898495;15872.365105395786;14482.782758258634;14730.558083257492;14895.031822931502;14919.850801491983;14935.551933442013;784.0747917457398;925.453982150531;931.16660588773;947.4978261521404;975.4878688688424;950.8906475755308;974.5078735238694;976.6288810252095;979.7207795778205;981.8330883749744;1026.0560284538205;1027.8920713325106;1030.1501261459289;1030.386919782728;1030.9072183503483;985.4087547471531;1021.0504231065106;1025.318163421324;1025.8563801067894;1032.4424810602266;737.6385571070191;742.0649981023895;756.043604839878;766.4673052228703;772.5480593852603;15506.61233469161;15571.766423503657;15816.841831581767;15899.523014309589;15956.76064859028;9805.509724513746;11972.10209234311;12227.082968777377;12259.448324825315;12281.324527151002;10360.948195258976;10421.062104410563;10477.895221047767;10540.9986051325;10630.468476576218;3537.7700449470703;3561.305545418644;3597.8560857565926;3603.279344131158;3667.8716244931566;87095;87690;87930;89103;89611;9994.450305233282;10002.399856008517;10013.549390277454;10065.34575252621;10100.646477373257;23973.880130599584;24045.759542404703;24384.878075609508;24414.389640259134;24441.511169776506;7812.062552493737;7819.921800782033;8115.3507719382305;8144.4298899077685;8301.8339633207;3577.2845430913403;3971.0667993021616;4016.216837716676;4159.521655009713;4178.791060446965;3087.938241235163;3775.188334508039;3812.599677033927;3854.1713531590844;3859.614038596118;687.3126873126873;706.4948561778353;714.9821254468576;731.3308322884608;762.5615271219071;456.8857785553612;503.68519675203;517.3300575754332;554.7960924793208;576.5848589015902;7074.752383666547;7323.560586364835;8363.707270245633;8371.916280837113;8515.659373624985;520.7656554550392;591.0985746736176;609.5002098279368;618.1593033474471;630.4105661206695;3875.8643447479203;3973.7814420206587;4011.5186177658866;4082.5713300103657;4202.3696445533415;81685.18314816775;84515;97321.51339243258;98766;99052;81562.59218703868;82353;82486.58756706178;82852.58573707214;84210.5789471061;71920.64039679873;72087;72624;72736.27263727401;72824.27175728281;7918;8074.515529068275;8207.425480216327;8216.178382161735;8241.134680858664;34380.82809585936;48953;50038.74980625074;51134;51804.740976294874;69181.61636767337;72771;73103.26896730965;73950.26049739434;73977.63011185125;10228.386296822215;10294.3823370595;10319.174466042849;10514.421706806199;10668.46657667098;10766.89233107659;10886.401247931122;10995;11099.5560177592;11211.159163062639;10393.116585090353;10852.782944341227;10897.128229741444;10964.068054215162;10999.670009899715;10468.63359782404;10627.893721063;10707.304025238334;10968;10985.945070274598;9702.029797020241;9924.702258932244;10096.949515252376;11316.9434152832;11938;7734.651940662796;8295.709650162215;9618.903810961801;9790.461524616214;10100.696979090639;9531.38046027006;9724.222062234863;9728.464934428674;9755.609775608897;9756.707298781048 01:57:08 INFO - PROCESS | 1668 | __end_tp_report 01:57:08 INFO - PROCESS | 1668 | __start_cc_report 01:57:08 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,392 01:57:08 INFO - PROCESS | 1668 | __end_cc_report 01:57:08 INFO - PROCESS | 1668 | __startTimestamp1465289828559__endTimestamp 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | ------- Summary: start ------- 01:57:08 INFO - PROCESS | 1668 | Number of tests: 6 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5917.30 Median:6190.63 stddev:658.60 (10.6%) stddev-sans-first:632.59 01:57:08 INFO - PROCESS | 1668 | Values: 3494.4 3641.2 3655.7 3684.3 3704.3 6044.4 6072.5 6073.0 6077.7 6082.0 5909.2 6026.8 6030.0 6058.4 6067.2 5378.9 5417.2 5446.3 5458.9 5541.3 5299.6 5412.6 5490.4 5499.8 5583.2 5468.9 5499.9 5502.2 5506.2 5524.1 5121.3 5155.6 5438.3 5449.8 5578.0 4688.7 5021.4 5245.2 5289.2 5415.9 5265.2 5800.4 5828.9 5843.6 6006.0 6127.7 6303.0 6309.0 6310.0 6317.9 6342.8 6374.2 6433.2 6438.9 6449.7 6021.5 6074.8 6096.0 6110.7 6115.0 6337.4 6446.3 6492.6 6496.0 6532.4 6226.0 6276.0 6300.2 6318.1 6342.1 6317.0 6317.6 6340.2 6341.2 6355.7 6215.8 6236.2 6275.7 6285.4 6314.9 6296.2 6313.6 6324.7 6336.5 6337.4 5078.8 5108.4 5111.9 5134.3 5135.8 3847.2 4480.3 4548.9 4646.1 4647.4 6026.0 6045.5 6079.1 6147.0 6207.8 6432.5 6436.1 6444.1 6446.4 6460.1 5973.3 6114.8 6190.6 6205.6 6206.3 5590.3 5609.4 5637.2 5656.9 5676.7 5521.5 6610.1 6614.2 6650.7 6657.1 6221.7 6365.7 6409.3 6422.0 6451.7 6658.8 6668.1 6678.9 6690.5 6700.2 6323.1 6341.2 6357.4 6373.5 6374.3 5554.3 6117.9 6220.1 6300.9 6343.4 6146.9 6245.2 6273.3 6285.1 6298.7 6173.2 6210.7 6243.8 6289.7 6297.9 4572.8 6127.5 6140.4 6217.8 6432.4 6271.9 6274.4 6274.5 6290.7 6315.3 5181.9 6098.1 6212.2 6251.2 6280.4 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:62179.48 Median:19981.31 stddev:137281.06 (687.0%) stddev-sans-first:137588.21 01:57:08 INFO - PROCESS | 1668 | Values: 560.5 563.7 577.1 608.0 611.1 38449.0 39181.6 39695.0 39695.6 39843.4 40255.4 40739.0 41111.6 41692.2 41733.4 9703.5 9896.0 9923.2 9931.5 9941.2 8555.8 9737.1 9906.8 9912.3 10003.7 9872.3 9886.4 9972.3 10068.7 10073.4 9906.7 9932.4 9997.2 10005.4 10035.1 9818.5 9821.5 9874.5 9921.7 9966.8 33172.5 33518.8 39615.4 39699.2 40333.8 3172.9 3329.5 3360.5 3364.4 3553.6 26328.9 26387.3 26989.8 27207.9 27512.9 1957.3 2460.7 2558.3 2561.0 2606.1 314001.0 314818.0 315032.0 316854.0 317238.4 34759.3 34995.5 34995.7 37097.0 37898.6 35739.5 36332.6 36591.6 36626.8 36774.4 16373.3 16488.8 16569.8 16724.6 16733.7 13879.1 14081.9 14202.7 14292.6 14402.3 8348.3 8387.2 8471.6 8527.0 8539.2 3092.4 3547.8 3576.1 3630.0 3649.1 852.3 1033.6 1095.9 1117.3 1228.8 30834.7 30878.8 30986.4 31228.7 31282.7 1191.8 1231.4 1235.6 1246.9 1255.2 15712.3 15785.7 15929.3 16006.4 16151.1 618754.0 619427.0 622594.0 624475.0 625132.0 61691.0 61865.4 62147.0 62257.7 62552.0 1531.3 1544.6 1559.6 1564.1 1570.8 29686.7 29694.3 30089.1 30737.4 30956.7 52227.0 52567.2 52572.7 52982.9 53129.5 547142.0 547786.0 548185.0 548365.0 550718.0 26113.7 26598.7 27183.2 27399.0 27477.7 39897.0 45432.1 48221.0 48384.0 48486.8 38236.8 38768.0 39023.6 39027.4 39037.8 37283.4 38312.6 38473.0 38877.0 39334.8 32159.8 33391.7 38335.8 38418.8 38615.2 29550.0 31063.0 31321.1 31641.8 31769.7 20009.7 24311.4 24341.0 24526.5 24550.3 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:35609.10 Median:12087.20 stddev:102859.20 (851.0%) stddev-sans-first:103113.71 01:57:08 INFO - PROCESS | 1668 | Values: 369.9 422.6 426.4 432.0 433.7 18351.7 20472.0 20541.1 21267.9 21433.5 21438.5 21793.7 21980.5 22099.6 22545.0 5859.5 6307.0 6376.2 6383.1 6392.2 6131.7 6214.5 6256.9 6316.7 6355.6 6285.3 6335.3 6346.7 6365.3 6398.3 6102.2 6303.7 6342.1 6357.8 6363.3 5440.3 5535.7 5561.7 5566.5 5567.1 22379.9 26894.0 27134.9 27286.5 27782.7 2067.9 2193.9 2332.4 2349.4 2883.7 10163.5 10183.3 10449.7 10459.5 10493.9 1782.8 1786.7 1818.9 1835.3 1865.9 117131.0 118753.0 125193.4 125265.0 126006.4 12038.4 12119.9 12248.2 12250.4 12330.6 13888.2 14907.5 15413.5 15723.8 15752.9 9223.8 9428.2 9480.4 9523.5 9617.0 9537.6 9627.1 9632.5 9706.8 9707.7 4781.8 4797.5 4839.9 4868.7 4905.4 1769.0 1837.4 2014.1 2082.4 2123.2 901.5 995.9 1006.4 1019.3 1039.0 17186.2 20263.0 20685.6 21687.1 21702.7 1041.6 1044.7 1077.0 1093.3 1101.5 9316.0 10907.5 11391.4 11423.9 11434.9 603110.0 613044.0 619701.0 624164.0 626641.0 119339.0 123281.0 129404.4 129531.0 131556.0 1042.4 1057.6 1059.3 1060.3 1085.4 18439.5 18826.9 19038.5 19058.2 19259.7 42717.8 51576.7 54563.7 54769.0 55210.7 68960.3 71259.0 72737.0 75326.0 77524.4 7909.1 7927.8 8111.8 8148.4 8355.9 7541.6 12410.3 12631.6 12960.2 12979.1 5300.9 6009.0 7117.1 7383.2 11290.9 11062.9 11069.4 11136.7 11140.4 11293.7 11277.2 11519.5 11682.7 11799.4 11878.3 8227.5 8244.3 8297.8 8331.2 8594.0 11239.2 11431.7 11469.3 11505.0 11554.9 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5883.64 Median:5097.07 stddev:3249.16 (63.7%) stddev-sans-first:3242.57 01:57:08 INFO - PROCESS | 1668 | Values: 1631.9 1642.4 1930.1 2017.8 2070.3 8356.8 8828.2 9098.9 9281.7 9286.1 7433.6 8950.1 9053.5 9072.7 9081.2 2446.7 2527.1 2554.9 2559.5 2578.9 2156.9 2451.0 2514.3 2557.5 2563.4 2102.8 2521.0 2522.9 2535.0 2536.3 2082.7 2490.2 2505.5 2546.3 2550.1 2205.7 2472.3 2499.5 2513.4 2533.4 9045.8 9205.0 9234.3 9274.6 9290.2 5583.2 5626.1 5687.3 5757.8 5778.0 3621.7 3667.2 3699.7 3706.1 3749.5 1049.2 1059.5 1066.0 1074.4 1074.5 12022.6 12028.5 12111.9 12482.1 12486.8 4932.7 4969.2 5043.5 5076.3 5087.5 10496.4 10558.8 10566.4 10587.4 10618.4 5597.0 5689.1 5693.9 5719.7 5750.9 4638.2 5034.6 5094.8 5148.3 5183.7 3615.6 4207.6 4250.9 4325.8 4341.1 1391.7 1417.8 1420.1 1420.1 1428.3 871.3 885.4 903.2 928.5 929.7 6123.6 6164.4 6164.6 6279.0 6316.5 959.5 1021.5 1031.7 1044.1 1058.7 4082.5 4115.9 4128.4 4141.9 4147.7 11084.7 11158.9 11230.3 11399.9 11426.8 10846.6 10885.3 10895.2 10900.2 11177.4 8357.0 8641.0 8643.3 8729.3 8767.9 4962.3 5331.7 5746.8 5982.3 6146.2 9446.1 9489.9 9518.3 9563.0 9582.3 9179.4 9803.5 9823.9 9854.8 10173.7 6982.2 7074.2 7551.2 7558.0 7659.8 8319.6 8330.3 8338.0 8341.5 8382.8 7274.5 7436.8 7497.9 7522.1 7587.6 7426.1 7458.6 7548.0 7570.3 7597.4 7228.3 7237.3 7290.0 7292.0 7300.3 4990.7 5115.6 5177.8 5211.8 5250.9 5051.2 5099.4 5101.0 5116.5 5139.2 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5940.33 Median:6815.35 stddev:1974.89 (29.0%) stddev-sans-first:1935.05 01:57:08 INFO - PROCESS | 1668 | Values: 331.7 336.1 336.8 342.7 345.3 5992.9 6704.1 6790.9 6847.7 6864.2 5927.3 6850.2 6894.1 6902.7 6910.7 5028.8 5052.2 5058.0 5059.6 5075.8 5061.0 5071.1 5073.5 5091.7 5101.2 4977.9 4985.1 4986.2 5035.9 5043.1 4268.0 4696.2 4705.6 4897.1 4990.2 3564.9 4135.6 4150.4 4185.5 4188.2 5423.6 5602.2 6331.7 6416.5 6427.6 5844.7 5853.6 5862.8 5898.8 5953.3 7306.4 7318.2 7331.8 7335.6 7367.4 4493.1 4648.2 4675.9 4680.8 4703.0 6320.4 7664.3 7711.3 7712.4 7728.0 4712.3 4716.2 4726.3 4729.3 4730.0 4804.0 4812.0 4820.4 4821.1 4830.4 5802.2 5826.3 5841.2 5842.3 5861.8 7073.5 7145.6 7344.6 7386.9 7394.3 1446.7 1660.3 1671.6 1673.4 1680.3 996.7 1036.0 1037.8 1058.1 1058.6 5732.3 6839.8 6999.9 7079.5 7083.6 6179.7 6566.3 7730.1 7738.4 7763.9 6279.7 7022.1 7032.1 7036.7 7087.4 3059.0 3466.4 3632.0 3932.6 4067.4 7938.0 8050.9 8052.2 8052.6 8058.5 7925.2 7984.5 7991.5 7992.7 8022.8 8051.2 8077.7 8088.6 8093.2 8100.9 7471.8 7709.3 7735.7 7735.9 7766.0 6448.2 7218.0 7566.9 7600.4 7619.8 6470.7 8027.8 8040.6 8043.8 8076.6 3929.8 4318.8 4448.7 4805.3 4815.0 7442.7 7561.2 7596.4 7695.2 7738.0 5503.5 7363.7 7385.7 7394.6 7425.1 7368.9 7395.7 7396.5 7420.4 7471.5 7160.2 7224.9 7230.0 7269.9 7315.9 7256.7 7429.7 7470.7 7491.5 7515.3 7028.6 7137.8 7260.1 7302.3 7336.3 01:57:08 INFO - PROCESS | 1668 | 01:57:08 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18809.01 Median:25818.84 stddev:26909.23 (104.2%) stddev-sans-first:26950.43 01:57:08 INFO - PROCESS | 1668 | Values: 715.6 717.8 719.9 727.9 765.2 15205.5 15246.3 15573.2 15837.6 15872.4 14482.8 14730.6 14895.0 14919.9 14935.6 784.1 925.5 931.2 947.5 975.5 950.9 974.5 976.6 979.7 981.8 1026.1 1027.9 1030.2 1030.4 1030.9 985.4 1021.1 1025.3 1025.9 1032.4 737.6 742.1 756.0 766.5 772.5 15506.6 15571.8 15816.8 15899.5 15956.8 9805.5 11972.1 12227.1 12259.4 12281.3 10360.9 10421.1 10477.9 10541.0 10630.5 3537.8 3561.3 3597.9 3603.3 3667.9 87095.0 87690.0 87930.0 89103.0 89611.0 9994.5 10002.4 10013.5 10065.3 10100.6 23973.9 24045.8 24384.9 24414.4 24441.5 7812.1 7819.9 8115.4 8144.4 8301.8 3577.3 3971.1 4016.2 4159.5 4178.8 3087.9 3775.2 3812.6 3854.2 3859.6 687.3 706.5 715.0 731.3 762.6 456.9 503.7 517.3 554.8 576.6 7074.8 7323.6 8363.7 8371.9 8515.7 520.8 591.1 609.5 618.2 630.4 3875.9 3973.8 4011.5 4082.6 4202.4 81685.2 84515.0 97321.5 98766.0 99052.0 81562.6 82353.0 82486.6 82852.6 84210.6 71920.6 72087.0 72624.0 72736.3 72824.3 7918.0 8074.5 8207.4 8216.2 8241.1 34380.8 48953.0 50038.7 51134.0 51804.7 69181.6 72771.0 73103.3 73950.3 73977.6 10228.4 10294.4 10319.2 10514.4 10668.5 10766.9 10886.4 10995.0 11099.6 11211.2 10393.1 10852.8 10897.1 10964.1 10999.7 10468.6 10627.9 10707.3 10968.0 10985.9 9702.0 9924.7 10096.9 11316.9 11938.0 7734.7 8295.7 9618.9 9790.5 10100.7 9531.4 9724.2 9728.5 9755.6 9756.7 01:57:08 INFO - PROCESS | 1668 | -------- Summary: end -------- 01:57:08 INFO - PROCESS | 1668 | 01:57:09 INFO - TEST-INFO | 1668: exit 0 01:57:09 INFO - TEST-OK | dromaeo_css | took 1110606ms 01:57:09 INFO - TEST-START | kraken 01:57:09 INFO - operating with platform_type : mac_ 01:57:09 INFO - Initialising browser for kraken test... 01:57:09 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpJ3TLX0/profile http://localhost:49274/getInfo.html) 01:57:11 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 01:57:11 INFO - PROCESS | 1679 | colorDepth:24 01:57:11 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 01:57:11 INFO - PROCESS | 1679 | __metrics 01:57:11 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:57:12 INFO - TEST-INFO | 1679: exit 0 01:57:12 INFO - Browser initialized. 01:57:12 INFO - Running cycle 1/1 for kraken test... 01:57:12 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpJ3TLX0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:24 INFO - PROCESS | 1683 | RSS: Main: 170848256 01:57:24 INFO - PROCESS | 1683 | 01:57:27 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:27 INFO - PROCESS | 1683 | RSS: Main: 183672832 01:57:27 INFO - PROCESS | 1683 | 01:57:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 01:57:31 INFO - PROCESS | 1683 | RSS: Main: 192212992 01:57:31 INFO - PROCESS | 1683 | 01:57:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 01:57:35 INFO - PROCESS | 1683 | RSS: Main: 195641344 01:57:35 INFO - PROCESS | 1683 | 01:57:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 01:57:37 INFO - PROCESS | 1683 | RSS: Main: 195948544 01:57:37 INFO - PROCESS | 1683 | 01:57:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:40 INFO - PROCESS | 1683 | RSS: Main: 197554176 01:57:40 INFO - PROCESS | 1683 | 01:57:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:43 INFO - PROCESS | 1683 | RSS: Main: 197791744 01:57:43 INFO - PROCESS | 1683 | 01:57:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:47 INFO - PROCESS | 1683 | RSS: Main: 197390336 01:57:47 INFO - PROCESS | 1683 | 01:57:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 01:57:50 INFO - PROCESS | 1683 | RSS: Main: 197533696 01:57:50 INFO - PROCESS | 1683 | 01:57:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:52 INFO - PROCESS | 1683 | RSS: Main: 197570560 01:57:52 INFO - PROCESS | 1683 | 01:57:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:55 INFO - PROCESS | 1683 | RSS: Main: 197685248 01:57:55 INFO - PROCESS | 1683 | 01:57:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:57:57 INFO - PROCESS | 1683 | RSS: Main: 197967872 01:57:57 INFO - PROCESS | 1683 | 01:58:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:58:01 INFO - PROCESS | 1683 | RSS: Main: 198017024 01:58:01 INFO - PROCESS | 1683 | 01:58:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:04 INFO - PROCESS | 1683 | RSS: Main: 198619136 01:58:04 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 01:58:06 INFO - PROCESS | 1683 | RSS: Main: 199831552 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | __start_tp_report 01:58:06 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 01:58:06 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 01:58:06 INFO - PROCESS | 1683 | |i|pagename|runs| 01:58:06 INFO - PROCESS | 1683 | |0;ai-astar;112;117;106;123;172;168;108;116;125;169 01:58:06 INFO - PROCESS | 1683 | |1;audio-beat-detection;151;119;143;159;119;150;130;150;200;148 01:58:06 INFO - PROCESS | 1683 | |2;audio-dft;192;194;194;194;236;269;192;193;197;194 01:58:06 INFO - PROCESS | 1683 | |3;audio-fft;65;71;72;145;57;55;56;64;119;55 01:58:06 INFO - PROCESS | 1683 | |4;audio-oscillator;79;82;122;76;81;87;122;80;78;123 01:58:06 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;90;86;108;130;91;86;88;91;89;86 01:58:06 INFO - PROCESS | 1683 | |6;imaging-darkroom;95;96;95;95;94;95;95;95;94;94 01:58:06 INFO - PROCESS | 1683 | |7;imaging-desaturate;90;92;90;90;92;90;89;93;91;89 01:58:06 INFO - PROCESS | 1683 | |8;json-parse-financial;58;61;64;64;63;65;64;79;62;58 01:58:06 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;64;67;65;70;68;69;81;56;62;65 01:58:06 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;85;80;80;82;81;82;83;80;84;83 01:58:06 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;130;144;145;127;143;149;137;133;196;170 01:58:06 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;166;169;163;159;171;166;163;166;166;163 01:58:06 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;66;75;87;60;66;71;89;100;62;85 01:58:06 INFO - PROCESS | 1683 | __end_tp_report 01:58:06 INFO - PROCESS | 1683 | __start_cc_report 01:58:06 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1054 01:58:06 INFO - PROCESS | 1683 | __end_cc_report 01:58:06 INFO - PROCESS | 1683 | __startTimestamp1465289886731__endTimestamp 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | ------- Summary: start ------- 01:58:06 INFO - PROCESS | 1683 | Number of tests: 14 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:131.60 Median:124.00 stddev:26.93 (21.7%) stddev-sans-first:27.61 01:58:06 INFO - PROCESS | 1683 | Values: 112.0 117.0 106.0 123.0 172.0 168.0 108.0 116.0 125.0 169.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:150.00 stddev:23.24 (15.5%) stddev-sans-first:24.60 01:58:06 INFO - PROCESS | 1683 | Values: 151.0 119.0 143.0 159.0 119.0 150.0 130.0 150.0 200.0 148.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:205.50 Median:194.00 stddev:26.00 (13.4%) stddev-sans-first:27.12 01:58:06 INFO - PROCESS | 1683 | Values: 192.0 194.0 194.0 194.0 236.0 269.0 192.0 193.0 197.0 194.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:75.90 Median:60.50 stddev:30.84 (51.0%) stddev-sans-first:32.46 01:58:06 INFO - PROCESS | 1683 | Values: 65.0 71.0 72.0 145.0 57.0 55.0 56.0 64.0 119.0 55.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:79.50 stddev:20.45 (25.7%) stddev-sans-first:21.05 01:58:06 INFO - PROCESS | 1683 | Values: 79.0 82.0 122.0 76.0 81.0 87.0 122.0 80.0 78.0 123.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:88.50 stddev:14.05 (15.9%) stddev-sans-first:14.81 01:58:06 INFO - PROCESS | 1683 | Values: 90.0 86.0 108.0 130.0 91.0 86.0 88.0 91.0 89.0 86.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 01:58:06 INFO - PROCESS | 1683 | Values: 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:90.50 stddev:1.35 (1.5%) stddev-sans-first:1.41 01:58:06 INFO - PROCESS | 1683 | Values: 90.0 92.0 90.0 90.0 92.0 90.0 89.0 93.0 91.0 89.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:5.88 (9.2%) stddev-sans-first:5.85 01:58:06 INFO - PROCESS | 1683 | Values: 58.0 61.0 64.0 64.0 63.0 65.0 64.0 79.0 62.0 58.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.50 stddev:6.43 (9.5%) stddev-sans-first:6.75 01:58:06 INFO - PROCESS | 1683 | Values: 64.0 67.0 65.0 70.0 68.0 69.0 81.0 56.0 62.0 65.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:1.76 (2.1%) stddev-sans-first:1.50 01:58:06 INFO - PROCESS | 1683 | Values: 85.0 80.0 80.0 82.0 81.0 82.0 83.0 80.0 84.0 83.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:144.50 stddev:20.94 (14.5%) stddev-sans-first:21.24 01:58:06 INFO - PROCESS | 1683 | Values: 130.0 144.0 145.0 127.0 143.0 149.0 137.0 133.0 196.0 170.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.00 stddev:3.39 (2.0%) stddev-sans-first:3.59 01:58:06 INFO - PROCESS | 1683 | Values: 166.0 169.0 163.0 159.0 171.0 166.0 163.0 166.0 166.0 163.0 01:58:06 INFO - PROCESS | 1683 | 01:58:06 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:73.00 stddev:13.44 (18.4%) stddev-sans-first:13.75 01:58:06 INFO - PROCESS | 1683 | Values: 66.0 75.0 87.0 60.0 66.0 71.0 89.0 100.0 62.0 85.0 01:58:06 INFO - PROCESS | 1683 | -------- Summary: end -------- 01:58:06 INFO - PROCESS | 1683 | 01:58:07 INFO - TEST-INFO | 1683: exit 0 01:58:07 INFO - TEST-OK | kraken | took 58589ms 01:58:07 INFO - SUITE-END | took 1169s 01:58:07 INFO - Completed test suite (00:19:29) 01:58:07 INFO - javascript benchmark 01:58:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3494.388482015647, 3641.198936234028, 3655.6709896109346, 3684.2631473705264, 3704.2591481703666, 6044.425779550947, 6072.483838873695, 6072.969635151829, 6077.665728384937, 6081.969590152049, 5909.2022576952095, 6026.75892964282, 6030.0, 6058.394160583939, 6067.211262535864, 5378.946210537883, 5417.187421886709, 5446.2647542581835, 5458.918116228259, 5541.33503979523, 5299.5760339172775, 5412.621116521845, 5490.396056433789, 5499.835004949858, 5583.190437386576, 5468.945310546903, 5499.917501237464, 5502.2296878437055, 5506.201600767887, 5524.06090964535, 5121.308623335858, 5155.556444195631, 5438.293021907166, 5449.754761035763, 5578.0, 4688.7186768793645, 5021.39743230811, 5245.160774276097, 5289.153735402318, 5415.918761218585, 5265.236540701615, 5800.390958949291, 5828.921649494815, 5843.590948633598, 6006.039033754579, 6127.739336776387, 6302.960011598081, 6309.0, 6309.968450157766, 6317.93682063178, 6342.841428964267, 6374.171357723512, 6433.195850518685, 6438.935610643881, 6449.709763060627, 6021.458068773788, 6074.817755467343, 6095.969520152371, 6110.725017374229, 6115.0, 6337.366263373626, 6446.258680251831, 6492.577982431127, 6495.967520162463, 6532.444742196966, 6225.968870155621, 6275.96862015687, 6300.243970723543, 6318.147050148263, 6342.112104305401, 6317.0, 6317.6209427434505, 6340.175777148941, 6341.23905131378, 6355.745770169141, 6215.751369945242, 6236.220472440945, 6275.6862156891975, 6285.402886725754, 6314.873702525923, 6296.150019747367, 6313.589616674902, 6324.6521441321165, 6336.524760642878, 6337.397947195009, 5078.771455284447, 5108.412532558729, 5111.923321150186, 5134.2812006319145, 5135.845924622267, 3847.249786291646, 4480.260756975128, 4548.88627784308, 4646.09401166776, 4647.419072615923, 6026.035834266497, 6045.535474501953, 6079.118527813443, 6146.985747351637, 6207.81376558704, 6432.485401167895, 6436.098946147543, 6444.097826304321, 6446.387593178641, 6460.127882735865, 5973.342932277446, 6114.755409783559, 6190.628562286277, 6205.627662340274, 6206.317305096436, 5590.301212348457, 5609.354924183689, 5637.210790489335, 5656.85857853557, 5676.659400435987, 5521.503064724194, 6610.140681711443, 6614.239362473281, 6650.667466626649, 6657.101291325609, 6221.688915554295, 6365.7135428904885, 6409.262934762562, 6421.967890160519, 6451.741930322734, 6658.800235992928, 6668.06647069401, 6678.933210668026, 6690.531662783558, 6700.162479690039, 6323.051542268697, 6341.175647165839, 6357.427831495188, 6373.458256048288, 6374.266959299554, 5554.305711786027, 6117.908231376444, 6220.129181914445, 6300.936990630035, 6343.397377249154, 6146.938530614815, 6245.18812554365, 6273.3099359071375, 6285.088662143872, 6298.71655775482, 6173.197484327009, 6210.658413787104, 6243.750249990131, 6289.685515724287, 6297.874042519033, 4572.79422425985, 6127.494965204967, 6140.385961403824, 6217.813465596039, 6432.388923052303, 6271.874562508816, 6274.372562743689, 6274.466670333073, 6290.748370065146, 6315.2948703850625, 5181.870453238699, 6098.0852872069545, 6212.161358216764, 6251.187345645037, 6280.403361680633], "value": 5878.063308190481, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.5403569073359, 563.6956043736383, 577.0909682797264, 608.0301918440086, 611.1413464082965, 38449.0, 39181.60818391815, 39695.0, 39695.60304396955, 39843.40234896475, 40255.39616905749, 40739.0, 41111.58888411115, 41692.166156676845, 41733.37399939003, 9703.514824258777, 9895.960924102974, 9923.156531694814, 9931.453770042644, 9941.204703623693, 8555.786105347353, 9737.07497787709, 9906.801863962752, 9912.306138570302, 10003.74990625233, 9872.308938374317, 9886.406815591052, 9972.252081093911, 10068.69793906184, 10073.44596047217, 9906.702798915972, 9932.404055756642, 9997.15024222942, 10005.399676019462, 10035.147012503947, 9818.45998470084, 9821.459819709913, 9874.456904870229, 9921.65274215399, 9966.80066398668, 33172.50241246359, 33518.83240583781, 39615.405768913486, 39699.20601587952, 40333.79833100845, 3172.888948886778, 3329.500574913758, 3360.5127256547908, 3364.444866597033, 3553.626869178725, 26328.86835565829, 26387.34031649205, 26989.785459654362, 27207.911683532635, 27512.862435687894, 1957.3442896629647, 2460.692413448319, 2558.334832943448, 2560.9871950640313, 2606.1139212667595, 314001.0, 314817.99999999773, 315032.0, 316854.0, 317238.4138079295, 34759.30481390358, 34995.475067874, 34995.65004349975, 37097.0, 37898.62101379006, 35739.4639080414, 36332.63667363292, 36591.63408365935, 36626.81686591604, 36774.44838327427, 16373.263203155886, 16488.752668709978, 16569.751453728204, 16724.581885452717, 16733.665326693397, 13879.097858639156, 14081.929590352187, 14202.715945681028, 14292.642683932776, 14402.279886005657, 8348.290395316344, 8387.245147936594, 8471.576421178916, 8526.957365213135, 8539.231469167804, 3092.412441636127, 3547.802175905627, 3576.1059735066233, 3629.9818500907327, 3649.0694872807794, 852.2627926843236, 1033.5968972100886, 1095.895889890459, 1117.279354816139, 1228.8402507674125, 30834.69165308318, 30878.845605772276, 30986.380272394876, 31228.687713123032, 31282.687173128434, 1191.845060142176, 1231.396615658321, 1235.5984305100878, 1246.8628450870397, 1255.2280347586168, 15712.29294681742, 15785.68428631421, 15929.283182256826, 16006.359745610278, 16151.11168885699, 618754.0, 619427.0, 622594.0, 624475.0, 625132.0, 61691.0, 61865.38134618596, 62147.0, 62257.68871155706, 62552.0, 1531.3109100904637, 1544.559800456842, 1559.5555266748922, 1564.0850102689826, 1570.8350623184401, 29686.703132968392, 29694.257643559085, 30089.097327080224, 30737.38525229438, 30956.69043309538, 52227.0, 52567.211491826885, 52572.73713631407, 52982.94034119219, 53129.46870531245, 547142.0, 547786.0, 548185.0, 548365.0, 550718.0, 26113.73886261113, 26598.734012659625, 27183.184504464898, 27399.0, 27477.72522274752, 39897.0, 45432.09135817331, 48221.03557928892, 48384.0, 48486.75756621194, 38236.808815955745, 38768.0, 39023.609763902, 39027.41458878062, 39037.804810975766, 37283.44074838934, 38312.616873830906, 38473.038174045876, 38877.0, 39334.80332598433, 32159.839200803846, 33391.66608333983, 38335.80832095822, 38418.80790596141, 38615.2276954465, 29550.0, 31063.0, 31321.06036818899, 31641.8417907909, 31769.682303177597, 20009.6998545019, 24311.392215194763, 24341.0, 24526.509469810146, 24550.263492095266], "value": 18409.107453629804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.8982779735571, 422.5626476596721, 426.3604593110334, 431.9956800431996, 433.7462584388133, 18351.724724129148, 20472.0, 20541.07565159568, 21267.893660531696, 21433.464163395885, 21438.464038399008, 21793.67309490359, 21980.450488737788, 22099.558008839813, 22544.985475653593, 5859.501942334896, 6307.0, 6376.202974628171, 6383.106365108865, 6392.232932048138, 6131.662758548278, 6214.502839772807, 6256.874862502747, 6316.74733010679, 6355.618662880219, 6285.308616052231, 6335.334789847069, 6346.682665866711, 6365.2998170201245, 6398.328175541571, 6102.202907238142, 6303.653299068549, 6342.0803983422375, 6357.809265722012, 6363.331850155736, 5440.292761940922, 5535.6955367454775, 5561.694106824123, 5566.526845218162, 5567.109262518018, 22379.888100559394, 26894.0, 27134.86432567844, 27286.45427091467, 27782.722172778416, 2067.927622533219, 2193.9451513712283, 2332.3586013846157, 2349.424391024193, 2883.700650071363, 10163.542640581192, 10183.28716989811, 10449.68650940473, 10459.477026148663, 10493.9475302623, 1782.7949785774672, 1786.6605344984541, 1818.9181486833124, 1835.3392778599693, 1865.8693891427606, 117131.0, 118753.0, 125193.37403313017, 125265.0, 126006.3699681505, 12038.39808009596, 12119.939400303118, 12248.203866748632, 12250.44872980718, 12330.568430105082, 13888.236147011808, 14907.478238261609, 15413.537593871977, 15723.842761572467, 15752.921235393978, 9223.769405764775, 9428.198603118812, 9480.431174129575, 9523.476208808443, 9616.990216027216, 9537.570809313598, 9627.133557979816, 9632.518374081268, 9706.805863882682, 9707.66023189199, 4781.808727650925, 4797.544233297831, 4839.879003024953, 4868.659193856467, 4905.386826646669, 1769.0, 1837.3844762004878, 2014.113789932425, 2082.3961051294955, 2123.193186589117, 901.5086777706166, 995.8605795188535, 1006.4263369879098, 1019.2966852871494, 1039.030635029327, 17186.226619801888, 20263.0, 20685.58628827445, 21687.132514699235, 21702.674459883114, 1041.630221271453, 1044.7492601775518, 1077.0360527327998, 1093.278436232083, 1101.493313075994, 9316.0, 10907.454627268606, 11391.373474458984, 11423.942880285545, 11434.885651143382, 603110.0, 613044.0, 619701.0, 624164.0, 626641.0, 119339.0, 123281.0, 129404.3529782345, 129531.0, 131556.0, 1042.3641578637025, 1057.5558265528496, 1059.2955684469896, 1060.3372891942536, 1085.4247248957906, 18439.53901152482, 18826.905865470584, 19038.524036898634, 19058.237670493025, 19259.711104333164, 42717.78641106775, 51576.74211628918, 54563.727181363836, 54769.0, 55210.723946380014, 68960.3103968954, 71259.0, 72737.0, 75326.0, 77524.44951100834, 7909.090454597795, 7927.762167134995, 8111.797205069921, 8148.429609927485, 8355.916440835514, 7541.585212813348, 12410.255384676948, 12631.557895473614, 12960.222386656831, 12979.091463597457, 5300.867478313073, 6009.0, 7117.110361204849, 7383.187849336676, 11290.887091129312, 11062.889371106186, 11069.446527673745, 11136.721581960192, 11140.387278699425, 11293.71765705831, 11277.154213434189, 11519.481623326803, 11682.70793230176, 11799.35103569312, 11878.346690931736, 8227.465214761021, 8244.258016778518, 8297.751067467985, 8331.16688331162, 8594.011688655635, 11239.213255072067, 11431.714207144887, 11469.254498457574, 11505.0, 11554.942225289156], "value": 9782.966404595958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1631.9437508738988, 1642.359479802877, 1930.0928563575123, 2017.848661350398, 2070.254708305009, 8356.83286334273, 8828.249598784096, 9098.909010909889, 9281.721548353551, 9286.117818807219, 7433.5911524866115, 8950.14973577509, 9053.45679259245, 9072.72781816545, 9081.18269355758, 2446.657467954488, 2527.1155095716535, 2554.9361265968405, 2559.5392829290813, 2578.9097381591646, 2156.9352919412445, 2451.019592163131, 2514.2959971208, 2557.5268575313626, 2563.3976015636313, 2102.7897210279, 2520.974790252092, 2522.8738563071865, 2534.974650253492, 2536.251805717318, 2082.6980087887246, 2490.2155820916355, 2505.473850491399, 2546.2743118211406, 2550.081970490622, 2205.6986378036877, 2472.344828620417, 2499.487605040962, 2513.434477242624, 2533.442642618621, 9045.819083618357, 9204.953975230148, 9234.261259099256, 9274.582643781046, 9290.210332121778, 5583.162525621149, 5626.12795016769, 5687.260656114679, 5757.769689212427, 5778.017736984681, 3621.746477746559, 3667.2298817248143, 3699.667029967316, 3706.129059670975, 3749.531308586427, 1049.2445439283704, 1059.4596755654595, 1065.9733506662317, 1074.4466599701161, 1074.5272080284728, 12022.63932082039, 12028.45871935765, 12111.939440302831, 12482.126251162423, 12486.813752693388, 4932.654714170046, 4969.18008528596, 5043.52086551777, 5076.340075790124, 5087.516685914832, 10496.370217786956, 10558.788824223473, 10566.418846963337, 10587.364758114383, 10618.415987120783, 5597.0, 5689.146628005749, 5693.914591281134, 5719.7140142992685, 5750.913736293959, 4638.165130276515, 5034.572061374751, 5094.77073531692, 5148.304978827885, 5183.740812959412, 3615.638436156416, 4207.600277973587, 4250.936235956463, 4325.76208308546, 4341.08837144197, 1391.7216556688702, 1417.8015077889104, 1420.0627585793534, 1420.1479112532397, 1428.3358238419185, 871.3421366868101, 885.3846576629181, 903.1510380242551, 928.4800511713462, 929.6792606550729, 6123.6221850083375, 6164.3835616438, 6164.599301045418, 6278.968605156945, 6316.463100636405, 959.5010594490826, 1021.4739409204266, 1031.6750223679517, 1044.0916402729674, 1058.7406085509099, 4082.4896887889013, 4115.8765237042935, 4128.38074288853, 4141.91716165675, 4147.668186545069, 11084.667459976052, 11158.944205279084, 11230.3261804292, 11399.886001140048, 11426.771464570662, 10846.566137354575, 10885.292455990335, 10895.237333386745, 10900.182486313399, 11177.385243811668, 8357.0, 8640.956795215983, 8643.308535317285, 8729.345299102593, 8767.868481972775, 4962.255661650637, 5331.733413329395, 5746.798862039808, 5982.312034116132, 6146.231721034871, 9446.055394460498, 9489.857652135086, 9518.286128540525, 9563.0, 9582.281328900499, 9179.449233046038, 9803.460809655253, 9823.901760982299, 9854.802903942025, 10173.745656358651, 6982.231954485104, 7074.186468556182, 7551.169371369255, 7557.962210188914, 7659.846803063796, 8319.625616847377, 8330.333573314, 8338.04112527067, 8341.499510029418, 8382.790430239293, 7274.454415918933, 7436.814079647836, 7497.9250207497225, 7522.059742532184, 7587.62061896914, 7426.108866936002, 7458.627068646438, 7548.0, 7570.280823321776, 7597.354224890946, 7228.277172282729, 7237.3486386225495, 7290.0, 7292.015577896916, 7300.342969132804, 4990.725510096834, 5115.590752739847, 5177.8187763428095, 5211.791528338824, 5250.894982100413, 5051.2423136529815, 5099.36257967754, 5100.974495127501, 5116.513931176532, 5139.203423469368], "value": 4764.118505383616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.65176564607157, 336.14271322210493, 336.8349508740717, 342.65734265734267, 345.3179969560118, 5992.861356342292, 6704.128463299777, 6790.864182716343, 6847.657617119143, 6864.244933057366, 5927.288725352963, 6850.246472887979, 6894.1037665103595, 6902.689378977945, 6910.686969475796, 5028.7988480460735, 5052.242163675451, 5057.974710126444, 5059.595232381401, 5075.796968121271, 5061.038402703493, 5071.087204303224, 5073.467285934979, 5091.694498330094, 5101.15830887903, 4977.875553111183, 4985.102681517325, 4986.227134794112, 5035.874103147414, 5043.067032598981, 4268.0, 4696.201645720202, 4705.623550116, 4897.069556784199, 4990.1516742153735, 3564.928701425983, 4135.60711732385, 4150.439690641755, 4185.518665353462, 4188.246115699173, 5423.647462914937, 5602.187682786014, 6331.715072821734, 6416.45460135889, 6427.646479443629, 5844.707764611752, 5853.5902486825935, 5862.794802181946, 5898.7640494380175, 5953.255843019622, 7306.4154867611, 7318.15841178266, 7331.78004659861, 7335.559866408033, 7367.410607151415, 4493.123840851035, 4648.1865673507, 4675.906481870377, 4680.812767489297, 4702.976485117552, 6320.399562041599, 7664.271894170045, 7711.344535714471, 7712.383009359181, 7727.961360193163, 4712.340272361872, 4716.198246298138, 4726.314684370747, 4729.337892695025, 4729.95270047302, 4803.951960480351, 4811.975940120277, 4820.39745031871, 4821.083244636944, 4830.396200474941, 5802.158686990363, 5826.300843898759, 5841.182234487175, 5842.298924129132, 5861.824145275563, 7073.469489788184, 7145.570885822856, 7344.559326440324, 7386.852262954818, 7394.334509894135, 1446.7323545144181, 1660.2528862012143, 1671.6489537197324, 1673.397576872325, 1680.2690829488968, 996.7009897030862, 1035.99482002591, 1037.7509397744486, 1058.1059902773948, 1058.5501162006117, 5732.283464566929, 6839.829004274933, 6999.930000700029, 7079.504434689626, 7083.6458177090935, 6179.660118693425, 6566.343365663395, 7730.1110372306775, 7738.380929525624, 7763.883541746878, 6279.7488100476385, 7022.08712867324, 7032.05067315916, 7036.683349249296, 7087.369904921897, 3059.0211132437407, 3466.3933811582874, 3631.9818400907825, 3932.5953550780337, 4067.3695577185586, 7938.0, 8050.919490805017, 8052.194780522018, 8052.59737013147, 8058.516489010678, 7925.167857374892, 7984.520928744294, 7991.520508769492, 7992.720254791055, 8022.839543209103, 8051.154628764012, 8077.676892924217, 8088.636011379502, 8093.231143041402, 8100.918990810016, 7471.813204669927, 7709.306162445407, 7735.6905723770415, 7735.922640773745, 7765.961170194339, 6448.193975753031, 7218.0, 7566.924330756622, 7600.42996775233, 7619.809504762426, 6470.741170353133, 8027.799305017421, 8040.5979701015885, 8043.758687239392, 8076.596170191585, 3929.80350982444, 4318.805653745651, 4448.665400379938, 4805.303231031551, 4815.012922350979, 7442.702291908263, 7561.168271490242, 7596.430267729832, 7695.2304769524835, 7738.032745906762, 5503.504684578407, 7363.668634911549, 7385.667644956097, 7394.630268486661, 7425.071866016748, 7368.852622947618, 7395.741149059757, 7396.519226250277, 7420.443466740124, 7471.476996610402, 7160.212376638669, 7224.8916266255, 7230.023946767119, 7269.854602908018, 7315.926840731738, 7256.7460138894885, 7429.702811887464, 7470.663820127998, 7491.513051651626, 7515.323620873929, 7028.578285302899, 7137.750178743719, 7260.056192695127, 7302.306280903305, 7336.266373362621], "value": 5276.486038105071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.5635062611806, 717.8205448637841, 719.9352058314751, 727.894455303981, 765.1659690936877, 15205.4678086267, 15246.313915873785, 15573.22133893305, 15837.604059898495, 15872.365105395786, 14482.782758258634, 14730.558083257492, 14895.031822931502, 14919.850801491983, 14935.551933442013, 784.0747917457398, 925.453982150531, 931.16660588773, 947.4978261521404, 975.4878688688424, 950.8906475755308, 974.5078735238694, 976.6288810252095, 979.7207795778205, 981.8330883749744, 1026.0560284538205, 1027.8920713325106, 1030.1501261459289, 1030.386919782728, 1030.9072183503483, 985.4087547471531, 1021.0504231065106, 1025.318163421324, 1025.8563801067894, 1032.4424810602266, 737.6385571070191, 742.0649981023895, 756.043604839878, 766.4673052228703, 772.5480593852603, 15506.61233469161, 15571.766423503657, 15816.841831581767, 15899.523014309589, 15956.76064859028, 9805.509724513746, 11972.10209234311, 12227.082968777377, 12259.448324825315, 12281.324527151002, 10360.948195258976, 10421.062104410563, 10477.895221047767, 10540.9986051325, 10630.468476576218, 3537.7700449470703, 3561.305545418644, 3597.8560857565926, 3603.279344131158, 3667.8716244931566, 87095.0, 87690.0, 87930.0, 89103.0, 89611.0, 9994.450305233282, 10002.399856008517, 10013.549390277454, 10065.34575252621, 10100.646477373257, 23973.880130599584, 24045.759542404703, 24384.878075609508, 24414.389640259134, 24441.511169776506, 7812.062552493737, 7819.921800782033, 8115.3507719382305, 8144.4298899077685, 8301.8339633207, 3577.2845430913403, 3971.0667993021616, 4016.216837716676, 4159.521655009713, 4178.791060446965, 3087.938241235163, 3775.188334508039, 3812.599677033927, 3854.1713531590844, 3859.614038596118, 687.3126873126873, 706.4948561778353, 714.9821254468576, 731.3308322884608, 762.5615271219071, 456.8857785553612, 503.68519675203, 517.3300575754332, 554.7960924793208, 576.5848589015902, 7074.752383666547, 7323.560586364835, 8363.707270245633, 8371.916280837113, 8515.659373624985, 520.7656554550392, 591.0985746736176, 609.5002098279368, 618.1593033474471, 630.4105661206695, 3875.8643447479203, 3973.7814420206587, 4011.5186177658866, 4082.5713300103657, 4202.3696445533415, 81685.18314816775, 84515.0, 97321.51339243258, 98766.0, 99052.0, 81562.59218703868, 82353.0, 82486.58756706178, 82852.58573707214, 84210.5789471061, 71920.64039679873, 72087.0, 72624.0, 72736.27263727401, 72824.27175728281, 7918.0, 8074.515529068275, 8207.425480216327, 8216.178382161735, 8241.134680858664, 34380.82809585936, 48953.0, 50038.74980625074, 51134.0, 51804.740976294874, 69181.61636767337, 72771.0, 73103.26896730965, 73950.26049739434, 73977.63011185125, 10228.386296822215, 10294.3823370595, 10319.174466042849, 10514.421706806199, 10668.46657667098, 10766.89233107659, 10886.401247931122, 10995.0, 11099.5560177592, 11211.159163062639, 10393.116585090353, 10852.782944341227, 10897.128229741444, 10964.068054215162, 10999.670009899715, 10468.63359782404, 10627.893721063, 10707.304025238334, 10968.0, 10985.945070274598, 9702.029797020241, 9924.702258932244, 10096.949515252376, 11316.9434152832, 11938.0, 7734.651940662796, 8295.709650162215, 9618.903810961801, 9790.461524616214, 10100.696979090639, 9531.38046027006, 9724.222062234863, 9728.464934428674, 9755.609775608897, 9756.707298781048], "value": 7014.947843505795, "unit": "score"}], "name": "dromaeo_css", "value": 7559.974277632093, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 106.0, 123.0, 172.0, 168.0, 108.0, 116.0, 125.0, 169.0], "value": 131.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 143.0, 159.0, 119.0, 150.0, 130.0, 150.0, 200.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 194.0, 194.0, 194.0, 236.0, 269.0, 192.0, 193.0, 197.0, 194.0], "value": 205.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 72.0, 145.0, 57.0, 55.0, 56.0, 64.0, 119.0, 55.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 122.0, 76.0, 81.0, 87.0, 122.0, 80.0, 78.0, 123.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 108.0, 130.0, 91.0, 86.0, 88.0, 91.0, 89.0, 86.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 90.0, 90.0, 92.0, 90.0, 89.0, 93.0, 91.0, 89.0], "value": 90.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 64.0, 64.0, 63.0, 65.0, 64.0, 79.0, 62.0, 58.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 70.0, 68.0, 69.0, 81.0, 56.0, 62.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 80.0, 82.0, 81.0, 82.0, 83.0, 80.0, 84.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 144.0, 145.0, 127.0, 143.0, 149.0, 137.0, 133.0, 196.0, 170.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 163.0, 159.0, 171.0, 166.0, 163.0, 166.0, 166.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 87.0, 60.0, 66.0, 71.0, 89.0, 100.0, 62.0, 85.0], "value": 76.1, "unit": "score"}], "name": "kraken", "value": 1534.0, "alertThreshold": 2.0}]} 01:58:07 INFO - Return code: 0 01:58:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:58:08 ERROR - # TBPL SUCCESS # 01:58:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:58:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:58:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:58:08 INFO - 2016-06-07 01:58:08.030 screenresolution[1688:10674] starting screenresolution argv=screenresolution get 01:58:08 INFO - 2016-06-07 01:58:08.032 screenresolution[1688:10674] Display 0: 1600x1200x32@60 01:58:08 INFO - 2016-06-07 01:58:08.038 screenresolution[1689:10677] starting screenresolution argv=screenresolution list 01:58:08 INFO - Available Modes on Display 0 01:58:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:58:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:58:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:58:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:58:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:58:08 INFO - Intel Iris: 01:58:08 INFO - Chipset Model: Intel Iris 01:58:08 INFO - Type: GPU 01:58:08 INFO - Bus: Built-In 01:58:08 INFO - VRAM (Dynamic, Max): 1536 MB 01:58:08 INFO - Vendor: Intel (0x8086) 01:58:08 INFO - Device ID: 0x0a2e 01:58:08 INFO - Revision ID: 0x0009 01:58:08 INFO - Displays: 01:58:08 INFO - Display: 01:58:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:58:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:58:08 INFO - Display Serial Number: 1600x1200 60 01:58:08 INFO - Main Display: Yes 01:58:08 INFO - Mirror: Off 01:58:08 INFO - Online: Yes 01:58:08 INFO - Rotation: Supported 01:58:08 INFO - Return code: 0 01:58:08 INFO - Running post-action listener: _resource_record_post_action 01:58:08 INFO - Running post-run listener: _resource_record_post_run 01:58:09 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 36894208; Write bytes: 497198080; Read time: 237; Write time: 1546 01:58:09 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194869760; Write bytes: 197093376; Read time: 17600; Write time: 421 01:58:09 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 35079680; Write bytes: 299256832; Read time: 222; Write time: 1123 01:58:09 INFO - Running post-run listener: _upload_blobber_files 01:58:09 INFO - Blob upload gear active. 01:58:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:58:09 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 01:58:09 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'] 01:58:09 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 01:58:09 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:10 INFO - (blobuploader) - INFO - Done attempting. 01:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:11 INFO - (blobuploader) - INFO - Done attempting. 01:58:11 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:11 INFO - Return code: 0 01:58:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d46a87a69fc6683144d83422d11b3be5624727713004e2141be35abde5200cc2f283f3058601a89cba76944c3a01b283027a05e9d9cf568a04c530b29353d78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6c67842dd41c76349d5cf110a19eaa9aa29f19bbc541779de39f794db7fa978f397b0bbe8b8dd6f2cfa1386a4486e6959caa08010bbe2ab0dec7d4ee1b5eaf4"} 01:58:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:11 INFO - Contents: 01:58:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d46a87a69fc6683144d83422d11b3be5624727713004e2141be35abde5200cc2f283f3058601a89cba76944c3a01b283027a05e9d9cf568a04c530b29353d78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6c67842dd41c76349d5cf110a19eaa9aa29f19bbc541779de39f794db7fa978f397b0bbe8b8dd6f2cfa1386a4486e6959caa08010bbe2ab0dec7d4ee1b5eaf4"} 01:58:11 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:11 INFO - Copying logs to upload dir... 01:58:11 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.479972 ========= master_lag: 0.71 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-07 01:58:12.276196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:12.284017) ========= 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.3D9n5sgAwE/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.pnA3onCLrR/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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/7d46a87a69fc6683144d83422d11b3be5624727713004e2141be35abde5200cc2f283f3058601a89cba76944c3a01b283027a05e9d9cf568a04c530b29353d78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6c67842dd41c76349d5cf110a19eaa9aa29f19bbc541779de39f794db7fa978f397b0bbe8b8dd6f2cfa1386a4486e6959caa08010bbe2ab0dec7d4ee1b5eaf4"} build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/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/7d46a87a69fc6683144d83422d11b3be5624727713004e2141be35abde5200cc2f283f3058601a89cba76944c3a01b283027a05e9d9cf568a04c530b29353d78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6c67842dd41c76349d5cf110a19eaa9aa29f19bbc541779de39f794db7fa978f397b0bbe8b8dd6f2cfa1386a4486e6959caa08010bbe2ab0dec7d4ee1b5eaf4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:12.321741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:12.322082) ========= 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.3D9n5sgAwE/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.pnA3onCLrR/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.005026 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:12.373616) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:12.373944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:12.374310) ========= ========= Total master_lag: 0.98 =========