builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0128 starttime: 1461192228.37 results: success (0) buildid: 20160420135553 builduid: d3aa61ee81694221b6574211e5a5398e revision: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.373887) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.374652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.375142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.397065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.397666) ========= 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.chVisIQQuj/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.3CMkxPp1FI/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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-04-20 15:43:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 57.9M=0s 2016-04-20 15:43:48 (57.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.508815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.509361) ========= 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.chVisIQQuj/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.3CMkxPp1FI/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.026657 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:48.558841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 15:43:48.559207) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 93090fa3065335c9f830e9c70cbfbbc2f40fd979 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 93090fa3065335c9f830e9c70cbfbbc2f40fd979 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.chVisIQQuj/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.3CMkxPp1FI/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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-04-20 15:43:48,643 truncating revision to first 12 chars 2016-04-20 15:43:48,643 Setting DEBUG logging. 2016-04-20 15:43:48,643 attempt 1/10 2016-04-20 15:43:48,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/93090fa30653?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 15:43:49,425 unpacking tar archive at: mozilla-central-93090fa30653/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 15:43:49.611376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:49.611773) ========= script_repo_revision: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:49.612175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:49.612440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:43:49.626742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 40 secs) (at 2016-04-20 15:43:49.627168) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.chVisIQQuj/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.3CMkxPp1FI/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:43:49 INFO - MultiFileLogger online at 20160420 15:43:49 in /builds/slave/test 15:43:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:43:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:49 INFO - {'append_to_log': False, 15:43:49 INFO - 'base_work_dir': '/builds/slave/test', 15:43:49 INFO - 'blob_upload_branch': 'Firefox', 15:43:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:49 INFO - 'branch': 'Firefox', 15:43:49 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:49 INFO - 'config_files': ('talos/mac_config.py',), 15:43:49 INFO - 'default_actions': ('clobber', 15:43:49 INFO - 'read-buildbot-config', 15:43:49 INFO - 'download-and-extract', 15:43:49 INFO - 'populate-webroot', 15:43:49 INFO - 'create-virtualenv', 15:43:49 INFO - 'install', 15:43:49 INFO - 'run-tests'), 15:43:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:49 INFO - 'download_minidump_stackwalk': True, 15:43:49 INFO - 'download_symbols': 'ondemand', 15:43:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:43:49 INFO - 'tooltool.py': '/tools/tooltool.py', 15:43:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:43:49 INFO - '/tools/misc-python/virtualenv.py')}, 15:43:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:49 INFO - 'installer_path': 'installer.exe', 15:43:49 INFO - 'log_level': 'info', 15:43:49 INFO - 'log_name': 'talos', 15:43:49 INFO - 'log_to_console': True, 15:43:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:43:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:43:49 INFO - 'opt_config_files': (), 15:43:49 INFO - 'pip_index': False, 15:43:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:43:49 INFO - 'cmd': ('bash', 15:43:49 INFO - '-c', 15:43:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:43:49 INFO - 'enabled': True, 15:43:49 INFO - 'halt_on_failure': False, 15:43:49 INFO - 'name': 'check_screen_resolution'},), 15:43:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:43:49 INFO - 'cmd': ('bash', 15:43:49 INFO - '-c', 15:43:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:43:49 INFO - 'enabled': True, 15:43:49 INFO - 'halt_on_failure': False, 15:43:49 INFO - 'name': 'check_screen_resolution'},), 15:43:49 INFO - 'run_cmd_checks_enabled': True, 15:43:49 INFO - 'sps_profile': False, 15:43:49 INFO - 'sps_profile_interval': 0, 15:43:49 INFO - 'suite': 'dromaeojs-e10s', 15:43:49 INFO - 'system_bits': '32', 15:43:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:49 INFO - 'title': 't-yosemite-r7-0128', 15:43:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:49 INFO - 'use_talos_json': True, 15:43:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:49 INFO - 'work_dir': 'build'} 15:43:49 INFO - ##### 15:43:49 INFO - ##### Running clobber step. 15:43:49 INFO - ##### 15:43:49 INFO - Running pre-action listener: _resource_record_pre_action 15:43:49 INFO - Running main action method: clobber 15:43:49 INFO - rmtree: /builds/slave/test/build 15:43:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:52 INFO - Running post-action listener: _resource_record_post_action 15:43:52 INFO - ##### 15:43:52 INFO - ##### Running read-buildbot-config step. 15:43:52 INFO - ##### 15:43:52 INFO - Running pre-action listener: _resource_record_pre_action 15:43:52 INFO - Running main action method: read_buildbot_config 15:43:52 INFO - Using buildbot properties: 15:43:52 INFO - { 15:43:52 INFO - "project": "", 15:43:52 INFO - "product": "firefox", 15:43:52 INFO - "script_repo_revision": "production", 15:43:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:43:52 INFO - "repository": "", 15:43:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:43:52 INFO - "buildid": "20160420135553", 15:43:52 INFO - "pgo_build": "False", 15:43:52 INFO - "basedir": "/builds/slave/test", 15:43:52 INFO - "buildnumber": 200, 15:43:52 INFO - "slavename": "t-yosemite-r7-0128", 15:43:52 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:43:52 INFO - "platform": "yosemite_r7", 15:43:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:43:52 INFO - "branch": "mozilla-central", 15:43:52 INFO - "repo_path": "mozilla-central", 15:43:52 INFO - "revision": "93090fa3065335c9f830e9c70cbfbbc2f40fd979", 15:43:52 INFO - "stage_platform": "macosx64", 15:43:52 INFO - "builduid": "d3aa61ee81694221b6574211e5a5398e", 15:43:52 INFO - "slavebuilddir": "test" 15:43:52 INFO - } 15:43:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:43:52 INFO - Running post-action listener: _resource_record_post_action 15:43:52 INFO - ##### 15:43:52 INFO - ##### Running download-and-extract step. 15:43:52 INFO - ##### 15:43:52 INFO - Running pre-action listener: _resource_record_pre_action 15:43:52 INFO - Running main action method: download_and_extract 15:43:52 INFO - mkdir: /builds/slave/test/build/tests 15:43: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')]} 15:43:52 INFO - https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:43:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:43:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:43:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 15:43:53 INFO - Downloaded 1199 bytes. 15:43:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:43:53 INFO - Using the following test package requirements: 15:43:53 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:43:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:43:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:43:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'jsshell-mac.zip'], 15:43:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:43:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:43:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:43:53 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:43:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:43:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:43:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:53 INFO - https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:43:55 INFO - Downloaded 18099582 bytes. 15:43:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:43:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:43:58 INFO - Return code: 0 15:43:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:43:58 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')]} 15:43:58 INFO - https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:44:00 INFO - Downloaded 18099582 bytes. 15:44:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:44:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:44:03 INFO - Return code: 0 15:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:03 INFO - https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:44:04 INFO - Downloaded 10845952 bytes. 15:44:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:44:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:44:04 INFO - Return code: 0 15:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:04 INFO - https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:44:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:44:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 15:44:08 INFO - Downloaded 110040236 bytes. 15:44:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:08 INFO - mkdir: /builds/slave/test/properties 15:44:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:44:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:44:08 INFO - Contents: 15:44:08 INFO - build_url:https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:09 INFO - Running post-action listener: _resource_record_post_action 15:44:09 INFO - Running post-action listener: set_extra_try_arguments 15:44:09 INFO - ##### 15:44:09 INFO - ##### Running populate-webroot step. 15:44:09 INFO - ##### 15:44:09 INFO - Running pre-action listener: _resource_record_pre_action 15:44:09 INFO - Running main action method: populate_webroot 15:44:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:09 INFO - '--tppagecycles', 15:44:09 INFO - '7'], 15:44:09 INFO - 'tests': ['tsvgm']}}, 15:44:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:44:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:44:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:44:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['damp', 'tps']}, 15:44:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'tests': ['damp', 'tps']}, 15:44:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['dromaeo_dom']}, 15:44:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['a11yr', 15:44:09 INFO - 'ts_paint', 15:44:09 INFO - 'tpaint', 15:44:09 INFO - 'sessionrestore', 15:44:09 INFO - 'sessionrestore_no_auto_restore', 15:44:09 INFO - 'tabpaint']}, 15:44:09 INFO - 'other-e10s': {'tests': ['a11yr', 15:44:09 INFO - 'ts_paint', 15:44:09 INFO - 'tpaint', 15:44:09 INFO - 'sessionrestore', 15:44:09 INFO - 'sessionrestore_no_auto_restore', 15:44:09 INFO - 'tabpaint']}, 15:44:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:44:09 INFO - 'ts_paint', 15:44:09 INFO - 'tpaint', 15:44:09 INFO - 'sessionrestore', 15:44:09 INFO - 'sessionrestore_no_auto_restore', 15:44:09 INFO - 'tabpaint']}, 15:44:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:44:09 INFO - 'ts_paint', 15:44:09 INFO - 'tpaint', 15:44:09 INFO - 'sessionrestore', 15:44:09 INFO - 'sessionrestore_no_auto_restore', 15:44:09 INFO - 'tabpaint']}, 15:44:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['a11yr', 15:44:09 INFO - 'ts_paint', 15:44:09 INFO - 'tpaint', 15:44:09 INFO - 'sessionrestore', 15:44:09 INFO - 'sessionrestore_no_auto_restore', 15:44:09 INFO - 'tabpaint']}, 15:44:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['a11yr', 15:44:09 INFO - 'ts_paint', 15:44:09 INFO - 'tpaint', 15:44:09 INFO - 'sessionrestore', 15:44:09 INFO - 'sessionrestore_no_auto_restore', 15:44:09 INFO - 'tabpaint']}, 15:44:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['tsvgx', 15:44:09 INFO - 'tsvgr_opacity', 15:44:09 INFO - 'tart', 15:44:09 INFO - 'tscrollx', 15:44:09 INFO - 'cart']}, 15:44:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:44:09 INFO - 'tsvgr_opacity', 15:44:09 INFO - 'tart', 15:44:09 INFO - 'tscrollx', 15:44:09 INFO - 'cart']}, 15:44:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'talos_options': ['--disable-e10s'], 15:44:09 INFO - 'tests': ['tp5o']}, 15:44:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'tests': ['tp5o']}, 15:44:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'talos_options': ['--disable-e10s', 15:44:09 INFO - '--xperf_path', 15:44:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:09 INFO - 'tests': ['tp5n']}, 15:44:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:09 INFO - 'talos_options': ['--xperf_path', 15:44:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:09 INFO - 'tests': ['tp5n']}}, 15:44:09 INFO - 'talos.zip': {'path': '', 15:44:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:09 INFO - Running post-action listener: _resource_record_post_action 15:44:09 INFO - ##### 15:44:09 INFO - ##### Running create-virtualenv step. 15:44:09 INFO - ##### 15:44:09 INFO - Running pre-action listener: _resource_record_pre_action 15:44:09 INFO - Running main action method: create_virtualenv 15:44:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:44:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:44:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:44:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:09 INFO - Using real prefix '/tools/python27' 15:44:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:44:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:13 INFO - Installing pip.................done. 15:44:13 INFO - Return code: 0 15:44:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:13 INFO - 'HOME': '/Users/cltbld', 15:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:13 INFO - 'LOGNAME': 'cltbld', 15:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:13 INFO - 'MOZ_NO_REMOTE': '1', 15:44:13 INFO - 'NO_EM_RESTART': '1', 15:44:13 INFO - 'PAGER': '/bin/cat', 15:44:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:13 INFO - 'PWD': '/builds/slave/test', 15:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:13 INFO - 'SHELL': '/bin/bash', 15:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:13 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:13 INFO - 'USER': 'cltbld', 15:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:13 INFO - 'XPC_FLAGS': '0x0', 15:44:13 INFO - 'XPC_SERVICE_NAME': '0', 15:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:44:13 INFO - Cleaning up... 15:44:13 INFO - Return code: 0 15:44:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:13 INFO - 'HOME': '/Users/cltbld', 15:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:13 INFO - 'LOGNAME': 'cltbld', 15:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:13 INFO - 'MOZ_NO_REMOTE': '1', 15:44:13 INFO - 'NO_EM_RESTART': '1', 15:44:13 INFO - 'PAGER': '/bin/cat', 15:44:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:13 INFO - 'PWD': '/builds/slave/test', 15:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:13 INFO - 'SHELL': '/bin/bash', 15:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:13 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:13 INFO - 'USER': 'cltbld', 15:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:13 INFO - 'XPC_FLAGS': '0x0', 15:44:13 INFO - 'XPC_SERVICE_NAME': '0', 15:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:13 INFO - Downloading/unpacking psutil>=0.7.1 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:16 INFO - Installing collected packages: psutil 15:44:16 INFO - Running setup.py install for psutil 15:44:16 INFO - building 'psutil._psutil_osx' extension 15:44:16 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 15:44:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:44:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:44:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:44:17 INFO - building 'psutil._psutil_posix' extension 15:44:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:44:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:44:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:44:17 INFO - ^ 15:44:17 INFO - 1 warning generated. 15:44:17 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 15:44:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:17 INFO - Successfully installed psutil 15:44:17 INFO - Cleaning up... 15:44:17 INFO - Return code: 0 15:44:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:44:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:17 INFO - 'HOME': '/Users/cltbld', 15:44:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:17 INFO - 'LOGNAME': 'cltbld', 15:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:17 INFO - 'MOZ_NO_REMOTE': '1', 15:44:17 INFO - 'NO_EM_RESTART': '1', 15:44:17 INFO - 'PAGER': '/bin/cat', 15:44:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:17 INFO - 'PWD': '/builds/slave/test', 15:44:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:17 INFO - 'SHELL': '/bin/bash', 15:44:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:17 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:17 INFO - 'USER': 'cltbld', 15:44:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:17 INFO - 'XPC_FLAGS': '0x0', 15:44:17 INFO - 'XPC_SERVICE_NAME': '0', 15:44:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:44:17 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 15:44:17 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 15:44:17 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 15:44:17 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 15:44:17 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 15:44:17 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 15:44:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:44:20 INFO - Installing collected packages: mozsystemmonitor 15:44:20 INFO - Running setup.py install for mozsystemmonitor 15:44:20 INFO - Successfully installed mozsystemmonitor 15:44:20 INFO - Cleaning up... 15:44:20 INFO - Return code: 0 15:44:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:44:20 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')]} 15:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:20 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')]} 15:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:20 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 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:20 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 15:44:20 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 15:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:20 INFO - 'HOME': '/Users/cltbld', 15:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:20 INFO - 'LOGNAME': 'cltbld', 15:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:20 INFO - 'MOZ_NO_REMOTE': '1', 15:44:20 INFO - 'NO_EM_RESTART': '1', 15:44:20 INFO - 'PAGER': '/bin/cat', 15:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:20 INFO - 'PWD': '/builds/slave/test', 15:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:20 INFO - 'SHELL': '/bin/bash', 15:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:20 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:20 INFO - 'USER': 'cltbld', 15:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:20 INFO - 'XPC_FLAGS': '0x0', 15:44:20 INFO - 'XPC_SERVICE_NAME': '0', 15:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:20 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:23 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44:23 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 15:44:23 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 15:44:23 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 15:44:23 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 15:44:23 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 15:44:23 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 15:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:44:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:24 INFO - Downloading docopt-0.6.1.tar.gz 15:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:24 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:24 INFO - Running setup.py install for blobuploader 15:44:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:44:24 INFO - Running setup.py install for requests 15:44:25 INFO - Running setup.py install for docopt 15:44:25 INFO - Successfully installed blobuploader requests docopt 15:44:25 INFO - Cleaning up... 15:44:25 INFO - Return code: 0 15:44:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:25 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 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:25 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 15:44:25 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 15:44:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:25 INFO - 'HOME': '/Users/cltbld', 15:44:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:25 INFO - 'LOGNAME': 'cltbld', 15:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:25 INFO - 'MOZ_NO_REMOTE': '1', 15:44:25 INFO - 'NO_EM_RESTART': '1', 15:44:25 INFO - 'PAGER': '/bin/cat', 15:44:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:25 INFO - 'PWD': '/builds/slave/test', 15:44:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:25 INFO - 'SHELL': '/bin/bash', 15:44:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:25 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:25 INFO - 'USER': 'cltbld', 15:44:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:25 INFO - 'XPC_FLAGS': '0x0', 15:44:25 INFO - 'XPC_SERVICE_NAME': '0', 15:44:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:25 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-2SyyQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:25 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-MgI5b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:25 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-OMSh5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-pbDvrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qkKEwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-08GbC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-LRXFMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-MDsyCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-bwZ_hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-A3W6lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-tINY8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-MEdJdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:26 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-gUChqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:27 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-5QrWog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:27 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-L13Lyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:27 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-vktY9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:27 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-xPAhHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:27 INFO - Running setup.py install for manifestparser 15:44:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:44:27 INFO - Running setup.py install for mozcrash 15:44:27 INFO - Running setup.py install for mozdebug 15:44:27 INFO - Running setup.py install for mozdevice 15:44:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Running setup.py install for mozfile 15:44:28 INFO - Running setup.py install for mozhttpd 15:44:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Running setup.py install for mozinfo 15:44:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Running setup.py install for mozInstall 15:44:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Running setup.py install for mozleak 15:44:28 INFO - Running setup.py install for mozlog 15:44:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:44:28 INFO - Running setup.py install for moznetwork 15:44:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:44:29 INFO - Running setup.py install for mozprocess 15:44:29 INFO - Running setup.py install for mozprofile 15:44:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:44:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:44:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:44:29 INFO - Running setup.py install for mozrunner 15:44:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:44:29 INFO - Running setup.py install for mozscreenshot 15:44:29 INFO - Running setup.py install for moztest 15:44:29 INFO - Running setup.py install for mozversion 15:44:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:44:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:30 INFO - Cleaning up... 15:44:30 INFO - Return code: 0 15:44:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:30 INFO - 'HOME': '/Users/cltbld', 15:44:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:30 INFO - 'LOGNAME': 'cltbld', 15:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:30 INFO - 'MOZ_NO_REMOTE': '1', 15:44:30 INFO - 'NO_EM_RESTART': '1', 15:44:30 INFO - 'PAGER': '/bin/cat', 15:44:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:30 INFO - 'PWD': '/builds/slave/test', 15:44:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:30 INFO - 'SHELL': '/bin/bash', 15:44:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:30 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:30 INFO - 'USER': 'cltbld', 15:44:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:30 INFO - 'XPC_FLAGS': '0x0', 15:44:30 INFO - 'XPC_SERVICE_NAME': '0', 15:44:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:30 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qyLZC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:30 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)) 15:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:30 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-7nvvsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:30 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)) 15:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:30 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-_aC42Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:30 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)) 15:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:30 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-iCRgTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:30 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)) 15:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:30 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-8AJTuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:30 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)) 15:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:30 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-ZQkMS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:30 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)) 15:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:30 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-VRJkao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-nzlhF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-hg6sMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:31 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)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-H1GaxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:31 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)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-vSWK03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:31 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)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-VvMm6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:31 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)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-NG9N7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:31 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)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-r2fNwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:31 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)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qc5r9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:31 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)) 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:31 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-VBHEl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:32 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-8FNxRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:34 INFO - Downloading blessings-1.6.tar.gz 15:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:34 INFO - Installing collected packages: blessings 15:44:34 INFO - Running setup.py install for blessings 15:44:34 INFO - Successfully installed blessings 15:44:34 INFO - Cleaning up... 15:44:34 INFO - Return code: 0 15:44:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:44:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:35 INFO - Reading from file tmpfile_stdout 15:44:35 INFO - Current package versions: 15:44:35 INFO - blessings == 1.6 15:44:35 INFO - blobuploader == 1.2.4 15:44:35 INFO - docopt == 0.6.1 15:44:35 INFO - manifestparser == 1.1 15:44:35 INFO - mozInstall == 1.12 15:44:35 INFO - mozcrash == 0.17 15:44:35 INFO - mozdebug == 0.1 15:44:35 INFO - mozdevice == 0.48 15:44:35 INFO - mozfile == 1.2 15:44:35 INFO - mozhttpd == 0.7 15:44:35 INFO - mozinfo == 0.9 15:44:35 INFO - mozleak == 0.1 15:44:35 INFO - mozlog == 3.1 15:44:35 INFO - moznetwork == 0.27 15:44:35 INFO - mozprocess == 0.22 15:44:35 INFO - mozprofile == 0.28 15:44:35 INFO - mozrunner == 6.11 15:44:35 INFO - mozscreenshot == 0.1 15:44:35 INFO - mozsystemmonitor == 0.0 15:44:35 INFO - moztest == 0.7 15:44:35 INFO - mozversion == 1.4 15:44:35 INFO - psutil == 3.1.1 15:44:35 INFO - requests == 1.2.3 15:44:35 INFO - wsgiref == 0.1.2 15:44:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:35 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 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:35 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 15:44:35 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 15:44:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:35 INFO - 'HOME': '/Users/cltbld', 15:44:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:35 INFO - 'LOGNAME': 'cltbld', 15:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:35 INFO - 'MOZ_NO_REMOTE': '1', 15:44:35 INFO - 'NO_EM_RESTART': '1', 15:44:35 INFO - 'PAGER': '/bin/cat', 15:44:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:35 INFO - 'PWD': '/builds/slave/test', 15:44:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:35 INFO - 'SHELL': '/bin/bash', 15:44:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:35 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:35 INFO - 'USER': 'cltbld', 15:44:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:35 INFO - 'XPC_FLAGS': '0x0', 15:44:35 INFO - 'XPC_SERVICE_NAME': '0', 15:44:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 INFO - Cleaning up... 15:44:35 INFO - Return code: 0 15:44:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:35 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 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:35 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 15:44:35 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 15:44:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:35 INFO - 'HOME': '/Users/cltbld', 15:44:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:35 INFO - 'LOGNAME': 'cltbld', 15:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:35 INFO - 'MOZ_NO_REMOTE': '1', 15:44:35 INFO - 'NO_EM_RESTART': '1', 15:44:35 INFO - 'PAGER': '/bin/cat', 15:44:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:35 INFO - 'PWD': '/builds/slave/test', 15:44:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:35 INFO - 'SHELL': '/bin/bash', 15:44:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:35 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:35 INFO - 'USER': 'cltbld', 15:44:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:35 INFO - 'XPC_FLAGS': '0x0', 15:44:35 INFO - 'XPC_SERVICE_NAME': '0', 15:44:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:35 INFO - Downloading/unpacking jsonschema 15:44:35 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 15:44:35 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 15:44:35 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 15:44:35 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 15:44:35 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 15:44:35 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 15:44:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:44:38 INFO - Downloading/unpacking functools32 (from jsonschema) 15:44:38 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 15:44:38 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 15:44:38 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 15:44:38 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 15:44:38 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 15:44:38 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 15:44:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:44:38 INFO - warning: no files found matching '*.txt' 15:44:38 INFO - no previously-included directories found matching 'build' 15:44:38 INFO - no previously-included directories found matching 'dist' 15:44:38 INFO - no previously-included directories found matching '.git*' 15:44:38 INFO - Installing collected packages: jsonschema, functools32 15:44:38 INFO - Running setup.py install for functools32 15:44:38 INFO - warning: no files found matching '*.txt' 15:44:38 INFO - no previously-included directories found matching 'build' 15:44:38 INFO - no previously-included directories found matching 'dist' 15:44:38 INFO - no previously-included directories found matching '.git*' 15:44:38 INFO - Successfully installed jsonschema functools32 15:44:38 INFO - Cleaning up... 15:44:38 INFO - Return code: 0 15:44:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:44:38 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')]} 15:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:38 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')]} 15:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:38 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 0x10b7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7f0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3ad7d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, '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.chVisIQQuj/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.3CMkxPp1FI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 15:44:38 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 15:44:38 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 15:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:38 INFO - 'HOME': '/Users/cltbld', 15:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:38 INFO - 'LOGNAME': 'cltbld', 15:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:38 INFO - 'MOZ_NO_REMOTE': '1', 15:44:38 INFO - 'NO_EM_RESTART': '1', 15:44:38 INFO - 'PAGER': '/bin/cat', 15:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:38 INFO - 'PWD': '/builds/slave/test', 15:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:38 INFO - 'SHELL': '/bin/bash', 15:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:44:38 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:38 INFO - 'USER': 'cltbld', 15:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:38 INFO - 'XPC_FLAGS': '0x0', 15:44:38 INFO - 'XPC_SERVICE_NAME': '0', 15:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:39 INFO - Downloading/unpacking flake8 15:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:44:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:44:41 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 15:44:41 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 15:44:41 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 15:44:41 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 15:44:41 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 15:44:41 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 15:44:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:44:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:44:41 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 15:44:41 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 15:44:41 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 15:44:41 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 15:44:41 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 15:44:41 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 15:44:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:44:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:44:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:44:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:44:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:44:42 INFO - no previously-included directories found matching 'docs/_build' 15:44:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:44:42 INFO - Running setup.py install for pep8 15:44:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:44:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:44:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:44:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:44:42 INFO - no previously-included directories found matching 'docs/_build' 15:44:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:44:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:44:43 INFO - Cleaning up... 15:44:43 INFO - Return code: 0 15:44:43 INFO - Running post-action listener: _resource_record_post_action 15:44:43 INFO - Running post-action listener: _start_resource_monitoring 15:44:43 INFO - Starting resource monitoring. 15:44:43 INFO - ##### 15:44:43 INFO - ##### Running install step. 15:44:43 INFO - ##### 15:44:43 INFO - Running pre-action listener: _resource_record_pre_action 15:44:43 INFO - Running main action method: install 15:44:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:43 INFO - Reading from file tmpfile_stdout 15:44:43 INFO - Detecting whether we're running mozinstall >=1.0... 15:44:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:44:43 INFO - Reading from file tmpfile_stdout 15:44:43 INFO - Output received: 15:44:43 INFO - Usage: mozinstall [options] installer 15:44:43 INFO - Options: 15:44:43 INFO - -h, --help show this help message and exit 15:44:43 INFO - -d DEST, --destination=DEST 15:44:43 INFO - Directory to install application into. [default: 15:44:43 INFO - "/builds/slave/test"] 15:44:43 INFO - --app=APP Application being installed. [default: firefox] 15:44:43 INFO - mkdir: /builds/slave/test/build/application 15:44:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:45:16 INFO - Reading from file tmpfile_stdout 15:45:16 INFO - Output received: 15:45:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:45:16 INFO - Running post-action listener: _resource_record_post_action 15:45:16 INFO - ##### 15:45:16 INFO - ##### Running run-tests step. 15:45:16 INFO - ##### 15:45:16 INFO - Running pre-action listener: _resource_record_pre_action 15:45:16 INFO - Running main action method: run_tests 15:45:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:45:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:45:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:45:16 INFO - 2016-04-20 15:45:16.823 screenresolution[1631:7412] starting screenresolution argv=screenresolution get 15:45:16 INFO - 2016-04-20 15:45:16.825 screenresolution[1631:7412] Display 0: 1600x1200x32@60 15:45:16 INFO - 2016-04-20 15:45:16.831 screenresolution[1632:7414] starting screenresolution argv=screenresolution list 15:45:16 INFO - Available Modes on Display 0 15:45:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:45:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:45:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:45:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:45:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:45:17 INFO - Intel Iris: 15:45:17 INFO - Chipset Model: Intel Iris 15:45:17 INFO - Type: GPU 15:45:17 INFO - Bus: Built-In 15:45:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:45:17 INFO - Vendor: Intel (0x8086) 15:45:17 INFO - Device ID: 0x0a2e 15:45:17 INFO - Revision ID: 0x0009 15:45:17 INFO - Displays: 15:45:17 INFO - Display: 15:45:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:45:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:45:17 INFO - Display Serial Number: 1600x1200 60 15:45:17 INFO - Main Display: Yes 15:45:17 INFO - Mirror: Off 15:45:17 INFO - Online: Yes 15:45:17 INFO - Rotation: Supported 15:45:17 INFO - Return code: 0 15:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:45:17 INFO - Python 2.7.3 15:45:17 INFO - Return code: 0 15:45:17 INFO - grabbing minidump binary from tooltool 15:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:17 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 0x10b67fe00>, '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 0x10b4e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b67ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:45:17 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 15:45:17 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 15:45:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:17 INFO - Return code: 0 15:45:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:45:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:45:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:45:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:45:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:45:18 INFO - Return code: 0 15:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 15:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0128 --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 15:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.chVisIQQuj/Render', 15:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:18 INFO - 'HOME': '/Users/cltbld', 15:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:18 INFO - 'LOGNAME': 'cltbld', 15:45:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:45:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:18 INFO - 'MOZ_NO_REMOTE': '1', 15:45:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:45:18 INFO - 'NO_EM_RESTART': '1', 15:45:18 INFO - 'PAGER': '/bin/cat', 15:45:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:18 INFO - 'PWD': '/builds/slave/test', 15:45:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:18 INFO - 'SHELL': '/bin/bash', 15:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CMkxPp1FI/Listeners', 15:45:18 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 15:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:18 INFO - 'USER': 'cltbld', 15:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:18 INFO - 'XPC_FLAGS': '0x0', 15:45:18 INFO - 'XPC_SERVICE_NAME': '0', 15:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 15:45:18 INFO - mozversion application_buildid: 20160420135553 15:45:18 INFO - mozversion application_changeset: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 15:45:18 INFO - mozversion application_display_name: Nightly 15:45:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:18 INFO - mozversion application_name: Firefox 15:45:18 INFO - mozversion application_remotingname: firefox 15:45:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:45:18 INFO - mozversion application_vendor: Mozilla 15:45:18 INFO - mozversion application_version: 48.0a1 15:45:18 INFO - mozversion platform_buildid: 20160420135553 15:45:18 INFO - mozversion platform_changeset: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 15:45:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:45:18 INFO - mozversion platform_version: 48.0a1 15:45:18 INFO - using testdate: 1461192318 15:45:18 INFO - actual date: 1461192318 15:45:18 INFO - starting webserver on 'localhost:49270' 15:45:18 INFO - SUITE-START | Running 2 tests 15:45:18 INFO - TEST-START | dromaeo_css 15:45:18 INFO - operating with platform_type : mac_ 15:45:18 INFO - Initialising browser for dromaeo_css test... 15:45:18 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpj56MZA/profile http://localhost:49270/getInfo.html) 15:45:22 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 15:45:22 INFO - PROCESS | 1650 | colorDepth:24 15:45:22 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 15:45:22 INFO - PROCESS | 1650 | __metrics 15:45:22 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:45:22 INFO - TEST-INFO | 1650: exit 0 15:45:22 INFO - Browser initialized. 15:45:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:22 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpj56MZA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:34 INFO - PROCESS | 1653 | RSS: Main: 248098816 15:45:34 INFO - PROCESS | 1653 | 15:46:24 INFO - PROCESS | 1653 | 1461192384548 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] 15:48:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 15:48:38 INFO - PROCESS | 1653 | RSS: Main: 260456448 15:48:38 INFO - PROCESS | 1653 | 15:51:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 15:51:41 INFO - PROCESS | 1653 | RSS: Main: 272654336 15:51:41 INFO - PROCESS | 1653 | 15:54:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 15:54:43 INFO - PROCESS | 1653 | RSS: Main: 274038784 15:54:43 INFO - PROCESS | 1653 | 15:57:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 15:57:45 INFO - PROCESS | 1653 | RSS: Main: 275582976 15:57:45 INFO - PROCESS | 1653 | 16:00:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:00:49 INFO - PROCESS | 1653 | RSS: Main: 278503424 16:00:49 INFO - PROCESS | 1653 | 16:03:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:03:52 INFO - PROCESS | 1653 | RSS: Main: 279683072 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | __start_tp_report 16:03:52 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 16:03:52 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 16:03:52 INFO - PROCESS | 1653 | |i|pagename|runs| 16:03:52 INFO - PROCESS | 1653 | |0;dojo.html;3429.3998550253705;3504.8609202009347;3545.2200515886498;3558.8576456941723;3605.9459108113383;5743.54051675866;5773.336066352371;5783;5805.593608447411;5822.534197264214;4965.975170124153;5697.6011679182475;5772.682502462363;5876.529877609792;6022.457978781908;5281.313429254201;5357.4106848246665;5379.515843574078;5409.29679141711;5445.50990410863;5315.707636080014;5475.589330800186;5502.669839809604;5514.200440936062;5515.862103447426;5247.291615631879;5248.527632513092;5388.568914486832;5407.972960135214;5430.348358197002;5274.551663108602;5322.973385133049;5329.440408757102;5361.329833770778;5397.4062853086125;5238.842834714965;5298.708571028592;5333.786648534054;5336.653117547347;5349.331333583302;5708.885822283531;5800.9129863052085;5801.274840644919;5812.128180772876;5856.853578660525;6239.371488240248;6270.592411493239;6300.495960323209;6324.3991820776955;6342.175517182783;6327.367263273682;6332.810015699536;6349.079383489368;6351.555391122623;6357.777477788255;5858.326292476378;5932.347441781358;5985.820425387245;6005.609635373774;6054.94038543262;6383.541807105604;6412.9679351602945;6423.229212494531;6430.967845160838;6450.580712253689;5120.283160357553;6299.748010079637;6323.652199129;6346.936530634727;6362.013887847298;5296.947030529645;5312.893742125213;6216.160818289563;6246.031865060922;6275.309715931244;6195.96902015487;6268.717907694165;6269.341719119518;6333.2716737575765;6338.176037115146;5106.617003724661;5556.611037227355;6239.313675495692;6279.843003924939;6298.960671489244;4202.453681021509;4334.371516130206;5021.59827213822;5041.193409054534;5089.007643509554;4079.5920407958965;4502.414686090788;4558.270676691714;4563.133004729158;4573.794179261941;5502.944970550243;5828.0966450200285;5862.94137058624;6044.425779550936;6051.4553690168095;5803.709814509258;6317.842053948688;6340.968295158587;6353.745850165941;6370.8088757337355;5828.79599214034;5972.910406343908;6003.159557661931;6035.275766907911;6071.51427885768;5424.159255315432;5480.232767412565;5539.556835453154;5542.3626282977975;5577.553795696334;6557.573757705733;6562.8359291018105;6564.212294524687;6578.934210657928;6611.471082313404;6397.776077837253;6403.519736019724;6408.231012278557;6418.935810641834;6453.064305675557;6314.147590075465;6442.774502892376;6543.345665433419;6567.211934567691;6597.50518711089;6205.689715514116;6214.658193799384;6290.49676025926;6302.023186406114;6326.304106548184;6162.845928851814;6283.277423096402;6301.495880329654;6302.873942521032;6310.716017779119;6091.634501929721;6144.477719393902;6153.077038444269;6209.689515524296;6232.439080482778;6150.630962142286;6251.843703907439;6274.623522588659;6278.0896769967185;6288.622682639057;5987.730552125077;6050.21347224858;6112.969435152796;6180.165677633462;6208.534359923115;6099.037411928083;6152.477039451518;6266.342034086355;6295.748170073146;6309.810705678837;6087.969560152171;6151.6001459904965;6180.320164781961;6184.752609895734;6214.316425193316 16:03:52 INFO - PROCESS | 1653 | |1;ext.html;503.73805621077037;513.1891611254216;518.1554066871;540.2463563329159;575.4878158438988;25972;37129;37633.81183094084;37705;37912.62087379125;39864.20271594566;40602.78191654255;40674;40698.389524157086;40843;9515.42907425555;9569.33014688972;9615.326927115104;9622.230221582256;9637.807243855119;9499.38254013487;9647.662331818388;9648.324617276794;9754.707358779213;9840.655577054804;9643.903560964405;9667.12995830375;9724.02759724029;9740.025997400275;9796.706098817047;9631.470269135265;9725.708228753114;9738.659146929824;9772.560234789451;9778.315517913714;9620.663276785279;9713.07725766051;9762.267829912786;9763.560639771227;9766.560504777302;28461.857690711415;37883.62116378829;37964;38212.61787382146;38386.232275354334;2970.970290297091;2987.3129180288656;3181.671346569599;3508.6315936826522;3692.5753538343165;25898.482030359475;25946.74053259462;26510.73489265102;26585;26714;2615.790736741056;2663.414048909237;2713.9321516962036;2814.8170368925953;2884.9134525964046;361145;363902;365939;366261;367242;29355.412891742046;59333.70333148393;59523.10715339273;59623.70188149118;59645.10532342018;34926.65073349234;35118;35154.64845351565;35420;35555.82222088873;14712;14733.336999835034;14795.926020369829;14931;14936.626584335261;12480.251184928933;12606.991440684724;12668.873311266954;12752.979761619048;12755.489780408865;7988.440809143421;8019.198080191934;8048.07447143586;8055.718049868226;8139.918600814034;2857.8856845725936;3349.145967778201;3374.0215337551836;3374.4432168692383;3377.8986630401128;1051.5636011055478;1060.1306928318859;1074.006543946846;1095.6548687163518;1111.8499002634542;29646.258843529085;29816.552751708743;29817.403651927274;29817.850910745306;29874.85062574673;1006.4062203299942;1054.920880933933;1065.7495488560182;1068.3216157739892;1171.2679575265458;12491.875081249253;14350.712985740227;14450.205238711971;14474;14619.707605847823;606837;611891.28652281;612074.9396252991;612872;613807;58263;58709.70645146747;60327.396726033054;60588.69705651444;60743.39256607466;1449.0291504691882;1460.5729863643492;1464.282501574221;1475.970480590382;1479.1938393575526;29191;29238.41523169482;29347.119586412442;29738.55392169076;30062;49714;50441.49558504368;51457.742711286206;51495.48504515057;51501;550130;560613;564595.3540464543;565559;567118;25744.485110298065;25904.352391190372;26108.608370874834;26112.73887261179;26225.082122125634;42633.57366426296;43213.567864320954;43436.9594128408;43510.78244608756;43732;35385.115372115906;35690.64309356873;36307.818460907525;36812.63187368092;37524.62475375211;34186.65813341835;36281.64169328985;36514.63485365112;36626.45060324151;37060.6293937068;35556;35661.28677426385;35920.820395897856;36075.458868116475;36998.63001369952;31519.684803151675;32058.311358774627;32098;32126.03621891347;32206.838965805022;20444.69332959977;23691.763082369645;24083;24251;24334.756652433956 16:03:52 INFO - PROCESS | 1653 | |2;jquery.html;385.6259428354495;387.9980600097001;391.81477492580376;392.4623266125408;398.7368336897648;19726.605467890633;20136.986301369856;20527;20579.485512862186;21281.829499377527;20137.39587812368;20622.484437889023;21346.679799803016;21395;21459.356219313446;5591.692456914879;6045.486133678643;6105.297890742555;6133.6626485543275;6136.570440069197;5468.644538105011;5922.318933322658;6016.217891674076;6024.427679370453;6043.516518678495;4861.8331600415995;5326.508577598279;5813.447722466359;5818.127280907876;5826.9708651456895;5213.86965325868;5278.155495120763;5892.057270836645;6046.667433291167;6069.0592958091565;5504.779808807642;5789.652620842763;5791.942080579224;5830.775537137206;5836.824895253149;13187.86812131876;13703.794443083361;13799.103058301178;13854.445822167101;13881.791773123412;1923.3172223860468;2104.8737075775502;2167.5014746608367;2217.7671344508917;2225.6661500774853;7979.56112413817;9612.231021518262;9946;11833.290002599872;14800.555983320517;1600.1039417926;1619.7651340555553;1650.8431698988577;1679.7564353168843;1736.28812187004;117868.82131178664;124879;125615.37192314072;125839.74160258372;127257;11591.98608361832;11747.88252117485;11785.646430606925;11840.70398240051;12137.453814578364;15064;15102.924485377504;15107.622309442351;15108.54674359771;15142.091474511564;8468.661253549912;8632.482051076955;8638;8737.43206691563;8850.380473366931;8491.787705307417;8491.830163396697;8533.317334613215;8621.913780862236;8655.740327790176;4613.569793364068;4647.18674232008;4677.228257337501;4682.344471773954;4767.094252092161;1809.687976217232;1896.0045975862784;1945.017766028175;1986.2352994097087;1993.5115896605425;907.26964793342;969.6703120938914;1011.9898801011896;1023.8668973033458;1067.754416484213;20491.4877128073;21066.894665526575;21188.78811211899;21536.0308786105;21546;712.7006657203987;959.5681943125621;960.8270511307892;962.821877952581;1009.9242556808268;8588.355873309401;10411.947940260401;11000.669979900616;11254;11516.596919107958;494254;586665.866718662;603130;603341;603486;129607;130957.0356444654;133809;135324;136710;990.6730778842965;993.6323560282742;1005.788784355279;1014.4927536231884;1022.3865680591734;14911.627209319853;18541;18566.443006709822;18811.529711757317;18895.811041889407;39813.20373592454;51531.74234128955;52648.473515264355;52814.47185528096;53368.46631533635;58986;74853.625731871;75206.11984700426;76171;76378;7943.24539168778;8072.677092916218;8108.270255677017;8375.497470151811;8440.493570385797;8987.19115279628;10467.895321046692;11129.944350278196;12550.560730374393;12563.497460101493;10875.184361172785;11124.61063862761;11239.100871930063;11322.60370887015;11335.206535542762;10593.993570610779;10784.514696838503;11105.611303604659;11136.832947505633;11407.372594507382;11126.55493780272;11300.547978080785;11469.770604587695;11592.188546801643;11692.35692036946;8233.79415514617;8373.832523349622;11474.967252947275;11859.288442693121;12191.634250972485;10844;11161.609343672932;11237.38194399316;11565.363904985306;11793.469293881624 16:03:52 INFO - PROCESS | 1653 | |3;mootools.html;1612.2180742339963;1641.1384023387723;1909.8758580692254;1966.5673551818613;2009.5578972626017;7888.645010974506;8534.57327133644;8610.52642104684;8883.64465421384;8886.555672216387;8636.222739953402;8654.826903461942;8724.345674074439;8760.255378292837;8773.868391974125;2449.3876530867283;2457.3856535866034;2461.3477428481465;2462.482878595497;2501.574732295505;2453.5338285725657;2480.1691433369842;2496.613024981131;2498.263012411343;2512.949741005179;2471.3821544613847;2473.480569080495;2490.22802931091;2498.5502609530367;2503.7996960243227;2452.1294940296293;2467.629855521668;2469.962950555743;2474.5916923707746;2500.524900268943;2462.162864626018;2473.641322008317;2474.6411770293385;2479.9876000619884;2495.638132470782;8798.956005219932;8810.779730506789;8891.822163556757;8908.955455222747;8915.643374265022;5278.47215278473;5370.275012873251;5460.6177567570285;5514.834554963358;5524.447555244484;3597.6042635310096;3616.0598244456633;3640.271945610862;3673.577538583044;3678.797666128362;1036.2073014144187;1054.1145437832258;1057.4395570347729;1071.3250652089212;1091.3124731419155;9936.857261414958;11714.414279286002;11793.587224447188;11797.705057373549;11833.467493962793;4775.283707443911;4828.8792780180775;4856.834359753704;4986.601071914238;5011.123053465629;9935.403875767477;10013.849792253122;10057.497125143713;10063.899361006443;10079.143272821892;5421.918671219935;5426.240326354314;5468.48049435303;5481.260029895913;5547.029269877755;3590.551181102362;4424.269995450779;4845.830395936196;5006.499350064964;5025.321581586512;4080.1431699342875;4107.7578281460255;4147.336426171798;4159.251334759772;4187.937180942288;1337.2645045225281;1380.2132784313046;1384.8961327900247;1387.8612138786243;1392.324722509582;885.7564169853342;895.1496078725107;919.3314134845234;925.0564424287189;933.6362596880828;5768.538516918637;5863.472287494146;5959.642421454727;5981.970090149608;6100.023996160682;406.2747994829216;450.58771224330025;455.1170728786144;471.75468756247244;473.24753641709844;3243.708066274047;3883.339832228528;3954.130091379892;3998.9000274992777;4014.558398576154;10249.795004100026;10626.893731062744;10704.411257380763;10711.571537138583;10718.24972251935;10183.388996660224;10653.627123050655;10659.467026648637;10745.301555398873;10755.924407559181;7948.244916732901;8014.519128852171;8057.717979870794;8078.272955434039;8137.145599712064;5703.486686198262;5735.168400581976;5825.650460972355;5942.762289508371;5967.1049342597225;9495.335326527353;9743.171830394496;9785.755356116155;9835.409875407498;9907.504624768877;10154.847677284699;10228.846567301347;10282.07461328484;10315.896841031794;10360.430176340373;6553.803385898431;6894.655267236719;7245.45659075582;7518.812029699301;7589.962050189713;8185.05871824724;8247.752567422747;8283.130271321425;8345.332373410234;8362.958185209034;7240.637968101469;7369.926300736924;7376.96311518439;7504.512206706547;7511.51175173612;6150.907736383869;7071.434285257064;7233.927660723325;7332.230115837973;7383;6894.758683446055;6910.378065974087;7024.121984751906;7031.753888614078;7032.296770322927;4783.736894470838;4822.469528351809;4906.190478571139;4961.50384961501;5049.116404629249;4848.9757551212015;4877.780499877443;4891.51084891508;4956.9752151240455;5084.059449001947 16:03:52 INFO - PROCESS | 1653 | |4;prototype.html;276.9653793275842;308.68514115602085;317.58237917138945;320.3065363488048;330.3508605590016;4874.805007799684;6283.968580157099;6306.171210348999;6330.43026127649;6417.454516366103;4748.029567729388;6264.561480696353;6274.874502509947;6292.685365731707;6300.369963003697;3902.9999999999927;4568.703034302776;4669.696469729457;4680.765961701918;4733.739644319561;4274.038341373197;4497.415336006315;4703.6237101032;4726.787294571735;4740.881477963061;3960.584138665442;4616.076784643068;4671.065786842628;4678.555537223959;4695.3191787190835;4007.939880901789;4318;4601.654875884322;4623.56076172763;4656.045510670305;3459.5329630499814;3932.9577661919616;3944.309745794503;3946.565877753445;3952.0317522206956;5785.768569257225;5845.707714614252;5993.4006599340155;6084.574079814415;6136.9079463808075;4180.728252663567;5359.866003349908;5392.218128371364;5415.350157981028;5424.593155513313;6612.537122401433;6648.933510664928;6656.733730650768;6675.46596272297;6714.966425167891;3864.169203621235;4185.183889141618;4355.455568053993;4365.694401391904;4392.38506609075;6897.862042759167;6967.651617419108;7000.50996430245;7008.789736307868;7009.929900700979;4402.427684401007;4411.205982923105;4415.845445409395;4423.623991960655;4431.290993441098;4296.119295544406;4490.640748740093;4490.946156613469;4509.233430316854;4514.255147900625;4276.5082015568605;5283.762230699628;5339.424869663459;5361.785528578813;5369.731513424391;5421.647592906527;5969.283685957713;6400.751853388544;6736.696848641823;6765.391114799593;1454.2001898955532;1529.2659523428817;1544.5481247627195;1548.2026756220555;1548.3032635314153;820.8399362124328;875.934304927133;979.6816034788579;1004.2869562610629;1008.4403156248206;6149;6149.538784591174;6170.598911070766;6194.566380353332;6209.565330426917;6593.241777195684;6833.521653484208;6859.897101543481;6923.653817309215;6943.479239057091;5397.433269506724;6152.507799376039;6160.168377269101;6185.381461853869;6188.319284878659;3433.364827506919;3545;3589.2283159120916;3640.1445660269815;3676.3750162472443;5970.447683602295;6638.535302528777;7160.892586611205;7161.39128174111;7199.1361036675935;6553.4101930826455;6736.831579210461;7061.964690176516;7087.433005359559;7096.7516136934955;5986.610870293417;6242.719077641426;6661.067450556926;7015.754448594377;7160.319769621878;6297.590656607306;6832.453403727591;6833.897491537531;6853.417459515997;6885.827854303682;5926.407359264039;6405.327440618668;6736.730530778714;6763.091870495734;6877.793666190022;6306.936930630635;6637.767678131242;6998.055262539696;7174.784756457315;7287.380572651172;3642.5264715587864;4389.912201756011;4414.779261037;4418.624416924597;4451.020775429401;5866.823995280149;6172.382761723792;6775.8142325093895;6852.417544508573;6908.516403851682;5098.133317335987;6367.872642547216;6680.265170831108;6698.464122870061;6720.8910529764;5885.499732522783;6551.967240163769;6559.311272316529;6621.602703837785;6627.801165965029;5175.689458632494;6088.903997280532;6183.938160618516;6324.272708638566;6530.608163510205;6659.2008958925235;6686.866262674816;6715.597064176165;6720.260771315054;6753.763618273337;5179.533841954242;5507.117482175137;5909.847579721913;6533.216014078151;6551.934480655133 16:03:52 INFO - PROCESS | 1653 | |5;yui.html;659.930707275736;693.5293709688606;735.0627949364562;749.8050506868212;749.8537785131898;12053.939730301347;14703.264836758159;14704.338304776284;14869.925650371746;14872.776908346357;13531.93234033831;13572.660683482893;13816.861831381682;13963.720725585483;13989.230592317419;729.7883613752032;921.7649499377666;931.4783721116163;937.3063932689829;938.2212763406357;899.901010888805;901.1484147480634;913.8537833946536;916.5188276155005;937.5078084005918;977.0571398600349;981.9459929703863;985.9014098590155;986.8766404199475;987.4371608183338;944.8252073366381;969.8787651543557;976.4873441443228;976.9936964926137;979.1334668818076;703.2369878681585;703.265087983059;720.6432815756182;723.2731105239253;726.6693654387241;12681.23912565249;12751.42618582166;12762.553310634083;12818.166819156819;12884;12548.623541293775;12576.81134782979;12643.74712505754;12747.553835615709;12858.871411285862;8824.382293239476;8918.19736223743;9874.407535547818;9963.45201013944;10028.247881408923;3041.148478426044;3424.1785492870426;3478.47822826578;3524.594671612772;3559.430491121408;76936.23063769347;76937.61531192309;78706.21293787046;78874.81687774688;79918.60040699759;9495.43027418357;9523.142917137353;9545.61817527305;9778.55996480146;9840.803183936281;21927;22060;22076.88961555182;22172.88913555422;22282.331530054125;7128.394086502602;7356.963215183997;7494.812629684301;7594.164641889388;7594.772156835304;4041.7170798044444;4082.6733861291027;4092.815823287959;4097.959020409818;4104.261232978092;3444.293919746446;3477.8608855646;3508.5088087667746;3544.3442963051916;3544.9822750886597;647.718242564486;648.5557393185683;648.8604949935692;656.671664167916;661.2131563439492;523.9554637855825;577.690935349586;589.2722487727652;593.9792107276224;597.521982414067;5719.571032172604;7490.325870671666;7552.833933397841;7575.772726818204;7899.210078992055;529.4811085136588;533.3413234655276;577.6476349426846;583.5594126434514;587.9857246250269;3765.284595926765;3787.0532366908274;3803.3344164771056;3816.637419445148;3841.5582208045876;78025;82291.30908493907;83426;85111;85167;51032.744836276324;53524.732376337866;65424.672876636265;67951.32048679549;68274.65862670654;58577;65999.34000660028;67027;67218.66390668113;67219.66390168018;8061.87907181381;8149.9185008151535;8161;8276.544790036605;8327.6668933242;35183.64816351804;41900.790496047324;43220.919477013325;44191.80224190937;44381.77809111063;55789;57493.42506574881;59003.70498147482;60182;64101.67949160224;11297.774044519228;11299.209055366046;11373.886261137282;11403.600873969372;11641.59254426091;11789.174757767218;11886.524539018688;12123.272603643809;12306.200096993667;12410.5656302029;10702.678919632424;10735.785284294427;10764.192685548458;10877.238593298393;11300.94349528247;11185.384803835866;11309.491072901574;11420.200585958903;11731.941340293244;11799.292042477478;10780;10842.457877106272;11102.389368584805;11155.163362747664;11216.990470857661;9228.261739060994;9530.1899338557;9575.329726919048;9657.034296570288;9915.55380007887;9304.534773261445;9367.672131475365;9370.578323975575;9414.293927955569;9454.196393306645 16:03:52 INFO - PROCESS | 1653 | __end_tp_report 16:03:52 INFO - PROCESS | 1653 | __start_cc_report 16:03:52 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,401 16:03:52 INFO - PROCESS | 1653 | __end_cc_report 16:03:52 INFO - PROCESS | 1653 | __startTimestamp1461193432132__endTimestamp 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | ------- Summary: start ------- 16:03:52 INFO - PROCESS | 1653 | Number of tests: 6 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5833.14 Median:6071.51 stddev:663.50 (10.9%) stddev-sans-first:638.18 16:03:52 INFO - PROCESS | 1653 | Values: 3429.4 3504.9 3545.2 3558.9 3605.9 5743.5 5773.3 5783.0 5805.6 5822.5 4966.0 5697.6 5772.7 5876.5 6022.5 5281.3 5357.4 5379.5 5409.3 5445.5 5315.7 5475.6 5502.7 5514.2 5515.9 5247.3 5248.5 5388.6 5408.0 5430.3 5274.6 5323.0 5329.4 5361.3 5397.4 5238.8 5298.7 5333.8 5336.7 5349.3 5708.9 5800.9 5801.3 5812.1 5856.9 6239.4 6270.6 6300.5 6324.4 6342.2 6327.4 6332.8 6349.1 6351.6 6357.8 5858.3 5932.3 5985.8 6005.6 6054.9 6383.5 6413.0 6423.2 6431.0 6450.6 5120.3 6299.7 6323.7 6346.9 6362.0 5296.9 5312.9 6216.2 6246.0 6275.3 6196.0 6268.7 6269.3 6333.3 6338.2 5106.6 5556.6 6239.3 6279.8 6299.0 4202.5 4334.4 5021.6 5041.2 5089.0 4079.6 4502.4 4558.3 4563.1 4573.8 5502.9 5828.1 5862.9 6044.4 6051.5 5803.7 6317.8 6341.0 6353.7 6370.8 5828.8 5972.9 6003.2 6035.3 6071.5 5424.2 5480.2 5539.6 5542.4 5577.6 6557.6 6562.8 6564.2 6578.9 6611.5 6397.8 6403.5 6408.2 6418.9 6453.1 6314.1 6442.8 6543.3 6567.2 6597.5 6205.7 6214.7 6290.5 6302.0 6326.3 6162.8 6283.3 6301.5 6302.9 6310.7 6091.6 6144.5 6153.1 6209.7 6232.4 6150.6 6251.8 6274.6 6278.1 6288.6 5987.7 6050.2 6113.0 6180.2 6208.5 6099.0 6152.5 6266.3 6295.7 6309.8 6088.0 6151.6 6180.3 6184.8 6214.3 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:63324.37 Median:36294.73 stddev:140277.09 (386.5%) stddev-sans-first:140591.31 16:03:52 INFO - PROCESS | 1653 | Values: 503.7 513.2 518.2 540.2 575.5 25972.0 37129.0 37633.8 37705.0 37912.6 39864.2 40602.8 40674.0 40698.4 40843.0 9515.4 9569.3 9615.3 9622.2 9637.8 9499.4 9647.7 9648.3 9754.7 9840.7 9643.9 9667.1 9724.0 9740.0 9796.7 9631.5 9725.7 9738.7 9772.6 9778.3 9620.7 9713.1 9762.3 9763.6 9766.6 28461.9 37883.6 37964.0 38212.6 38386.2 2971.0 2987.3 3181.7 3508.6 3692.6 25898.5 25946.7 26510.7 26585.0 26714.0 2615.8 2663.4 2713.9 2814.8 2884.9 361145.0 363902.0 365939.0 366261.0 367242.0 29355.4 59333.7 59523.1 59623.7 59645.1 34926.7 35118.0 35154.6 35420.0 35555.8 14712.0 14733.3 14795.9 14931.0 14936.6 12480.3 12607.0 12668.9 12753.0 12755.5 7988.4 8019.2 8048.1 8055.7 8139.9 2857.9 3349.1 3374.0 3374.4 3377.9 1051.6 1060.1 1074.0 1095.7 1111.8 29646.3 29816.6 29817.4 29817.9 29874.9 1006.4 1054.9 1065.7 1068.3 1171.3 12491.9 14350.7 14450.2 14474.0 14619.7 606837.0 611891.3 612074.9 612872.0 613807.0 58263.0 58709.7 60327.4 60588.7 60743.4 1449.0 1460.6 1464.3 1476.0 1479.2 29191.0 29238.4 29347.1 29738.6 30062.0 49714.0 50441.5 51457.7 51495.5 51501.0 550130.0 560613.0 564595.4 565559.0 567118.0 25744.5 25904.4 26108.6 26112.7 26225.1 42633.6 43213.6 43437.0 43510.8 43732.0 35385.1 35690.6 36307.8 36812.6 37524.6 34186.7 36281.6 36514.6 36626.5 37060.6 35556.0 35661.3 35920.8 36075.5 36998.6 31519.7 32058.3 32098.0 32126.0 32206.8 20444.7 23691.8 24083.0 24251.0 24334.8 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:34309.93 Median:21235.31 stddev:97214.02 (457.8%) stddev-sans-first:97453.36 16:03:52 INFO - PROCESS | 1653 | Values: 385.6 388.0 391.8 392.5 398.7 19726.6 20137.0 20527.0 20579.5 21281.8 20137.4 20622.5 21346.7 21395.0 21459.4 5591.7 6045.5 6105.3 6133.7 6136.6 5468.6 5922.3 6016.2 6024.4 6043.5 4861.8 5326.5 5813.4 5818.1 5827.0 5213.9 5278.2 5892.1 6046.7 6069.1 5504.8 5789.7 5791.9 5830.8 5836.8 13187.9 13703.8 13799.1 13854.4 13881.8 1923.3 2104.9 2167.5 2217.8 2225.7 7979.6 9612.2 9946.0 11833.3 14800.6 1600.1 1619.8 1650.8 1679.8 1736.3 117868.8 124879.0 125615.4 125839.7 127257.0 11592.0 11747.9 11785.6 11840.7 12137.5 15064.0 15102.9 15107.6 15108.5 15142.1 8468.7 8632.5 8638.0 8737.4 8850.4 8491.8 8491.8 8533.3 8621.9 8655.7 4613.6 4647.2 4677.2 4682.3 4767.1 1809.7 1896.0 1945.0 1986.2 1993.5 907.3 969.7 1012.0 1023.9 1067.8 20491.5 21066.9 21188.8 21536.0 21546.0 712.7 959.6 960.8 962.8 1009.9 8588.4 10411.9 11000.7 11254.0 11516.6 494254.0 586665.9 603130.0 603341.0 603486.0 129607.0 130957.0 133809.0 135324.0 136710.0 990.7 993.6 1005.8 1014.5 1022.4 14911.6 18541.0 18566.4 18811.5 18895.8 39813.2 51531.7 52648.5 52814.5 53368.5 58986.0 74853.6 75206.1 76171.0 76378.0 7943.2 8072.7 8108.3 8375.5 8440.5 8987.2 10467.9 11129.9 12550.6 12563.5 10875.2 11124.6 11239.1 11322.6 11335.2 10594.0 10784.5 11105.6 11136.8 11407.4 11126.6 11300.5 11469.8 11592.2 11692.4 8233.8 8373.8 11475.0 11859.3 12191.6 10844.0 11161.6 11237.4 11565.4 11793.5 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5702.91 Median:4852.91 stddev:3159.63 (65.1%) stddev-sans-first:3153.54 16:03:52 INFO - PROCESS | 1653 | Values: 1612.2 1641.1 1909.9 1966.6 2009.6 7888.6 8534.6 8610.5 8883.6 8886.6 8636.2 8654.8 8724.3 8760.3 8773.9 2449.4 2457.4 2461.3 2462.5 2501.6 2453.5 2480.2 2496.6 2498.3 2512.9 2471.4 2473.5 2490.2 2498.6 2503.8 2452.1 2467.6 2470.0 2474.6 2500.5 2462.2 2473.6 2474.6 2480.0 2495.6 8799.0 8810.8 8891.8 8909.0 8915.6 5278.5 5370.3 5460.6 5514.8 5524.4 3597.6 3616.1 3640.3 3673.6 3678.8 1036.2 1054.1 1057.4 1071.3 1091.3 9936.9 11714.4 11793.6 11797.7 11833.5 4775.3 4828.9 4856.8 4986.6 5011.1 9935.4 10013.8 10057.5 10063.9 10079.1 5421.9 5426.2 5468.5 5481.3 5547.0 3590.6 4424.3 4845.8 5006.5 5025.3 4080.1 4107.8 4147.3 4159.3 4187.9 1337.3 1380.2 1384.9 1387.9 1392.3 885.8 895.1 919.3 925.1 933.6 5768.5 5863.5 5959.6 5982.0 6100.0 406.3 450.6 455.1 471.8 473.2 3243.7 3883.3 3954.1 3998.9 4014.6 10249.8 10626.9 10704.4 10711.6 10718.2 10183.4 10653.6 10659.5 10745.3 10755.9 7948.2 8014.5 8057.7 8078.3 8137.1 5703.5 5735.2 5825.7 5942.8 5967.1 9495.3 9743.2 9785.8 9835.4 9907.5 10154.8 10228.8 10282.1 10315.9 10360.4 6553.8 6894.7 7245.5 7518.8 7590.0 8185.1 8247.8 8283.1 8345.3 8363.0 7240.6 7369.9 7377.0 7504.5 7511.5 6150.9 7071.4 7233.9 7332.2 7383.0 6894.8 6910.4 7024.1 7031.8 7032.3 4783.7 4822.5 4906.2 4961.5 5049.1 4849.0 4877.8 4891.5 4957.0 5084.1 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:5314.34 Median:6086.74 stddev:1701.10 (27.9%) stddev-sans-first:1663.33 16:03:52 INFO - PROCESS | 1653 | Values: 277.0 308.7 317.6 320.3 330.4 4874.8 6284.0 6306.2 6330.4 6417.5 4748.0 6264.6 6274.9 6292.7 6300.4 3903.0 4568.7 4669.7 4680.8 4733.7 4274.0 4497.4 4703.6 4726.8 4740.9 3960.6 4616.1 4671.1 4678.6 4695.3 4007.9 4318.0 4601.7 4623.6 4656.0 3459.5 3933.0 3944.3 3946.6 3952.0 5785.8 5845.7 5993.4 6084.6 6136.9 4180.7 5359.9 5392.2 5415.4 5424.6 6612.5 6648.9 6656.7 6675.5 6715.0 3864.2 4185.2 4355.5 4365.7 4392.4 6897.9 6967.7 7000.5 7008.8 7009.9 4402.4 4411.2 4415.8 4423.6 4431.3 4296.1 4490.6 4490.9 4509.2 4514.3 4276.5 5283.8 5339.4 5361.8 5369.7 5421.6 5969.3 6400.8 6736.7 6765.4 1454.2 1529.3 1544.5 1548.2 1548.3 820.8 875.9 979.7 1004.3 1008.4 6149.0 6149.5 6170.6 6194.6 6209.6 6593.2 6833.5 6859.9 6923.7 6943.5 5397.4 6152.5 6160.2 6185.4 6188.3 3433.4 3545.0 3589.2 3640.1 3676.4 5970.4 6638.5 7160.9 7161.4 7199.1 6553.4 6736.8 7062.0 7087.4 7096.8 5986.6 6242.7 6661.1 7015.8 7160.3 6297.6 6832.5 6833.9 6853.4 6885.8 5926.4 6405.3 6736.7 6763.1 6877.8 6306.9 6637.8 6998.1 7174.8 7287.4 3642.5 4389.9 4414.8 4418.6 4451.0 5866.8 6172.4 6775.8 6852.4 6908.5 5098.1 6367.9 6680.3 6698.5 6720.9 5885.5 6552.0 6559.3 6621.6 6627.8 5175.7 6088.9 6183.9 6324.3 6530.6 6659.2 6686.9 6715.6 6720.3 6753.8 5179.5 5507.1 5909.8 6533.2 6551.9 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:16773.95 Median:29798.84 stddev:22836.12 (76.6%) stddev-sans-first:22868.13 16:03:52 INFO - PROCESS | 1653 | Values: 659.9 693.5 735.1 749.8 749.9 12053.9 14703.3 14704.3 14869.9 14872.8 13531.9 13572.7 13816.9 13963.7 13989.2 729.8 921.8 931.5 937.3 938.2 899.9 901.1 913.9 916.5 937.5 977.1 981.9 985.9 986.9 987.4 944.8 969.9 976.5 977.0 979.1 703.2 703.3 720.6 723.3 726.7 12681.2 12751.4 12762.6 12818.2 12884.0 12548.6 12576.8 12643.7 12747.6 12858.9 8824.4 8918.2 9874.4 9963.5 10028.2 3041.1 3424.2 3478.5 3524.6 3559.4 76936.2 76937.6 78706.2 78874.8 79918.6 9495.4 9523.1 9545.6 9778.6 9840.8 21927.0 22060.0 22076.9 22172.9 22282.3 7128.4 7357.0 7494.8 7594.2 7594.8 4041.7 4082.7 4092.8 4098.0 4104.3 3444.3 3477.9 3508.5 3544.3 3545.0 647.7 648.6 648.9 656.7 661.2 524.0 577.7 589.3 594.0 597.5 5719.6 7490.3 7552.8 7575.8 7899.2 529.5 533.3 577.6 583.6 588.0 3765.3 3787.1 3803.3 3816.6 3841.6 78025.0 82291.3 83426.0 85111.0 85167.0 51032.7 53524.7 65424.7 67951.3 68274.7 58577.0 65999.3 67027.0 67218.7 67219.7 8061.9 8149.9 8161.0 8276.5 8327.7 35183.6 41900.8 43220.9 44191.8 44381.8 55789.0 57493.4 59003.7 60182.0 64101.7 11297.8 11299.2 11373.9 11403.6 11641.6 11789.2 11886.5 12123.3 12306.2 12410.6 10702.7 10735.8 10764.2 10877.2 11300.9 11185.4 11309.5 11420.2 11731.9 11799.3 10780.0 10842.5 11102.4 11155.2 11217.0 9228.3 9530.2 9575.3 9657.0 9915.6 9304.5 9367.7 9370.6 9414.3 9454.2 16:03:52 INFO - PROCESS | 1653 | -------- Summary: end -------- 16:03:52 INFO - PROCESS | 1653 | 16:03:52 INFO - TEST-INFO | 1653: exit 0 16:03:52 INFO - TEST-OK | dromaeo_css | took 1114089ms 16:03:52 INFO - TEST-START | kraken 16:03:52 INFO - operating with platform_type : mac_ 16:03:52 INFO - Initialising browser for kraken test... 16:03:52 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpdO8v8K/profile http://localhost:49270/getInfo.html) 16:03:55 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 16:03:55 INFO - PROCESS | 1665 | colorDepth:24 16:03:55 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 16:03:55 INFO - PROCESS | 1665 | __metrics 16:03:55 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:03:56 INFO - TEST-INFO | 1665: exit 0 16:03:56 INFO - Browser initialized. 16:03:56 INFO - Running cycle 1/1 for kraken test... 16:03:56 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpdO8v8K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:08 INFO - PROCESS | 1668 | RSS: Main: 247808000 16:04:08 INFO - PROCESS | 1668 | 16:04:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:11 INFO - PROCESS | 1668 | RSS: Main: 259997696 16:04:11 INFO - PROCESS | 1668 | 16:04:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 16:04:15 INFO - PROCESS | 1668 | RSS: Main: 269373440 16:04:15 INFO - PROCESS | 1668 | 16:04:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 16:04:19 INFO - PROCESS | 1668 | RSS: Main: 272084992 16:04:19 INFO - PROCESS | 1668 | 16:04:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 16:04:22 INFO - PROCESS | 1668 | RSS: Main: 274591744 16:04:22 INFO - PROCESS | 1668 | 16:04:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:24 INFO - PROCESS | 1668 | RSS: Main: 274538496 16:04:24 INFO - PROCESS | 1668 | 16:04:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:28 INFO - PROCESS | 1668 | RSS: Main: 274636800 16:04:28 INFO - PROCESS | 1668 | 16:04:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:32 INFO - PROCESS | 1668 | RSS: Main: 274841600 16:04:32 INFO - PROCESS | 1668 | 16:04:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 16:04:35 INFO - PROCESS | 1668 | RSS: Main: 274882560 16:04:35 INFO - PROCESS | 1668 | 16:04:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:04:38 INFO - PROCESS | 1668 | RSS: Main: 274890752 16:04:38 INFO - PROCESS | 1668 | 16:04:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:04:40 INFO - PROCESS | 1668 | RSS: Main: 274898944 16:04:40 INFO - PROCESS | 1668 | 16:04:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:04:43 INFO - PROCESS | 1668 | RSS: Main: 275271680 16:04:43 INFO - PROCESS | 1668 | 16:04:46 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:46 INFO - PROCESS | 1668 | RSS: Main: 275386368 16:04:46 INFO - PROCESS | 1668 | 16:04:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:50 INFO - PROCESS | 1668 | RSS: Main: 275279872 16:04:50 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 16:04:52 INFO - PROCESS | 1668 | RSS: Main: 277159936 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | __start_tp_report 16:04:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 16:04:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 16:04:52 INFO - PROCESS | 1668 | |i|pagename|runs| 16:04:52 INFO - PROCESS | 1668 | |0;ai-astar;115;110;124;126;116;128;117;123;169;119 16:04:52 INFO - PROCESS | 1668 | |1;audio-beat-detection;174;118;132;183;164;146;156;137;189;146 16:04:52 INFO - PROCESS | 1668 | |2;audio-dft;195;200;201;220;273;247;200;201;200;196 16:04:52 INFO - PROCESS | 1668 | |3;audio-fft;73;79;74;132;64;81;97;73;75;58 16:04:52 INFO - PROCESS | 1668 | |4;audio-oscillator;71;136;169;119;86;89;124;77;82;150 16:04:52 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;90;86;95;74;132;131;129;130;89;133 16:04:52 INFO - PROCESS | 1668 | |6;imaging-darkroom;95;97;97;96;96;103;102;153;150;100 16:04:52 INFO - PROCESS | 1668 | |7;imaging-desaturate;89;92;103;90;76;147;134;89;76;145 16:04:52 INFO - PROCESS | 1668 | |8;json-parse-financial;60;61;62;61;63;63;61;75;65;65 16:04:52 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;64;66;75;67;75;73;68;67;68;70 16:04:52 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;83;83;86;86;81;84;82;84;87;85 16:04:52 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;146;143;138;145;143;135;141;154;207;159 16:04:52 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;171;175;173;173;173;173;173;171;171;169 16:04:52 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;73;86;72;100;69;71;72;72;72;68 16:04:52 INFO - PROCESS | 1668 | __end_tp_report 16:04:52 INFO - PROCESS | 1668 | __start_cc_report 16:04:52 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1026 16:04:52 INFO - PROCESS | 1668 | __end_cc_report 16:04:52 INFO - PROCESS | 1668 | __startTimestamp1461193492329__endTimestamp 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | ------- Summary: start ------- 16:04:52 INFO - PROCESS | 1668 | Number of tests: 14 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:124.70 Median:123.50 stddev:16.52 (13.4%) stddev-sans-first:17.14 16:04:52 INFO - PROCESS | 1668 | Values: 115.0 110.0 124.0 126.0 116.0 128.0 117.0 123.0 169.0 119.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:160.00 stddev:23.01 (14.4%) stddev-sans-first:23.30 16:04:52 INFO - PROCESS | 1668 | Values: 174.0 118.0 132.0 183.0 164.0 146.0 156.0 137.0 189.0 146.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:213.30 Median:201.00 stddev:26.27 (13.1%) stddev-sans-first:27.02 16:04:52 INFO - PROCESS | 1668 | Values: 195.0 200.0 201.0 220.0 273.0 247.0 200.0 201.0 200.0 196.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:80.60 Median:74.50 stddev:20.79 (27.9%) stddev-sans-first:21.87 16:04:52 INFO - PROCESS | 1668 | Values: 73.0 79.0 74.0 132.0 64.0 81.0 97.0 73.0 75.0 58.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:74.00 stddev:34.07 (46.0%) stddev-sans-first:33.03 16:04:52 INFO - PROCESS | 1668 | Values: 71.0 136.0 169.0 119.0 86.0 89.0 124.0 77.0 82.0 150.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:80.00 stddev:23.90 (29.9%) stddev-sans-first:24.35 16:04:52 INFO - PROCESS | 1668 | Values: 90.0 86.0 95.0 74.0 132.0 131.0 129.0 130.0 89.0 133.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:95.50 stddev:22.62 (23.7%) stddev-sans-first:23.43 16:04:52 INFO - PROCESS | 1668 | Values: 95.0 97.0 97.0 96.0 96.0 103.0 102.0 153.0 150.0 100.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:104.10 Median:82.50 stddev:27.46 (33.3%) stddev-sans-first:28.58 16:04:52 INFO - PROCESS | 1668 | Values: 89.0 92.0 103.0 90.0 76.0 147.0 134.0 89.0 76.0 145.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.00 stddev:4.35 (6.9%) stddev-sans-first:4.42 16:04:52 INFO - PROCESS | 1668 | Values: 60.0 61.0 62.0 61.0 63.0 63.0 61.0 75.0 65.0 65.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:3.83 (5.6%) stddev-sans-first:3.55 16:04:52 INFO - PROCESS | 1668 | Values: 64.0 66.0 75.0 67.0 75.0 73.0 68.0 67.0 68.0 70.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:1.91 (2.3%) stddev-sans-first:1.99 16:04:52 INFO - PROCESS | 1668 | Values: 83.0 83.0 86.0 86.0 81.0 84.0 82.0 84.0 87.0 85.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:145.50 stddev:20.88 (14.3%) stddev-sans-first:22.06 16:04:52 INFO - PROCESS | 1668 | Values: 146.0 143.0 138.0 145.0 143.0 135.0 141.0 154.0 207.0 159.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:1.69 (1.0%) stddev-sans-first:1.73 16:04:52 INFO - PROCESS | 1668 | Values: 171.0 175.0 173.0 173.0 173.0 173.0 173.0 171.0 171.0 169.0 16:04:52 INFO - PROCESS | 1668 | 16:04:52 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:72.00 stddev:9.91 (13.8%) stddev-sans-first:10.47 16:04:52 INFO - PROCESS | 1668 | Values: 73.0 86.0 72.0 100.0 69.0 71.0 72.0 72.0 72.0 68.0 16:04:52 INFO - PROCESS | 1668 | -------- Summary: end -------- 16:04:52 INFO - PROCESS | 1668 | 16:04:53 INFO - TEST-INFO | 1668: exit 0 16:04:53 INFO - TEST-OK | kraken | took 60414ms 16:04:53 INFO - SUITE-END | took 1174s 16:04:53 INFO - Completed test suite (00:19:34) 16:04:53 INFO - javascript benchmark 16:04:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.3998550253705, 3504.8609202009347, 3545.2200515886498, 3558.8576456941723, 3605.9459108113383, 5743.54051675866, 5773.336066352371, 5783.0, 5805.593608447411, 5822.534197264214, 4965.975170124153, 5697.6011679182475, 5772.682502462363, 5876.529877609792, 6022.457978781908, 5281.313429254201, 5357.4106848246665, 5379.515843574078, 5409.29679141711, 5445.50990410863, 5315.707636080014, 5475.589330800186, 5502.669839809604, 5514.200440936062, 5515.862103447426, 5247.291615631879, 5248.527632513092, 5388.568914486832, 5407.972960135214, 5430.348358197002, 5274.551663108602, 5322.973385133049, 5329.440408757102, 5361.329833770778, 5397.4062853086125, 5238.842834714965, 5298.708571028592, 5333.786648534054, 5336.653117547347, 5349.331333583302, 5708.885822283531, 5800.9129863052085, 5801.274840644919, 5812.128180772876, 5856.853578660525, 6239.371488240248, 6270.592411493239, 6300.495960323209, 6324.3991820776955, 6342.175517182783, 6327.367263273682, 6332.810015699536, 6349.079383489368, 6351.555391122623, 6357.777477788255, 5858.326292476378, 5932.347441781358, 5985.820425387245, 6005.609635373774, 6054.94038543262, 6383.541807105604, 6412.9679351602945, 6423.229212494531, 6430.967845160838, 6450.580712253689, 5120.283160357553, 6299.748010079637, 6323.652199129, 6346.936530634727, 6362.013887847298, 5296.947030529645, 5312.893742125213, 6216.160818289563, 6246.031865060922, 6275.309715931244, 6195.96902015487, 6268.717907694165, 6269.341719119518, 6333.2716737575765, 6338.176037115146, 5106.617003724661, 5556.611037227355, 6239.313675495692, 6279.843003924939, 6298.960671489244, 4202.453681021509, 4334.371516130206, 5021.59827213822, 5041.193409054534, 5089.007643509554, 4079.5920407958965, 4502.414686090788, 4558.270676691714, 4563.133004729158, 4573.794179261941, 5502.944970550243, 5828.0966450200285, 5862.94137058624, 6044.425779550936, 6051.4553690168095, 5803.709814509258, 6317.842053948688, 6340.968295158587, 6353.745850165941, 6370.8088757337355, 5828.79599214034, 5972.910406343908, 6003.159557661931, 6035.275766907911, 6071.51427885768, 5424.159255315432, 5480.232767412565, 5539.556835453154, 5542.3626282977975, 5577.553795696334, 6557.573757705733, 6562.8359291018105, 6564.212294524687, 6578.934210657928, 6611.471082313404, 6397.776077837253, 6403.519736019724, 6408.231012278557, 6418.935810641834, 6453.064305675557, 6314.147590075465, 6442.774502892376, 6543.345665433419, 6567.211934567691, 6597.50518711089, 6205.689715514116, 6214.658193799384, 6290.49676025926, 6302.023186406114, 6326.304106548184, 6162.845928851814, 6283.277423096402, 6301.495880329654, 6302.873942521032, 6310.716017779119, 6091.634501929721, 6144.477719393902, 6153.077038444269, 6209.689515524296, 6232.439080482778, 6150.630962142286, 6251.843703907439, 6274.623522588659, 6278.0896769967185, 6288.622682639057, 5987.730552125077, 6050.21347224858, 6112.969435152796, 6180.165677633462, 6208.534359923115, 6099.037411928083, 6152.477039451518, 6266.342034086355, 6295.748170073146, 6309.810705678837, 6087.969560152171, 6151.6001459904965, 6180.320164781961, 6184.752609895734, 6214.316425193316], "value": 5792.5533482681085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.73805621077037, 513.1891611254216, 518.1554066871, 540.2463563329159, 575.4878158438988, 25972.0, 37129.0, 37633.81183094084, 37705.0, 37912.62087379125, 39864.20271594566, 40602.78191654255, 40674.0, 40698.389524157086, 40843.0, 9515.42907425555, 9569.33014688972, 9615.326927115104, 9622.230221582256, 9637.807243855119, 9499.38254013487, 9647.662331818388, 9648.324617276794, 9754.707358779213, 9840.655577054804, 9643.903560964405, 9667.12995830375, 9724.02759724029, 9740.025997400275, 9796.706098817047, 9631.470269135265, 9725.708228753114, 9738.659146929824, 9772.560234789451, 9778.315517913714, 9620.663276785279, 9713.07725766051, 9762.267829912786, 9763.560639771227, 9766.560504777302, 28461.857690711415, 37883.62116378829, 37964.0, 38212.61787382146, 38386.232275354334, 2970.970290297091, 2987.3129180288656, 3181.671346569599, 3508.6315936826522, 3692.5753538343165, 25898.482030359475, 25946.74053259462, 26510.73489265102, 26585.0, 26714.0, 2615.790736741056, 2663.414048909237, 2713.9321516962036, 2814.8170368925953, 2884.9134525964046, 361145.0, 363902.0, 365939.0, 366261.0, 367242.0, 29355.412891742046, 59333.70333148393, 59523.10715339273, 59623.70188149118, 59645.10532342018, 34926.65073349234, 35118.0, 35154.64845351565, 35420.0, 35555.82222088873, 14712.0, 14733.336999835034, 14795.926020369829, 14931.0, 14936.626584335261, 12480.251184928933, 12606.991440684724, 12668.873311266954, 12752.979761619048, 12755.489780408865, 7988.440809143421, 8019.198080191934, 8048.07447143586, 8055.718049868226, 8139.918600814034, 2857.8856845725936, 3349.145967778201, 3374.0215337551836, 3374.4432168692383, 3377.8986630401128, 1051.5636011055478, 1060.1306928318859, 1074.006543946846, 1095.6548687163518, 1111.8499002634542, 29646.258843529085, 29816.552751708743, 29817.403651927274, 29817.850910745306, 29874.85062574673, 1006.4062203299942, 1054.920880933933, 1065.7495488560182, 1068.3216157739892, 1171.2679575265458, 12491.875081249253, 14350.712985740227, 14450.205238711971, 14474.0, 14619.707605847823, 606837.0, 611891.28652281, 612074.9396252991, 612872.0, 613807.0, 58263.0, 58709.70645146747, 60327.396726033054, 60588.69705651444, 60743.39256607466, 1449.0291504691882, 1460.5729863643492, 1464.282501574221, 1475.970480590382, 1479.1938393575526, 29191.0, 29238.41523169482, 29347.119586412442, 29738.55392169076, 30062.0, 49714.0, 50441.49558504368, 51457.742711286206, 51495.48504515057, 51501.0, 550130.0, 560613.0, 564595.3540464543, 565559.0, 567118.0, 25744.485110298065, 25904.352391190372, 26108.608370874834, 26112.73887261179, 26225.082122125634, 42633.57366426296, 43213.567864320954, 43436.9594128408, 43510.78244608756, 43732.0, 35385.115372115906, 35690.64309356873, 36307.818460907525, 36812.63187368092, 37524.62475375211, 34186.65813341835, 36281.64169328985, 36514.63485365112, 36626.45060324151, 37060.6293937068, 35556.0, 35661.28677426385, 35920.820395897856, 36075.458868116475, 36998.63001369952, 31519.684803151675, 32058.311358774627, 32098.0, 32126.03621891347, 32206.838965805022, 20444.69332959977, 23691.763082369645, 24083.0, 24251.0, 24334.756652433956], "value": 18030.243094671165, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6259428354495, 387.9980600097001, 391.81477492580376, 392.4623266125408, 398.7368336897648, 19726.605467890633, 20136.986301369856, 20527.0, 20579.485512862186, 21281.829499377527, 20137.39587812368, 20622.484437889023, 21346.679799803016, 21395.0, 21459.356219313446, 5591.692456914879, 6045.486133678643, 6105.297890742555, 6133.6626485543275, 6136.570440069197, 5468.644538105011, 5922.318933322658, 6016.217891674076, 6024.427679370453, 6043.516518678495, 4861.8331600415995, 5326.508577598279, 5813.447722466359, 5818.127280907876, 5826.9708651456895, 5213.86965325868, 5278.155495120763, 5892.057270836645, 6046.667433291167, 6069.0592958091565, 5504.779808807642, 5789.652620842763, 5791.942080579224, 5830.775537137206, 5836.824895253149, 13187.86812131876, 13703.794443083361, 13799.103058301178, 13854.445822167101, 13881.791773123412, 1923.3172223860468, 2104.8737075775502, 2167.5014746608367, 2217.7671344508917, 2225.6661500774853, 7979.56112413817, 9612.231021518262, 9946.0, 11833.290002599872, 14800.555983320517, 1600.1039417926, 1619.7651340555553, 1650.8431698988577, 1679.7564353168843, 1736.28812187004, 117868.82131178664, 124879.0, 125615.37192314072, 125839.74160258372, 127257.0, 11591.98608361832, 11747.88252117485, 11785.646430606925, 11840.70398240051, 12137.453814578364, 15064.0, 15102.924485377504, 15107.622309442351, 15108.54674359771, 15142.091474511564, 8468.661253549912, 8632.482051076955, 8638.0, 8737.43206691563, 8850.380473366931, 8491.787705307417, 8491.830163396697, 8533.317334613215, 8621.913780862236, 8655.740327790176, 4613.569793364068, 4647.18674232008, 4677.228257337501, 4682.344471773954, 4767.094252092161, 1809.687976217232, 1896.0045975862784, 1945.017766028175, 1986.2352994097087, 1993.5115896605425, 907.26964793342, 969.6703120938914, 1011.9898801011896, 1023.8668973033458, 1067.754416484213, 20491.4877128073, 21066.894665526575, 21188.78811211899, 21536.0308786105, 21546.0, 712.7006657203987, 959.5681943125621, 960.8270511307892, 962.821877952581, 1009.9242556808268, 8588.355873309401, 10411.947940260401, 11000.669979900616, 11254.0, 11516.596919107958, 494254.0, 586665.866718662, 603130.0, 603341.0, 603486.0, 129607.0, 130957.0356444654, 133809.0, 135324.0, 136710.0, 990.6730778842965, 993.6323560282742, 1005.788784355279, 1014.4927536231884, 1022.3865680591734, 14911.627209319853, 18541.0, 18566.443006709822, 18811.529711757317, 18895.811041889407, 39813.20373592454, 51531.74234128955, 52648.473515264355, 52814.47185528096, 53368.46631533635, 58986.0, 74853.625731871, 75206.11984700426, 76171.0, 76378.0, 7943.24539168778, 8072.677092916218, 8108.270255677017, 8375.497470151811, 8440.493570385797, 8987.19115279628, 10467.895321046692, 11129.944350278196, 12550.560730374393, 12563.497460101493, 10875.184361172785, 11124.61063862761, 11239.100871930063, 11322.60370887015, 11335.206535542762, 10593.993570610779, 10784.514696838503, 11105.611303604659, 11136.832947505633, 11407.372594507382, 11126.55493780272, 11300.547978080785, 11469.770604587695, 11592.188546801643, 11692.35692036946, 8233.79415514617, 8373.832523349622, 11474.967252947275, 11859.288442693121, 12191.634250972485, 10844.0, 11161.609343672932, 11237.38194399316, 11565.363904985306, 11793.469293881624], "value": 9451.653946734516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1612.2180742339963, 1641.1384023387723, 1909.8758580692254, 1966.5673551818613, 2009.5578972626017, 7888.645010974506, 8534.57327133644, 8610.52642104684, 8883.64465421384, 8886.555672216387, 8636.222739953402, 8654.826903461942, 8724.345674074439, 8760.255378292837, 8773.868391974125, 2449.3876530867283, 2457.3856535866034, 2461.3477428481465, 2462.482878595497, 2501.574732295505, 2453.5338285725657, 2480.1691433369842, 2496.613024981131, 2498.263012411343, 2512.949741005179, 2471.3821544613847, 2473.480569080495, 2490.22802931091, 2498.5502609530367, 2503.7996960243227, 2452.1294940296293, 2467.629855521668, 2469.962950555743, 2474.5916923707746, 2500.524900268943, 2462.162864626018, 2473.641322008317, 2474.6411770293385, 2479.9876000619884, 2495.638132470782, 8798.956005219932, 8810.779730506789, 8891.822163556757, 8908.955455222747, 8915.643374265022, 5278.47215278473, 5370.275012873251, 5460.6177567570285, 5514.834554963358, 5524.447555244484, 3597.6042635310096, 3616.0598244456633, 3640.271945610862, 3673.577538583044, 3678.797666128362, 1036.2073014144187, 1054.1145437832258, 1057.4395570347729, 1071.3250652089212, 1091.3124731419155, 9936.857261414958, 11714.414279286002, 11793.587224447188, 11797.705057373549, 11833.467493962793, 4775.283707443911, 4828.8792780180775, 4856.834359753704, 4986.601071914238, 5011.123053465629, 9935.403875767477, 10013.849792253122, 10057.497125143713, 10063.899361006443, 10079.143272821892, 5421.918671219935, 5426.240326354314, 5468.48049435303, 5481.260029895913, 5547.029269877755, 3590.551181102362, 4424.269995450779, 4845.830395936196, 5006.499350064964, 5025.321581586512, 4080.1431699342875, 4107.7578281460255, 4147.336426171798, 4159.251334759772, 4187.937180942288, 1337.2645045225281, 1380.2132784313046, 1384.8961327900247, 1387.8612138786243, 1392.324722509582, 885.7564169853342, 895.1496078725107, 919.3314134845234, 925.0564424287189, 933.6362596880828, 5768.538516918637, 5863.472287494146, 5959.642421454727, 5981.970090149608, 6100.023996160682, 406.2747994829216, 450.58771224330025, 455.1170728786144, 471.75468756247244, 473.24753641709844, 3243.708066274047, 3883.339832228528, 3954.130091379892, 3998.9000274992777, 4014.558398576154, 10249.795004100026, 10626.893731062744, 10704.411257380763, 10711.571537138583, 10718.24972251935, 10183.388996660224, 10653.627123050655, 10659.467026648637, 10745.301555398873, 10755.924407559181, 7948.244916732901, 8014.519128852171, 8057.717979870794, 8078.272955434039, 8137.145599712064, 5703.486686198262, 5735.168400581976, 5825.650460972355, 5942.762289508371, 5967.1049342597225, 9495.335326527353, 9743.171830394496, 9785.755356116155, 9835.409875407498, 9907.504624768877, 10154.847677284699, 10228.846567301347, 10282.07461328484, 10315.896841031794, 10360.430176340373, 6553.803385898431, 6894.655267236719, 7245.45659075582, 7518.812029699301, 7589.962050189713, 8185.05871824724, 8247.752567422747, 8283.130271321425, 8345.332373410234, 8362.958185209034, 7240.637968101469, 7369.926300736924, 7376.96311518439, 7504.512206706547, 7511.51175173612, 6150.907736383869, 7071.434285257064, 7233.927660723325, 7332.230115837973, 7383.0, 6894.758683446055, 6910.378065974087, 7024.121984751906, 7031.753888614078, 7032.296770322927, 4783.736894470838, 4822.469528351809, 4906.190478571139, 4961.50384961501, 5049.116404629249, 4848.9757551212015, 4877.780499877443, 4891.51084891508, 4956.9752151240455, 5084.059449001947], "value": 4550.191505487591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.9653793275842, 308.68514115602085, 317.58237917138945, 320.3065363488048, 330.3508605590016, 4874.805007799684, 6283.968580157099, 6306.171210348999, 6330.43026127649, 6417.454516366103, 4748.029567729388, 6264.561480696353, 6274.874502509947, 6292.685365731707, 6300.369963003697, 3902.9999999999927, 4568.703034302776, 4669.696469729457, 4680.765961701918, 4733.739644319561, 4274.038341373197, 4497.415336006315, 4703.6237101032, 4726.787294571735, 4740.881477963061, 3960.584138665442, 4616.076784643068, 4671.065786842628, 4678.555537223959, 4695.3191787190835, 4007.939880901789, 4318.0, 4601.654875884322, 4623.56076172763, 4656.045510670305, 3459.5329630499814, 3932.9577661919616, 3944.309745794503, 3946.565877753445, 3952.0317522206956, 5785.768569257225, 5845.707714614252, 5993.4006599340155, 6084.574079814415, 6136.9079463808075, 4180.728252663567, 5359.866003349908, 5392.218128371364, 5415.350157981028, 5424.593155513313, 6612.537122401433, 6648.933510664928, 6656.733730650768, 6675.46596272297, 6714.966425167891, 3864.169203621235, 4185.183889141618, 4355.455568053993, 4365.694401391904, 4392.38506609075, 6897.862042759167, 6967.651617419108, 7000.50996430245, 7008.789736307868, 7009.929900700979, 4402.427684401007, 4411.205982923105, 4415.845445409395, 4423.623991960655, 4431.290993441098, 4296.119295544406, 4490.640748740093, 4490.946156613469, 4509.233430316854, 4514.255147900625, 4276.5082015568605, 5283.762230699628, 5339.424869663459, 5361.785528578813, 5369.731513424391, 5421.647592906527, 5969.283685957713, 6400.751853388544, 6736.696848641823, 6765.391114799593, 1454.2001898955532, 1529.2659523428817, 1544.5481247627195, 1548.2026756220555, 1548.3032635314153, 820.8399362124328, 875.934304927133, 979.6816034788579, 1004.2869562610629, 1008.4403156248206, 6149.0, 6149.538784591174, 6170.598911070766, 6194.566380353332, 6209.565330426917, 6593.241777195684, 6833.521653484208, 6859.897101543481, 6923.653817309215, 6943.479239057091, 5397.433269506724, 6152.507799376039, 6160.168377269101, 6185.381461853869, 6188.319284878659, 3433.364827506919, 3545.0, 3589.2283159120916, 3640.1445660269815, 3676.3750162472443, 5970.447683602295, 6638.535302528777, 7160.892586611205, 7161.39128174111, 7199.1361036675935, 6553.4101930826455, 6736.831579210461, 7061.964690176516, 7087.433005359559, 7096.7516136934955, 5986.610870293417, 6242.719077641426, 6661.067450556926, 7015.754448594377, 7160.319769621878, 6297.590656607306, 6832.453403727591, 6833.897491537531, 6853.417459515997, 6885.827854303682, 5926.407359264039, 6405.327440618668, 6736.730530778714, 6763.091870495734, 6877.793666190022, 6306.936930630635, 6637.767678131242, 6998.055262539696, 7174.784756457315, 7287.380572651172, 3642.5264715587864, 4389.912201756011, 4414.779261037, 4418.624416924597, 4451.020775429401, 5866.823995280149, 6172.382761723792, 6775.8142325093895, 6852.417544508573, 6908.516403851682, 5098.133317335987, 6367.872642547216, 6680.265170831108, 6698.464122870061, 6720.8910529764, 5885.499732522783, 6551.967240163769, 6559.311272316529, 6621.602703837785, 6627.801165965029, 5175.689458632494, 6088.903997280532, 6183.938160618516, 6324.272708638566, 6530.608163510205, 6659.2008958925235, 6686.866262674816, 6715.597064176165, 6720.260771315054, 6753.763618273337, 5179.533841954242, 5507.117482175137, 5909.847579721913, 6533.216014078151, 6551.934480655133], "value": 4750.836778248762, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.930707275736, 693.5293709688606, 735.0627949364562, 749.8050506868212, 749.8537785131898, 12053.939730301347, 14703.264836758159, 14704.338304776284, 14869.925650371746, 14872.776908346357, 13531.93234033831, 13572.660683482893, 13816.861831381682, 13963.720725585483, 13989.230592317419, 729.7883613752032, 921.7649499377666, 931.4783721116163, 937.3063932689829, 938.2212763406357, 899.901010888805, 901.1484147480634, 913.8537833946536, 916.5188276155005, 937.5078084005918, 977.0571398600349, 981.9459929703863, 985.9014098590155, 986.8766404199475, 987.4371608183338, 944.8252073366381, 969.8787651543557, 976.4873441443228, 976.9936964926137, 979.1334668818076, 703.2369878681585, 703.265087983059, 720.6432815756182, 723.2731105239253, 726.6693654387241, 12681.23912565249, 12751.42618582166, 12762.553310634083, 12818.166819156819, 12884.0, 12548.623541293775, 12576.81134782979, 12643.74712505754, 12747.553835615709, 12858.871411285862, 8824.382293239476, 8918.19736223743, 9874.407535547818, 9963.45201013944, 10028.247881408923, 3041.148478426044, 3424.1785492870426, 3478.47822826578, 3524.594671612772, 3559.430491121408, 76936.23063769347, 76937.61531192309, 78706.21293787046, 78874.81687774688, 79918.60040699759, 9495.43027418357, 9523.142917137353, 9545.61817527305, 9778.55996480146, 9840.803183936281, 21927.0, 22060.0, 22076.88961555182, 22172.88913555422, 22282.331530054125, 7128.394086502602, 7356.963215183997, 7494.812629684301, 7594.164641889388, 7594.772156835304, 4041.7170798044444, 4082.6733861291027, 4092.815823287959, 4097.959020409818, 4104.261232978092, 3444.293919746446, 3477.8608855646, 3508.5088087667746, 3544.3442963051916, 3544.9822750886597, 647.718242564486, 648.5557393185683, 648.8604949935692, 656.671664167916, 661.2131563439492, 523.9554637855825, 577.690935349586, 589.2722487727652, 593.9792107276224, 597.521982414067, 5719.571032172604, 7490.325870671666, 7552.833933397841, 7575.772726818204, 7899.210078992055, 529.4811085136588, 533.3413234655276, 577.6476349426846, 583.5594126434514, 587.9857246250269, 3765.284595926765, 3787.0532366908274, 3803.3344164771056, 3816.637419445148, 3841.5582208045876, 78025.0, 82291.30908493907, 83426.0, 85111.0, 85167.0, 51032.744836276324, 53524.732376337866, 65424.672876636265, 67951.32048679549, 68274.65862670654, 58577.0, 65999.34000660028, 67027.0, 67218.66390668113, 67219.66390168018, 8061.87907181381, 8149.9185008151535, 8161.0, 8276.544790036605, 8327.6668933242, 35183.64816351804, 41900.790496047324, 43220.919477013325, 44191.80224190937, 44381.77809111063, 55789.0, 57493.42506574881, 59003.70498147482, 60182.0, 64101.67949160224, 11297.774044519228, 11299.209055366046, 11373.886261137282, 11403.600873969372, 11641.59254426091, 11789.174757767218, 11886.524539018688, 12123.272603643809, 12306.200096993667, 12410.5656302029, 10702.678919632424, 10735.785284294427, 10764.192685548458, 10877.238593298393, 11300.94349528247, 11185.384803835866, 11309.491072901574, 11420.200585958903, 11731.941340293244, 11799.292042477478, 10780.0, 10842.457877106272, 11102.389368584805, 11155.163362747664, 11216.990470857661, 9228.261739060994, 9530.1899338557, 9575.329726919048, 9657.034296570288, 9915.55380007887, 9304.534773261445, 9367.672131475365, 9370.578323975575, 9414.293927955569, 9454.196393306645], "value": 6680.183974824682, "unit": "score"}], "name": "dromaeo_css", "value": 7227.709113792588, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 124.0, 126.0, 116.0, 128.0, 117.0, 123.0, 169.0, 119.0], "value": 124.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 118.0, 132.0, 183.0, 164.0, 146.0, 156.0, 137.0, 189.0, 146.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 200.0, 201.0, 220.0, 273.0, 247.0, 200.0, 201.0, 200.0, 196.0], "value": 213.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 74.0, 132.0, 64.0, 81.0, 97.0, 73.0, 75.0, 58.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 136.0, 169.0, 119.0, 86.0, 89.0, 124.0, 77.0, 82.0, 150.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 95.0, 74.0, 132.0, 131.0, 129.0, 130.0, 89.0, 133.0], "value": 108.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 96.0, 96.0, 103.0, 102.0, 153.0, 150.0, 100.0], "value": 108.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 103.0, 90.0, 76.0, 147.0, 134.0, 89.0, 76.0, 145.0], "value": 104.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 61.0, 63.0, 63.0, 61.0, 75.0, 65.0, 65.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 75.0, 67.0, 75.0, 73.0, 68.0, 67.0, 68.0, 70.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 86.0, 81.0, 84.0, 82.0, 84.0, 87.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 138.0, 145.0, 143.0, 135.0, 141.0, 154.0, 207.0, 159.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 173.0, 173.0, 173.0, 173.0, 173.0, 171.0, 171.0, 169.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 86.0, 72.0, 100.0, 69.0, 71.0, 72.0, 72.0, 72.0, 68.0], "value": 75.5, "unit": "score"}], "name": "kraken", "value": 1621.0999999999997, "alertThreshold": 2.0}]} 16:04:53 INFO - Return code: 0 16:04:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:04:53 ERROR - # TBPL SUCCESS # 16:04:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:04:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:04:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:04:53 INFO - 2016-04-20 16:04:53.677 screenresolution[1673:10247] starting screenresolution argv=screenresolution get 16:04:53 INFO - 2016-04-20 16:04:53.679 screenresolution[1673:10247] Display 0: 1600x1200x32@60 16:04:53 INFO - 2016-04-20 16:04:53.685 screenresolution[1674:10250] starting screenresolution argv=screenresolution list 16:04:53 INFO - Available Modes on Display 0 16:04:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:04:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:04:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:04:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:04:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:04:53 INFO - Intel Iris: 16:04:53 INFO - Chipset Model: Intel Iris 16:04:53 INFO - Type: GPU 16:04:53 INFO - Bus: Built-In 16:04:53 INFO - VRAM (Dynamic, Max): 1536 MB 16:04:53 INFO - Vendor: Intel (0x8086) 16:04:53 INFO - Device ID: 0x0a2e 16:04:53 INFO - Revision ID: 0x0009 16:04:53 INFO - Displays: 16:04:53 INFO - Display: 16:04:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:04:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:04:53 INFO - Display Serial Number: 1600x1200 60 16:04:53 INFO - Main Display: Yes 16:04:53 INFO - Mirror: Off 16:04:53 INFO - Online: Yes 16:04:53 INFO - Rotation: Supported 16:04:53 INFO - Return code: 0 16:04:53 INFO - Running post-action listener: _resource_record_post_action 16:04:53 INFO - Running post-run listener: _resource_record_post_run 16:04:54 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38065664; Write bytes: 695424512; Read time: 404; Write time: 1858 16:04:54 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382241280; Write bytes: 376257536; Read time: 28181; Write time: 696 16:04:54 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35964416; Write bytes: 297327104; Read time: 376; Write time: 1116 16:04:54 INFO - Running post-run listener: _upload_blobber_files 16:04:54 INFO - Blob upload gear active. 16:04:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:04:55 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 16:04:55 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:04:55 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:04:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:04:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:56 INFO - (blobuploader) - INFO - Done attempting. 16:04:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:04:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:57 INFO - (blobuploader) - INFO - Done attempting. 16:04:57 INFO - (blobuploader) - INFO - Iteration through files over. 16:04:57 INFO - Return code: 0 16:04:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:04:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:04:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8095743b38f530d22ba46be571ebd86117f0df01ac2b8b838b8be651d63d1171563ecfac452392b0bb7ee9c605b2c4e010f88cc2e710325193e5bc39f831c4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8e522c5f9d24e16d9cbd6d3abfabf64c895167557471f316c08a5ee913f86794bbcf09ba41e1982f3ad74e143dcc68754626b7fefd9a90186c8c2695b08070b"} 16:04:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:04:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:04:57 INFO - Contents: 16:04:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8095743b38f530d22ba46be571ebd86117f0df01ac2b8b838b8be651d63d1171563ecfac452392b0bb7ee9c605b2c4e010f88cc2e710325193e5bc39f831c4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8e522c5f9d24e16d9cbd6d3abfabf64c895167557471f316c08a5ee913f86794bbcf09ba41e1982f3ad74e143dcc68754626b7fefd9a90186c8c2695b08070b"} 16:04:57 INFO - Running post-run listener: copy_logs_to_upload_dir 16:04:57 INFO - Copying logs to upload dir... 16:04:57 INFO - mkdir: /builds/slave/test/build/upload/logs 16:04:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.630169 ========= master_lag: 92.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 40 secs) (at 2016-04-20 16:06:29.862384) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-04-20 16:06:29.863582) ========= 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.chVisIQQuj/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.3CMkxPp1FI/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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/Firefox/sha512/8095743b38f530d22ba46be571ebd86117f0df01ac2b8b838b8be651d63d1171563ecfac452392b0bb7ee9c605b2c4e010f88cc2e710325193e5bc39f831c4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8e522c5f9d24e16d9cbd6d3abfabf64c895167557471f316c08a5ee913f86794bbcf09ba41e1982f3ad74e143dcc68754626b7fefd9a90186c8c2695b08070b"} build_url:https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/FnY0x_Y-QYm1ot_ExssDBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8095743b38f530d22ba46be571ebd86117f0df01ac2b8b838b8be651d63d1171563ecfac452392b0bb7ee9c605b2c4e010f88cc2e710325193e5bc39f831c4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8e522c5f9d24e16d9cbd6d3abfabf64c895167557471f316c08a5ee913f86794bbcf09ba41e1982f3ad74e143dcc68754626b7fefd9a90186c8c2695b08070b"}' ========= master_lag: 6.50 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-04-20 16:06:36.377944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-04-20 16:06:36.378384) ========= 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.chVisIQQuj/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.3CMkxPp1FI/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.005095 ========= master_lag: 9.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-04-20 16:06:45.673699) ========= ========= Started reboot skipped (results: 3, elapsed: 19 secs) (at 2016-04-20 16:06:45.674100) ========= ========= Finished reboot skipped (results: 3, elapsed: 19 secs) (at 2016-04-20 16:07:05.367913) ========= ========= Total master_lag: 108.46 =========